builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1457734010.46 results: success (0) buildid: 20160311113055 builduid: bd2344f81cb64e6f9d6e90510435e3eb revision: 39e8d596872992f8088e78b07ebcb272380c648c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.462358) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.462809) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.463136) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006381 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.497394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.497681) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.516073) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.516327) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.572836) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.573115) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.573618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.573902) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 14:06:50-- 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% 96.8M=0s 2016-03-11 14:06:50 (96.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091138 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.685681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.686013) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020089 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:50.743440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-11 14:06:50.743776) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 39e8d596872992f8088e78b07ebcb272380c648c --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 39e8d596872992f8088e78b07ebcb272380c648c --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=9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 14:06:50,796 truncating revision to first 12 chars 2016-03-11 14:06:50,796 Setting DEBUG logging. 2016-03-11 14:06:50,797 attempt 1/10 2016-03-11 14:06:50,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/39e8d5968729?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 14:06:51,062 unpacking tar archive at: fx-team-39e8d5968729/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572624 ========= master_lag: 1.48 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-11 14:06:52.797493) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:52.797860) ========= echo 39e8d596872992f8088e78b07ebcb272380c648c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'39e8d596872992f8088e78b07ebcb272380c648c'] 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=9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 39e8d596872992f8088e78b07ebcb272380c648c program finished with exit code 0 elapsedTime=0.004733 script_repo_revision: '39e8d596872992f8088e78b07ebcb272380c648c' ========= master_lag: 0.10 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:52.903484) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:52.903759) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 14:06:53.189682) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-11 14:06:53.189947) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:06:53 INFO - MultiFileLogger online at 20160311 14:06:53 in /builds/slave/test-pgo 14:06:53 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:06:53 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:06:53 INFO - {'append_to_log': False, 14:06:53 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:06:53 INFO - 'blob_upload_branch': 'Fx-Team', 14:06:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:06:53 INFO - 'branch': 'Fx-Team', 14:06:53 INFO - 'buildbot_json_path': 'buildprops.json', 14:06:53 INFO - 'config_files': ('talos/linux_config.py',), 14:06:53 INFO - 'default_actions': ('clobber', 14:06:53 INFO - 'read-buildbot-config', 14:06:53 INFO - 'download-and-extract', 14:06:53 INFO - 'populate-webroot', 14:06:53 INFO - 'create-virtualenv', 14:06:53 INFO - 'install', 14:06:53 INFO - 'run-tests'), 14:06:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:06:53 INFO - 'download_minidump_stackwalk': True, 14:06:53 INFO - 'download_symbols': 'ondemand', 14:06:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:06:53 INFO - 'tooltool.py': '/tools/tooltool.py', 14:06:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:06:53 INFO - '/tools/misc-python/virtualenv.py')}, 14:06:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:06:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:06:53 INFO - 'installer_path': 'installer.exe', 14:06:53 INFO - 'log_level': 'info', 14:06:53 INFO - 'log_name': 'talos', 14:06:53 INFO - 'log_to_console': True, 14:06:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:06:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:06:53 INFO - 'opt_config_files': (), 14:06:53 INFO - 'pip_index': False, 14:06:53 INFO - 'sps_profile': False, 14:06:53 INFO - 'sps_profile_interval': 0, 14:06:53 INFO - 'suite': 'dromaeojs', 14:06:53 INFO - 'system_bits': '32', 14:06:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:06:53 INFO - 'title': 'talos-linux64-ix-013', 14:06:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:06:53 INFO - 'use_talos_json': True, 14:06:53 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:06:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:06:53 INFO - 'work_dir': 'build'} 14:06:53 INFO - ##### 14:06:53 INFO - ##### Running clobber step. 14:06:53 INFO - ##### 14:06:53 INFO - Running pre-action listener: _resource_record_pre_action 14:06:53 INFO - Running main action method: clobber 14:06:53 INFO - rmtree: /builds/slave/test-pgo/build 14:06:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:06:53 INFO - Running post-action listener: _resource_record_post_action 14:06:53 INFO - ##### 14:06:53 INFO - ##### Running read-buildbot-config step. 14:06:53 INFO - ##### 14:06:53 INFO - Running pre-action listener: _resource_record_pre_action 14:06:53 INFO - Running main action method: read_buildbot_config 14:06:53 INFO - Using buildbot properties: 14:06:53 INFO - { 14:06:53 INFO - "project": "", 14:06:53 INFO - "product": "firefox", 14:06:53 INFO - "script_repo_revision": "production", 14:06:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:06:53 INFO - "repository": "", 14:06:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:06:53 INFO - "buildid": "20160311113055", 14:06:53 INFO - "pgo_build": "True", 14:06:53 INFO - "basedir": "/builds/slave/test-pgo", 14:06:53 INFO - "buildnumber": 538, 14:06:53 INFO - "slavename": "talos-linux64-ix-013", 14:06:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:06:53 INFO - "platform": "ubuntu64_hw", 14:06:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:06:53 INFO - "branch": "fx-team", 14:06:53 INFO - "repo_path": "integration/fx-team", 14:06:53 INFO - "revision": "39e8d596872992f8088e78b07ebcb272380c648c", 14:06:53 INFO - "stage_platform": "linux64-pgo", 14:06:53 INFO - "builduid": "bd2344f81cb64e6f9d6e90510435e3eb", 14:06:53 INFO - "slavebuilddir": "test" 14:06:53 INFO - } 14:06:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:06:53 INFO - Running post-action listener: _resource_record_post_action 14:06:53 INFO - ##### 14:06:53 INFO - ##### Running download-and-extract step. 14:06:53 INFO - ##### 14:06:53 INFO - Running pre-action listener: _resource_record_pre_action 14:06:53 INFO - Running main action method: download_and_extract 14:06:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:06:53 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:06:53 INFO - https://queue.taskcluster.net/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:06:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:06:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:06:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:06:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:06:57 INFO - Downloaded 1361 bytes. 14:06:57 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:06:57 INFO - Using the following test package requirements: 14:06:57 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:06:57 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:06:57 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:06:57 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:57 INFO - u'jsshell-linux-x86_64.zip'], 14:06:57 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:06:57 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:06:57 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:06:57 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:06:57 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:06:57 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:57 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:06:57 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:06: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:06:57 INFO - https://queue.taskcluster.net/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:06:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:06:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:06:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:06:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:06:59 INFO - Downloaded 23408128 bytes. 14:06:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:06:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:07:01 INFO - Return code: 0 14:07:01 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:07: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:07:01 INFO - https://queue.taskcluster.net/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:07:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:07:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:07:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:07:02 INFO - Downloaded 23408128 bytes. 14:07:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:07:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:07:04 INFO - Return code: 0 14:07: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:07:04 INFO - https://queue.taskcluster.net/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:07:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:07:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:07:05 INFO - Downloaded 10845263 bytes. 14:07:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:07:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 14:07:05 INFO - Return code: 0 14:07:05 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:07:05 INFO - https://queue.taskcluster.net/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:07:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:07:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:07:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:07:06 INFO - Downloaded 56225614 bytes. 14:07:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:07:06 INFO - mkdir: /builds/slave/test-pgo/properties 14:07:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:07:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:07:06 INFO - Contents: 14:07:06 INFO - build_url:https://queue.taskcluster.net/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:07:07 INFO - Running post-action listener: _resource_record_post_action 14:07:07 INFO - Running post-action listener: set_extra_try_arguments 14:07:07 INFO - ##### 14:07:07 INFO - ##### Running populate-webroot step. 14:07:07 INFO - ##### 14:07:07 INFO - Running pre-action listener: _resource_record_pre_action 14:07:07 INFO - Running main action method: populate_webroot 14:07:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:07:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:07:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:07:07 INFO - '--tppagecycles', 14:07:07 INFO - '7'], 14:07:07 INFO - 'tests': ['tsvgm']}}, 14:07:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:07:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:07:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:07:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:07:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:07:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:07:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'talos_options': ['--e10s'], 14:07:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'tests': ['damp', 'tps']}, 14:07:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'talos_options': ['--e10s'], 14:07:07 INFO - 'tests': ['damp', 'tps']}, 14:07:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:07:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:07:07 INFO - 'other': {'tests': ['a11yr', 14:07:07 INFO - 'ts_paint', 14:07:07 INFO - 'tpaint', 14:07:07 INFO - 'sessionrestore', 14:07:07 INFO - 'sessionrestore_no_auto_restore', 14:07:07 INFO - 'tabpaint']}, 14:07:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:07:07 INFO - 'tests': ['a11yr', 14:07:07 INFO - 'ts_paint', 14:07:07 INFO - 'tpaint', 14:07:07 INFO - 'sessionrestore', 14:07:07 INFO - 'sessionrestore_no_auto_restore', 14:07:07 INFO - 'tabpaint']}, 14:07:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:07:07 INFO - 'tests': ['a11yr', 14:07:07 INFO - 'ts_paint', 14:07:07 INFO - 'tpaint', 14:07:07 INFO - 'sessionrestore', 14:07:07 INFO - 'sessionrestore_no_auto_restore', 14:07:07 INFO - 'tabpaint']}, 14:07:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:07:07 INFO - 'tests': ['a11yr', 14:07:07 INFO - 'ts_paint', 14:07:07 INFO - 'tpaint', 14:07:07 INFO - 'sessionrestore', 14:07:07 INFO - 'sessionrestore_no_auto_restore', 14:07:07 INFO - 'tabpaint']}, 14:07:07 INFO - 'other_l64': {'tests': ['a11yr', 14:07:07 INFO - 'ts_paint', 14:07:07 INFO - 'tpaint', 14:07:07 INFO - 'sessionrestore', 14:07:07 INFO - 'sessionrestore_no_auto_restore', 14:07:07 INFO - 'tabpaint']}, 14:07:07 INFO - 'other_nol64': {'tests': ['a11yr', 14:07:07 INFO - 'ts_paint', 14:07:07 INFO - 'tpaint', 14:07:07 INFO - 'sessionrestore', 14:07:07 INFO - 'sessionrestore_no_auto_restore', 14:07:07 INFO - 'tabpaint']}, 14:07:07 INFO - 'svgr': {'tests': ['tsvgx', 14:07:07 INFO - 'tsvgr_opacity', 14:07:07 INFO - 'tart', 14:07:07 INFO - 'tscrollx', 14:07:07 INFO - 'cart']}, 14:07:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:07:07 INFO - 'tests': ['tsvgx', 14:07:07 INFO - 'tsvgr_opacity', 14:07:07 INFO - 'tart', 14:07:07 INFO - 'tscrollx', 14:07:07 INFO - 'cart']}, 14:07:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'tests': ['tp5o']}, 14:07:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'talos_options': ['--e10s'], 14:07:07 INFO - 'tests': ['tp5o']}, 14:07:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'talos_options': ['--xperf_path', 14:07:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:07 INFO - 'tests': ['tp5n']}, 14:07:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:07 INFO - 'talos_options': ['--e10s', 14:07:07 INFO - '--xperf_path', 14:07:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:07 INFO - 'tests': ['tp5n']}}, 14:07:07 INFO - 'talos.zip': {'path': '', 14:07:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:07:07 INFO - Running post-action listener: _resource_record_post_action 14:07:07 INFO - ##### 14:07:07 INFO - ##### Running create-virtualenv step. 14:07:07 INFO - ##### 14:07:07 INFO - Running pre-action listener: _resource_record_pre_action 14:07:07 INFO - Running main action method: create_virtualenv 14:07:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:07:07 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:07:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:07:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:07:07 INFO - Using real prefix '/usr' 14:07:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:07:08 INFO - Installing distribute.............................................................................................................................................................................................done. 14:07:10 INFO - Installing pip.................done. 14:07:10 INFO - Return code: 0 14:07:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:07:10 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:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:10 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:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:10 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 0x7f5f97186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ce920>, '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 0x24cf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cfcb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', '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:07:10 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:07:10 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:07:10 INFO - Using env: {'DISPLAY': ':0', 14:07:10 INFO - 'HOME': '/home/cltbld', 14:07:10 INFO - 'LANG': 'en_US.UTF-8', 14:07:10 INFO - 'LANGUAGE': 'en_US:en', 14:07:10 INFO - 'LOGNAME': 'cltbld', 14:07:10 INFO - 'MAIL': '/var/mail/cltbld', 14:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:10 INFO - 'MOZ_NO_REMOTE': '1', 14:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:10 INFO - 'NO_EM_RESTART': '1', 14:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:10 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:10 INFO - 'SHELL': '/bin/bash', 14:07:10 INFO - 'SHLVL': '1', 14:07:10 INFO - 'TERM': 'linux', 14:07:10 INFO - 'TMOUT': '86400', 14:07:10 INFO - 'USER': 'cltbld', 14:07:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', 14:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:10 INFO - '_': '/tools/buildbot/bin/python'} 14:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:10 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:07:10 INFO - Cleaning up... 14:07:10 INFO - Return code: 0 14:07:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:07:10 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:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:10 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:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:10 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 0x7f5f97186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ce920>, '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 0x24cf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cfcb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', '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:07:10 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:07:10 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:07:10 INFO - Using env: {'DISPLAY': ':0', 14:07:10 INFO - 'HOME': '/home/cltbld', 14:07:10 INFO - 'LANG': 'en_US.UTF-8', 14:07:10 INFO - 'LANGUAGE': 'en_US:en', 14:07:10 INFO - 'LOGNAME': 'cltbld', 14:07:10 INFO - 'MAIL': '/var/mail/cltbld', 14:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:10 INFO - 'MOZ_NO_REMOTE': '1', 14:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:10 INFO - 'NO_EM_RESTART': '1', 14:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:10 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:10 INFO - 'SHELL': '/bin/bash', 14:07:10 INFO - 'SHLVL': '1', 14:07:10 INFO - 'TERM': 'linux', 14:07:10 INFO - 'TMOUT': '86400', 14:07:10 INFO - 'USER': 'cltbld', 14:07:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', 14:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:10 INFO - '_': '/tools/buildbot/bin/python'} 14:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:10 INFO - Downloading/unpacking psutil>=0.7.1 14:07:10 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:07:10 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:07:10 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:07:10 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:07:10 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:07:10 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:07:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:07:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:12 INFO - Installing collected packages: psutil 14:07:12 INFO - Running setup.py install for psutil 14:07:12 INFO - building 'psutil._psutil_linux' extension 14:07:12 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:07:12 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:07:12 INFO - building 'psutil._psutil_posix' extension 14:07:12 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:07:12 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:07:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:12 INFO - Successfully installed psutil 14:07:12 INFO - Cleaning up... 14:07:12 INFO - Return code: 0 14:07:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:12 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 0x7f5f97186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ce920>, '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 0x24cf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cfcb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', '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:07:12 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:07:12 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:07:12 INFO - Using env: {'DISPLAY': ':0', 14:07:12 INFO - 'HOME': '/home/cltbld', 14:07:12 INFO - 'LANG': 'en_US.UTF-8', 14:07:12 INFO - 'LANGUAGE': 'en_US:en', 14:07:12 INFO - 'LOGNAME': 'cltbld', 14:07:12 INFO - 'MAIL': '/var/mail/cltbld', 14:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:12 INFO - 'MOZ_NO_REMOTE': '1', 14:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:12 INFO - 'NO_EM_RESTART': '1', 14:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:12 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:12 INFO - 'SHELL': '/bin/bash', 14:07:12 INFO - 'SHLVL': '1', 14:07:12 INFO - 'TERM': 'linux', 14:07:12 INFO - 'TMOUT': '86400', 14:07:12 INFO - 'USER': 'cltbld', 14:07:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', 14:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:12 INFO - '_': '/tools/buildbot/bin/python'} 14:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:07:13 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:07:13 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:07:13 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:07:13 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:07:13 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:07:13 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:07:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:07:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:07:15 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:07:15 INFO - Installing collected packages: mozsystemmonitor 14:07:15 INFO - Running setup.py install for mozsystemmonitor 14:07:15 INFO - Successfully installed mozsystemmonitor 14:07:15 INFO - Cleaning up... 14:07:15 INFO - Return code: 0 14:07:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:15 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 0x7f5f97186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ce920>, '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 0x24cf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cfcb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', '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:07:15 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:07:15 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:07:15 INFO - Using env: {'DISPLAY': ':0', 14:07:15 INFO - 'HOME': '/home/cltbld', 14:07:15 INFO - 'LANG': 'en_US.UTF-8', 14:07:15 INFO - 'LANGUAGE': 'en_US:en', 14:07:15 INFO - 'LOGNAME': 'cltbld', 14:07:15 INFO - 'MAIL': '/var/mail/cltbld', 14:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:15 INFO - 'MOZ_NO_REMOTE': '1', 14:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:15 INFO - 'NO_EM_RESTART': '1', 14:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:15 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:15 INFO - 'SHELL': '/bin/bash', 14:07:15 INFO - 'SHLVL': '1', 14:07:15 INFO - 'TERM': 'linux', 14:07:15 INFO - 'TMOUT': '86400', 14:07:15 INFO - 'USER': 'cltbld', 14:07:15 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', 14:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:15 INFO - '_': '/tools/buildbot/bin/python'} 14:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:15 INFO - Downloading/unpacking blobuploader==1.2.4 14:07:15 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:07:15 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:07:15 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:07:15 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:07:15 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:07:15 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:07:17 INFO - Downloading blobuploader-1.2.4.tar.gz 14:07:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:07:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:07:17 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:07:17 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:07:17 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:07:17 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:07:17 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:07:17 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:07:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:07:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:07:17 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:07:17 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:07:17 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:07:17 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:07:17 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:07:17 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:07:17 INFO - Downloading docopt-0.6.1.tar.gz 14:07:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:07:17 INFO - Installing collected packages: blobuploader, requests, docopt 14:07:17 INFO - Running setup.py install for blobuploader 14:07:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:07:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:07:18 INFO - Running setup.py install for requests 14:07:18 INFO - Running setup.py install for docopt 14:07:18 INFO - Successfully installed blobuploader requests docopt 14:07:18 INFO - Cleaning up... 14:07:18 INFO - Return code: 0 14:07:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:18 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 0x7f5f97186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ce920>, '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 0x24cf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cfcb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', '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:07:18 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:07:18 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:07:18 INFO - Using env: {'DISPLAY': ':0', 14:07:18 INFO - 'HOME': '/home/cltbld', 14:07:18 INFO - 'LANG': 'en_US.UTF-8', 14:07:18 INFO - 'LANGUAGE': 'en_US:en', 14:07:18 INFO - 'LOGNAME': 'cltbld', 14:07:18 INFO - 'MAIL': '/var/mail/cltbld', 14:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:18 INFO - 'MOZ_NO_REMOTE': '1', 14:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:18 INFO - 'NO_EM_RESTART': '1', 14:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:18 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:18 INFO - 'SHELL': '/bin/bash', 14:07:18 INFO - 'SHLVL': '1', 14:07:18 INFO - 'TERM': 'linux', 14:07:18 INFO - 'TMOUT': '86400', 14:07:18 INFO - 'USER': 'cltbld', 14:07:18 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', 14:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:18 INFO - '_': '/tools/buildbot/bin/python'} 14:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:07:18 INFO - Running setup.py (path:/tmp/pip-GXmbEV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:07:18 INFO - Running setup.py (path:/tmp/pip-rbc2fV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:07:18 INFO - Running setup.py (path:/tmp/pip-47EoFn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:07:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:07:18 INFO - Running setup.py (path:/tmp/pip-pM0KKN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:07:19 INFO - Running setup.py (path:/tmp/pip-ZFpXx2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:07:19 INFO - Running setup.py (path:/tmp/pip-Yg6iyH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:07:19 INFO - Running setup.py (path:/tmp/pip-zO8ytr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:07:19 INFO - Running setup.py (path:/tmp/pip-2CUlua-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:07:19 INFO - Running setup.py (path:/tmp/pip-fSkwF6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:07:19 INFO - Running setup.py (path:/tmp/pip-HU4BpS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:07:19 INFO - Running setup.py (path:/tmp/pip-Sji2cU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:07:19 INFO - Running setup.py (path:/tmp/pip-9MaTSp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:07:19 INFO - Running setup.py (path:/tmp/pip-1Fgy2X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:07:19 INFO - Running setup.py (path:/tmp/pip-VEU5Up-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:07:19 INFO - Running setup.py (path:/tmp/pip-TH9wXs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:07:19 INFO - Running setup.py (path:/tmp/pip-9j35f_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:07:19 INFO - Running setup.py (path:/tmp/pip-67VQIr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:07:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:07:19 INFO - Running setup.py install for manifestparser 14:07:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:07:20 INFO - Running setup.py install for mozcrash 14:07:20 INFO - Running setup.py install for mozdebug 14:07:20 INFO - Running setup.py install for mozdevice 14:07:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:07:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:07:20 INFO - Running setup.py install for mozfile 14:07:20 INFO - Running setup.py install for mozhttpd 14:07:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:07:20 INFO - Running setup.py install for mozinfo 14:07:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:07:20 INFO - Running setup.py install for mozInstall 14:07:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:07:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:07:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:07:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:07:20 INFO - Running setup.py install for mozleak 14:07:20 INFO - Running setup.py install for mozlog 14:07:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:07:20 INFO - Running setup.py install for moznetwork 14:07:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:07:21 INFO - Running setup.py install for mozprocess 14:07:21 INFO - Running setup.py install for mozprofile 14:07:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:07:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:07:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:07:21 INFO - Running setup.py install for mozrunner 14:07:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:07:21 INFO - Running setup.py install for mozscreenshot 14:07:21 INFO - Running setup.py install for moztest 14:07:21 INFO - Running setup.py install for mozversion 14:07:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:07:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:07:21 INFO - Cleaning up... 14:07:21 INFO - Return code: 0 14:07:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:21 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 0x7f5f97186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ce920>, '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 0x24cf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cfcb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', '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:07:21 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:07:21 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:07:21 INFO - Using env: {'DISPLAY': ':0', 14:07:21 INFO - 'HOME': '/home/cltbld', 14:07:21 INFO - 'LANG': 'en_US.UTF-8', 14:07:21 INFO - 'LANGUAGE': 'en_US:en', 14:07:21 INFO - 'LOGNAME': 'cltbld', 14:07:21 INFO - 'MAIL': '/var/mail/cltbld', 14:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:21 INFO - 'MOZ_NO_REMOTE': '1', 14:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:21 INFO - 'NO_EM_RESTART': '1', 14:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:21 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:21 INFO - 'SHELL': '/bin/bash', 14:07:21 INFO - 'SHLVL': '1', 14:07:21 INFO - 'TERM': 'linux', 14:07:21 INFO - 'TMOUT': '86400', 14:07:21 INFO - 'USER': 'cltbld', 14:07:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', 14:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:21 INFO - '_': '/tools/buildbot/bin/python'} 14:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:07:21 INFO - Running setup.py (path:/tmp/pip-QC7oXr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:07:22 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:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:07:22 INFO - Running setup.py (path:/tmp/pip-1VFOt3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:07:22 INFO - Running setup.py (path:/tmp/pip-Pwvn05-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:07:22 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:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:07:22 INFO - Running setup.py (path:/tmp/pip-1kl3oW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:07:22 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:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:07:22 INFO - Running setup.py (path:/tmp/pip-3dztWf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:07:22 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:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:07:22 INFO - Running setup.py (path:/tmp/pip-TcSCyE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:07:22 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:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:07:22 INFO - Running setup.py (path:/tmp/pip-khtWiA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:07:22 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:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:07:22 INFO - Running setup.py (path:/tmp/pip-Lxvmai-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:07:22 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:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:07:22 INFO - Running setup.py (path:/tmp/pip-6e2Mtk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:07:22 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:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:07:22 INFO - Running setup.py (path:/tmp/pip-ZIKq5A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:07:22 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:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:07:22 INFO - Running setup.py (path:/tmp/pip-7HxMF6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:07:22 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:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:07:22 INFO - Running setup.py (path:/tmp/pip-lC8QGn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:07:22 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:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:07:22 INFO - Running setup.py (path:/tmp/pip-VxKr57-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:07:22 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:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:07:22 INFO - Running setup.py (path:/tmp/pip-1ViUaV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:07:22 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:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:07:22 INFO - Running setup.py (path:/tmp/pip-xvt_PS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:07:23 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:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:07:23 INFO - Running setup.py (path:/tmp/pip-a24ad3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:07:23 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:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:07:23 INFO - Running setup.py (path:/tmp/pip-SdBTHh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:07:23 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:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:07:23 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:07:23 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:07:23 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:07:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:24 INFO - Downloading blessings-1.6.tar.gz 14:07:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:07:25 INFO - Installing collected packages: blessings 14:07:25 INFO - Running setup.py install for blessings 14:07:25 INFO - Successfully installed blessings 14:07:25 INFO - Cleaning up... 14:07:25 INFO - Return code: 0 14:07:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:07:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:07:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:07:25 INFO - Reading from file tmpfile_stdout 14:07:25 INFO - Current package versions: 14:07:25 INFO - argparse == 1.2.1 14:07:25 INFO - blessings == 1.6 14:07:25 INFO - blobuploader == 1.2.4 14:07:25 INFO - docopt == 0.6.1 14:07:25 INFO - manifestparser == 1.1 14:07:25 INFO - mozInstall == 1.12 14:07:25 INFO - mozcrash == 0.17 14:07:25 INFO - mozdebug == 0.1 14:07:25 INFO - mozdevice == 0.48 14:07:25 INFO - mozfile == 1.2 14:07:25 INFO - mozhttpd == 0.7 14:07:25 INFO - mozinfo == 0.9 14:07:25 INFO - mozleak == 0.1 14:07:25 INFO - mozlog == 3.1 14:07:25 INFO - moznetwork == 0.27 14:07:25 INFO - mozprocess == 0.22 14:07:25 INFO - mozprofile == 0.28 14:07:25 INFO - mozrunner == 6.11 14:07:25 INFO - mozscreenshot == 0.1 14:07:25 INFO - mozsystemmonitor == 0.0 14:07:25 INFO - moztest == 0.7 14:07:25 INFO - mozversion == 1.4 14:07:25 INFO - psutil == 3.1.1 14:07:25 INFO - requests == 1.2.3 14:07:25 INFO - wsgiref == 0.1.2 14:07:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:25 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 0x7f5f97186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ce920>, '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 0x24cf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cfcb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', '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:07:25 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:07:25 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:07:25 INFO - Using env: {'DISPLAY': ':0', 14:07:25 INFO - 'HOME': '/home/cltbld', 14:07:25 INFO - 'LANG': 'en_US.UTF-8', 14:07:25 INFO - 'LANGUAGE': 'en_US:en', 14:07:25 INFO - 'LOGNAME': 'cltbld', 14:07:25 INFO - 'MAIL': '/var/mail/cltbld', 14:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:25 INFO - 'MOZ_NO_REMOTE': '1', 14:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:25 INFO - 'NO_EM_RESTART': '1', 14:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:25 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:25 INFO - 'SHELL': '/bin/bash', 14:07:25 INFO - 'SHLVL': '1', 14:07:25 INFO - 'TERM': 'linux', 14:07:25 INFO - 'TMOUT': '86400', 14:07:25 INFO - 'USER': 'cltbld', 14:07:25 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', 14:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:25 INFO - '_': '/tools/buildbot/bin/python'} 14:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:25 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:07:25 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:07:25 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:07:25 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:07:25 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:07:25 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:07:25 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:07:25 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:07:25 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:07:25 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:07:25 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:07:25 INFO - Cleaning up... 14:07:25 INFO - Return code: 0 14:07:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f97186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ce920>, '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 0x24cf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cfcb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', '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:07:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:07:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:07:25 INFO - Using env: {'DISPLAY': ':0', 14:07:25 INFO - 'HOME': '/home/cltbld', 14:07:25 INFO - 'LANG': 'en_US.UTF-8', 14:07:25 INFO - 'LANGUAGE': 'en_US:en', 14:07:25 INFO - 'LOGNAME': 'cltbld', 14:07:25 INFO - 'MAIL': '/var/mail/cltbld', 14:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:25 INFO - 'MOZ_NO_REMOTE': '1', 14:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:25 INFO - 'NO_EM_RESTART': '1', 14:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:25 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:25 INFO - 'SHELL': '/bin/bash', 14:07:25 INFO - 'SHLVL': '1', 14:07:25 INFO - 'TERM': 'linux', 14:07:25 INFO - 'TMOUT': '86400', 14:07:25 INFO - 'USER': 'cltbld', 14:07:25 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', 14:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:25 INFO - '_': '/tools/buildbot/bin/python'} 14:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:25 INFO - Downloading/unpacking jsonschema 14:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:07:27 INFO - Downloading/unpacking functools32 (from jsonschema) 14:07:27 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:07:27 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:07:27 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:07:27 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:07:27 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:07:27 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:07:27 INFO - Downloading functools32-3.2.3-2.tar.gz 14:07:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:07:27 INFO - warning: no files found matching '*.txt' 14:07:27 INFO - no previously-included directories found matching 'build' 14:07:27 INFO - no previously-included directories found matching 'dist' 14:07:27 INFO - no previously-included directories found matching '.git*' 14:07:27 INFO - Installing collected packages: jsonschema, functools32 14:07:28 INFO - Running setup.py install for functools32 14:07:28 INFO - warning: no files found matching '*.txt' 14:07:28 INFO - no previously-included directories found matching 'build' 14:07:28 INFO - no previously-included directories found matching 'dist' 14:07:28 INFO - no previously-included directories found matching '.git*' 14:07:28 INFO - Successfully installed jsonschema functools32 14:07:28 INFO - Cleaning up... 14:07:28 INFO - Return code: 0 14:07:28 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:07: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:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:28 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 0x7f5f97186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ce920>, '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 0x24cf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cfcb0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', '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:07:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:07:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:07:28 INFO - Using env: {'DISPLAY': ':0', 14:07:28 INFO - 'HOME': '/home/cltbld', 14:07:28 INFO - 'LANG': 'en_US.UTF-8', 14:07:28 INFO - 'LANGUAGE': 'en_US:en', 14:07:28 INFO - 'LOGNAME': 'cltbld', 14:07:28 INFO - 'MAIL': '/var/mail/cltbld', 14:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:28 INFO - 'MOZ_NO_REMOTE': '1', 14:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:28 INFO - 'NO_EM_RESTART': '1', 14:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:28 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:28 INFO - 'SHELL': '/bin/bash', 14:07:28 INFO - 'SHLVL': '1', 14:07:28 INFO - 'TERM': 'linux', 14:07:28 INFO - 'TMOUT': '86400', 14:07:28 INFO - 'USER': 'cltbld', 14:07:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', 14:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:28 INFO - '_': '/tools/buildbot/bin/python'} 14:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:28 INFO - Downloading/unpacking flake8 14:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:07:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:07:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:07:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:07:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:07:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:07:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:07:30 INFO - no previously-included directories found matching 'docs/_build' 14:07:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:07:30 INFO - Running setup.py install for pep8 14:07:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:07:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:07:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:07:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:07:31 INFO - no previously-included directories found matching 'docs/_build' 14:07:31 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:07:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:07:31 INFO - Cleaning up... 14:07:31 INFO - Return code: 0 14:07:31 INFO - Running post-action listener: _resource_record_post_action 14:07:31 INFO - Running post-action listener: _start_resource_monitoring 14:07:31 INFO - Starting resource monitoring. 14:07:31 INFO - ##### 14:07:31 INFO - ##### Running install step. 14:07:31 INFO - ##### 14:07:31 INFO - Running pre-action listener: _resource_record_pre_action 14:07:31 INFO - Running main action method: install 14:07:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:07:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:07:31 INFO - Reading from file tmpfile_stdout 14:07:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:07:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:07:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:07:31 INFO - Reading from file tmpfile_stdout 14:07:31 INFO - Output received: 14:07:31 INFO - Usage: mozinstall [options] installer 14:07:31 INFO - Options: 14:07:31 INFO - -h, --help show this help message and exit 14:07:31 INFO - -d DEST, --destination=DEST 14:07:31 INFO - Directory to install application into. [default: 14:07:31 INFO - "/builds/slave/test-pgo"] 14:07:31 INFO - --app=APP Application being installed. [default: firefox] 14:07:31 INFO - mkdir: /builds/slave/test-pgo/build/application 14:07:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:07:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:07:47 INFO - Reading from file tmpfile_stdout 14:07:47 INFO - Output received: 14:07:47 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:07:47 INFO - Running post-action listener: _resource_record_post_action 14:07:47 INFO - ##### 14:07:47 INFO - ##### Running run-tests step. 14:07:47 INFO - ##### 14:07:47 INFO - Running pre-action listener: _resource_record_pre_action 14:07:47 INFO - Running main action method: run_tests 14:07:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:07:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:07:47 INFO - Python 2.7.3 14:07:47 INFO - Return code: 0 14:07:47 INFO - grabbing minidump binary from tooltool 14:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:47 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 0x24ce920>, '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 0x24cf820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cfcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:07:47 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:07:47 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:07:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:07:47 INFO - Return code: 0 14:07:47 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:07:47 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:07:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:07:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:07:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:07:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:07:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:07:48 INFO - Return code: 0 14:07:48 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/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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:07:48 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/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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:07:48 INFO - Using env: {'DISPLAY': ':0', 14:07:48 INFO - 'HOME': '/home/cltbld', 14:07:48 INFO - 'LANG': 'en_US.UTF-8', 14:07:48 INFO - 'LANGUAGE': 'en_US:en', 14:07:48 INFO - 'LOGNAME': 'cltbld', 14:07:48 INFO - 'MAIL': '/var/mail/cltbld', 14:07:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:07:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:48 INFO - 'MOZ_NO_REMOTE': '1', 14:07:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:48 INFO - 'NO_EM_RESTART': '1', 14:07:48 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:48 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:48 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:07:48 INFO - 'SHELL': '/bin/bash', 14:07:48 INFO - 'SHLVL': '1', 14:07:48 INFO - 'TERM': 'linux', 14:07:48 INFO - 'TMOUT': '86400', 14:07:48 INFO - 'USER': 'cltbld', 14:07:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548', 14:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:48 INFO - '_': '/tools/buildbot/bin/python'} 14:07:48 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/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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:07:48 INFO - mozversion application_buildid: 20160311113055 14:07:48 INFO - mozversion application_changeset: 39e8d596872992f8088e78b07ebcb272380c648c 14:07:48 INFO - mozversion application_display_name: Nightly 14:07:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:07:48 INFO - mozversion application_name: Firefox 14:07:48 INFO - mozversion application_remotingname: firefox 14:07:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:07:48 INFO - mozversion application_vendor: Mozilla 14:07:48 INFO - mozversion application_version: 48.0a1 14:07:48 INFO - mozversion platform_buildid: 20160311113055 14:07:48 INFO - mozversion platform_changeset: 39e8d596872992f8088e78b07ebcb272380c648c 14:07:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:07:48 INFO - mozversion platform_version: 48.0a1 14:07:48 INFO - using testdate: 1457734068 14:07:48 INFO - actual date: 1457734068 14:07:48 INFO - starting webserver on 'localhost:49259' 14:07:48 INFO - SUITE-START | Running 2 tests 14:07:48 INFO - TEST-START | dromaeo_css 14:07:48 INFO - operating with platform_type : linux_ 14:07:48 INFO - Initialising browser for dromaeo_css test... 14:07:48 INFO - TEST-INFO | started process 31878 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMbSllD/profile http://localhost:49259/getInfo.html) 14:07:53 INFO - PROCESS | 31878 | __metrics Screen width/height:1600/1200 14:07:53 INFO - PROCESS | 31878 | colorDepth:24 14:07:53 INFO - PROCESS | 31878 | Browser inner width/height: 1024/697 14:07:53 INFO - PROCESS | 31878 | __metrics 14:07:54 ERROR - PROCESS | 31878 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:07:54 INFO - PROCESS | 31878 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 14:07:55 INFO - TEST-INFO | 31878: exit 0 14:07:55 INFO - Browser initialized. 14:07:55 INFO - Running cycle 1/1 for dromaeo_css test... 14:07:55 INFO - TEST-INFO | started process 31972 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMbSllD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:06 INFO - PROCESS | 31972 | RSS: Main: 154460160 14:08:06 INFO - PROCESS | 31972 | 14:08:57 INFO - PROCESS | 31972 | 1457734137508 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:11:06 INFO - PROCESS | 31972 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49259/tests/dromaeo/cssquery-ext.html) 14:11:07 INFO - PROCESS | 31972 | RSS: Main: 251166720 14:11:07 INFO - PROCESS | 31972 | 14:14:10 INFO - PROCESS | 31972 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-ext.html (next: http://localhost:49259/tests/dromaeo/cssquery-jquery.html) 14:14:10 INFO - PROCESS | 31972 | RSS: Main: 237707264 14:14:10 INFO - PROCESS | 31972 | 14:17:12 INFO - PROCESS | 31972 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49259/tests/dromaeo/cssquery-mootools.html) 14:17:13 INFO - PROCESS | 31972 | RSS: Main: 233132032 14:17:13 INFO - PROCESS | 31972 | 14:20:15 INFO - PROCESS | 31972 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49259/tests/dromaeo/cssquery-prototype.html) 14:20:15 INFO - PROCESS | 31972 | RSS: Main: 215982080 14:20:15 INFO - PROCESS | 31972 | 14:23:18 INFO - PROCESS | 31972 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49259/tests/dromaeo/cssquery-yui.html) 14:23:18 INFO - PROCESS | 31972 | RSS: Main: 213778432 14:23:18 INFO - PROCESS | 31972 | 14:26:21 INFO - PROCESS | 31972 | Cycle 1(1): loaded http://localhost:49259/tests/dromaeo/cssquery-yui.html (next: http://localhost:49259/tests/dromaeo/cssquery-dojo.html) 14:26:21 INFO - PROCESS | 31972 | RSS: Main: 303005696 14:26:21 INFO - PROCESS | 31972 | 14:26:21 INFO - PROCESS | 31972 | __start_tp_report 14:26:21 INFO - PROCESS | 31972 | _x_x_mozilla_page_load 14:26:21 INFO - PROCESS | 31972 | _x_x_mozilla_page_load_details 14:26:21 INFO - PROCESS | 31972 | |i|pagename|runs| 14:26:21 INFO - PROCESS | 31972 | |0;dojo.html;3126.781125321227;3187.6652951440083;3247.9837600812007;3254.934901301974;3283.9835800820993;5101.285819985205;5173.224016397542;5179.948200517993;5217.243499692542;5265.157574788034;5193.3248677671945;5204.9739751301195;5215.530602245797;5233.084210263208;5265.131253343194;4690.624750020007;4691.835785747499;4697.735074123486;4742.668013239075;4873.439554451248;4797.856064318059;4839.540243676845;4845.685030473026;4849.660523763338;4882.6826256293225;4687.460941991663;4698.483166851678;4715.504871988426;4802.207635740098;4844.636652251095;4757.9286310705365;4775.235962246059;4781.258904869751;4792.952070479286;4835.9032819343765;4759.333693282943;4776.522347765231;4783.593394561466;4785.64107691921;4799.208130658437;4992.051510213048;5003.4996500350035;5044.8234311798915;5045.747712614391;5062.493750624945;5566.4990150886615;5572.219889215513;5579.274694289757;5581.358143813432;5586.55307575393;5511.200875872976;5582.358028826697;5603.159526071081;5604.8318550443555;5611.326640803089;5272.051030814452;5292.259083728281;5317.441668624816;5347.679139251619;5368.30212072432;5764.654120752768;5779.884402312015;5781.797637082682;5787.536997040227;5818.883622327529;5416.431274716177;5477.616566840283;5534.1975413564805;5541.473560011793;5542.972285138549;5602.215689803431;5603.915941260884;5605.523530499953;5608.298962629671;5656.462636049569;5582.023145949443;5603.831885043455;5605.663660180402;5611.046122159243;5615.943840561624;5490.69801160932;5565.554755619541;5587.161925711094;5600.019996500596;5660.179274005246;4268.381084742695;4277.358396240589;4281.550437204049;4310.590493903074;4323.675724320626;3852;3861.092643228839;3861.498005259298;3887.358585833306;3900.6099390060767;5132.999065182254;5162.793488260428;5205.895882082337;5235.842924712265;5315.521603055744;5557.083081291623;5569.387367389584;5573.27547418833;5584.888302233932;5588.441155884379;5247.1866860636665;5247.711375874287;5248.606354523426;5248.737563121905;5297.470252974672;4656.4645065817185;4779.283107533898;4807.423109226916;4847.781849816767;4864.708117512961;5914.408559144137;5959.404059594092;5959.612625179263;5962.880742385128;5967.731452084667;5390.649607775482;5609.523190528687;5654.491095801398;5658.321001479684;5660.858478537904;5922.348541660328;5967.343592204941;5970.731317090655;5991.700414979146;6010.459058684739;5556.388797232382;5586.525145362527;5587.3015873015875;5589.385167631639;5597.748101335531;5502.147167189092;5587;5645.209670646195;5663.801766938137;5673.489385955284;5423.484768946943;5477.397486276586;5478.04134276492;5484.808031719031;5530.391656917816;5451.536619387396;5458.536024437808;5471.699056551769;5471.8084867029465;5475.2334673145;5320.17537281722;5324.920126198032;5378.327709036371;5379.246905433164;5416.7020813855615;5535.723213839373;5536.335639723259;5544.611877168721;5578.023845827045;5586.608937374344;5384.192371144203;5417.756200971045;5427.4301198373605;5430.51125398716;5433.049216387196 14:26:21 INFO - PROCESS | 31972 | |1;ext.html;519.6128883981432;521.7938914128922;559.2478116932725;607.7963882099497;610.0513701194641;28419.857900710493;28783.712162878364;36661;37265.254694906085;37299.4405083924;43008.35487467691;43937;44018.779906100426;44038.77980610092;44170;7504.5872477013745;8643.956780216105;8856.5571721414;8861.867071993925;8863.246624036932;10340.121089707383;10632.681019569425;10635.946820265888;10639.202059845504;10645;10332.638357657483;10453.84319235212;10459.267851250415;10461.947690261539;10468;10145.64490242838;10219.744506387326;10224.437655928921;10246.89753102467;10259.589616415335;10341.431221282826;10446.582136714522;10477.109445697124;10482.528286227061;10485.685429437053;40778.18443631141;40985.590144098474;41217;41261.174776504304;41305.586944130475;3029.8338236542645;3104.922376940572;3127;3147.7796554241213;3289.3256882339065;31040.53439198414;31634.36731265362;31810.522842157385;31907;32750.836245818617;3896.5129358830145;3901.5708272090046;3914.9804250978564;3923.3722604383447;4038.9798051009557;280447;280458;280524;280772.99999999796;281324;40482.79758601247;41432.37851432231;59193.40806591965;59485;59647.70176149091;39963.40054899179;40265.79867100704;40323.59676403257;40344.596554034084;40345;13611.659708507366;13822.861771382157;13863.098898571561;13887.79168312476;13914.930425347808;8422.452540584842;8496.957515212385;9721.756956076155;10398.948005260077;10572.154227661922;14148.292585370691;14269.143851368952;14306.356213970397;14315.713685726436;14321.427142914376;5616.85957851057;5626.268585083994;5693.715314234271;5694.743736531866;5761.135829625506;923.215267023025;954.6086104697041;956.8086382723483;964.4791812421214;970.5389939778548;28036.158915232576;28938.421231575252;29101.85449072741;29258.414831703245;29484.410311793643;1021.0861279155115;1046.3617193511952;1082.6643740440331;1093.9398333091597;1140.5152810055858;13340.199588024556;13713.520026799015;13867.930660346634;13945.372458239404;14031.508897188549;305083;310003;311875;311988;312114;53266.73366633142;53716.46283537193;53799;53832.46167538274;53948;1119.4514687802919;1307.7907534794388;1329.195836518892;1331.8534961154264;1351.418889877362;24854.751452485965;26560.468790624465;26644.733552665002;26698.46603067889;26713.732862671124;37337.62662373341;37599.624003759614;38153.42769858399;38313.808430957666;38314.80842595881;174376;174660;174906;174937;175209.1239543845;27347.31631709223;30909.69090309158;32622.51066233961;32718.182045449055;32739.672603274616;38108.618913810504;38998.250437390656;39175;39253.41119883147;41413.1717365657;35034.299314013064;35174.82412588023;35468.290634186655;35836.462453062704;35857.82071089628;34601.30797383988;34633.826830865684;34869;35170.64829351674;35201.823990880905;33973.980780576625;34414;34563.48154777731;34804.477932831534;34886.30227395488;30025.849870750506;30878.84560577183;31156.22109447282;31178.376432471676;31658.841705791325;24672.383190419667;24699.259022229362;24831.751682483668;24877.507349559084;25005 14:26:21 INFO - PROCESS | 31972 | |2;jquery.html;353.3974573352434;364.6626870145115;369.72270796902313;377.758234729773;383.0328420737639;16382.344706211752;16962.830371696295;18241.270349186016;18385.724214136764;18395.356162534314;16575.83424165758;17511.474655760314;17513.124343782823;17513.211905464254;17528.474145775614;4662.347271382001;4855.393075865517;4855.417349918015;4858.659893807435;4861.1492988727005;3791.9431208531896;4824.155772739774;5210.661307015051;5420.186971954218;5449.100898351767;5428.267183930178;5429.321334833146;5437.673739575618;5443.782248710047;5445.50990410863;5244.134717771563;5398.271233383502;5484.561235101202;5485.533729632986;5489.258950041733;5265.657732247391;5275.182346736224;5275.26146339509;5277.261183434322;5280.102382594968;12760.680982975407;12994.740105197938;13198.86801131986;13228.074034817566;13239.735205295936;1859.888406695589;1884.274554296592;1889.9244030238774;1916.9712454313196;1941.9611607767906;9004.459732416011;9085.51926861473;9198.126178013077;9198.816023679556;9546.42721436716;1517.4006267524376;1519.3694616734042;1560.2978659603111;1645.695546323934;1664.7419649954277;56291;58684.41315586832;61165.388346116415;62111.689441553404;62880.37119628791;9816.852747208797;9901.950490247647;10455.372677639367;10503.369797812156;10596.788064238826;13877.306134693225;13978;13983.09109907873;13990.370433330525;14009.08940918837;7279.854402911912;7311.926880731231;7357.816054598571;7435;7436.692378283148;6937.306269373023;6971.54684945487;7065.89401158983;7137.464690148259;7163.3552980232025;4450.221211288076;4491.214037543482;4527.864164075083;4578.9771051144535;4631.513691062457;1684.8399402056784;1710.1705672748708;1829.5243236758272;1840.9723854142198;1872.5786697992842;389.5481241759602;392.30757712637217;395.4562476594682;397.34239833076305;931.967376168681;9899.950500247596;9990.900090999143;10089.848652270222;10094.444805535619;10360.222983276284;424.4969710892602;426.5286858021903;426.82073529117844;431.3228231676238;433.93707912352534;5474.479924407175;5509.559235261169;5509.807156749494;5574.080276754371;5651.039323314964;447309;450398;454068;458419;468178;73191.26808731844;73476.63261683764;73516;74141.6292918532;75181.62409187919;457;460.7005446459761;462.142725244673;465.5577201658438;465.71125901940337;8178.754637360888;9802.460864652512;10194.388336699822;10271.537780800032;10446.843297350697;30715;31022.689773102884;31110.53334200034;31527.84236078805;32114;39979.2004159921;41679.37480937849;41707.7914610425;41759.7912010438;42150.927966650605;7512.436567257369;7598.772036838904;7736.535807851547;7793.766187014398;7805.375569954504;9988.900110998797;11400.543978241109;11677.007454366474;11695.415229238673;11906.940465297617;10181.490925453845;10197.13324367437;10279.177665786869;10383.584656613953;10704.625338113128;9893.35693179941;10198;10228.897711022795;10391.63629273002;10419.270651054354;10187.796244075225;10497.47512624381;10528.46033441849;10657.467126643793;10829.837552436562;7438.070241219848;7501.212372701006;7519.473636845587;7736.961315193388;7994.2805147537;7749.573773442515;8928.910710892807;9787.510624468605;9915.801683966425;10006.599736010477 14:26:21 INFO - PROCESS | 31972 | |3;mootools.html;1363.7681594128996;1471.9264036798158;1489.1809504772375;1682.5457126575825;1842.3275504440883;7763.650635721392;7948.085970113439;7957.164497727742;7963.323117535002;7973.60131993401;7904.802379940505;8086.150954149818;8089.2315230053055;8098.392620553467;8101.14937931516;2077.2937201351538;2306.1813056365;2325.3140323604493;2349.788519033287;2354.6703461515403;2346.812255019603;2359.7050368703913;2361.8346715729904;2362.14962613459;2362.4684445999683;2299.8850057497143;2364.361622361961;2366.290112966103;2366.92899213023;2371.312319427364;2319.2926157521947;2336.19401306549;2386.2364043506;2386.868722220277;2388.3551441110803;2309.353381053291;2336.4859730859184;2340.648902664597;2388.6536452214505;2389.952200955971;8189.95905020477;8247.092819789817;8251.504909705436;8260.628271727786;8263.421560490768;4841.70949743013;4982;4996.875078123039;5005.274235235906;5006.048850718352;3111.4399408106533;3208.8395580220895;3261.5270785735934;3272.8690852365876;3279.2949515854207;961.9470929098967;967.7774111954219;993.1409330928767;1016.8017236638858;1017.1710056304089;11464.082873370111;11486.13853960948;11486.655400338002;11493.770124597544;11495.310281383227;4435;4527.185106680763;4618.584327410549;4632.4904260531985;4634.420697412824;9795.118439340493;9820.459874706818;9834.213262938947;9836.704898853046;9848;4421.292593185075;5039.596832253411;5058.342415486037;5059.87350316245;5070.797168113308;4012.558618551957;4018.5981401860163;4047.1500984793524;4393.428854248991;4465.24090904547;3758.699304055669;3847.480590120354;3864.961350386516;3895.863644772476;3900.4344370066183;1231.612042206702;1233.4079641772;1241.1746188784539;1247.0460098025019;1251.6557946564767;1320.947162113524;1338.732253549294;1351.8107464954915;1358.0968655843951;1358.3615700620692;7473.887891681629;7486.213947535431;7664.156942736295;7664.271894170045;7677.731279405194;1113.9554417823358;1128.1651577832345;1133.1274918312854;1138.698244965085;1140.156284349592;5706.80026199081;5726.427357264323;5739.13912913058;5764.221830052889;5780.1907732917425;9356;9533.285003624756;9709.174720148725;9812;9959.452230127268;9929.25530585209;9975.900240997642;9989.05104015132;10058.647947321808;10058.949705251427;7502.362299204519;7754.844903101906;7869.960650196713;7900.762977110696;7906.881396779053;7285.854282914418;7298.708051678086;7351.889721654073;7361.631918404166;7363.042804435389;8205.95897020511;8732.34507411934;8835.514046727234;9040.954795225982;9050.411723237969;8640.35197360213;8670.566471676264;8743.912560874563;8747.693830715894;8861.069587693199;6698.66506674674;7396.778096657109;7581.50720203185;7676.692932282646;7762.5730584818375;7707.614619269127;7737.458377913492;7742.1483636798785;7766.88349674744;7804.765857024298;6813.182418109858;6863.347981941708;6888.345607167311;7041.366277035091;7073.504854660125;6785.457163426815;6812.182538095262;6927.653617319214;6931.44548436134;6941.409980151744;6894.8621027578165;7087.184973728087;7137;7328.3404493595835;7381.1511676157925;6498.512611554058;6644.700988455627;6656.667166641745;6681.899771503528;6690.899636505554;6651.966740166268;6693.196816382066;6729.495287853529;6745.86508269822;6775.457963363017 14:26:21 INFO - PROCESS | 31972 | |4;prototype.html;317.5427384566223;318.5460718476171;323.9886603968861;325.87779582656486;326.03168589289817;5764.106563482662;5784.248047753791;5790.797322093727;5795.739191736371;5795.942040579593;5658.971705141479;5677.630953987988;5698.145278208271;5700.515456186229;5702.971485142569;4239.851605193819;4346.8913277168;4455.84404545841;4481.395011673431;4498.167838949788;4465.732056076646;4476.8656940291685;4485.237509623372;4485.775711214426;4502.144592527426;4254.617084462413;4434.00234947136;4449.176902273073;4451.176532341511;4454.599086082252;4317.935230971538;4338.978305108486;4346.76092814895;4434.733915965053;4440.289553671397;3889.3776995680837;3890.6692931100893;3893.8831835044994;3896.08442016126;3903;5532.28080349552;5535.335759708861;5536.390996990328;5542.39033706292;5544.140658197985;5141.228815677641;5157.097507936096;5158.097332966716;5162.483751624845;5163.225516172567;6109.266887973427;6115.571909966304;6120.265568131853;6123.295820980599;6129.325774164839;4218.367244913257;4309.6336811371075;4314.546972567867;4316.417283666728;4325.286327755916;6380.234371875405;6395.744170233185;6403.551751377406;6403.647799371032;6408;4394.758288294111;4397.758123303185;4404.251277282806;4404.845830395985;4408.118376324684;4455.576720211575;4459.44256967879;4461.933071003938;4464.084862603158;4464.129494748493;5070.594352451795;5131.076406246837;5133.332666753298;5138.640295179376;5144.511271429208;5935.0207215808905;6098.5426093042315;6137.631742095399;6143;6154.846128846814;1505.2548988250667;1517.4006267524487;1529.701708166919;1530.4260902161689;1531.7625768005978;929.6885543343055;993.6293150279055;998.4159266828987;1006.2201793610011;1007.3905287301224;5827.446392592697;5953.493953013955;5998.730057147439;6001.639901605918;6002.039673652194;6325.588836725598;6396.008618664115;6398.296187419473;6399.200099987502;6402.519811014193;5944.167816505693;5947.434993675681;5968.85077873048;5973.074173503114;5974;3391.491276308524;3422.418188907842;3422.606400263952;3425.1950791563963;3427.657234276602;6539.934600653933;6700.932990670129;6704.161979752531;6714.429273511709;6734.797956061326;6505.642189679613;6520.119783829123;6521.706523206467;6534.8366290843105;6540.37866402691;6699.330066993261;6701.497387695942;6705.664716764142;6707.832304192434;6715.395614394728;6352.777652782131;6358.427741503287;6360.141380913517;6360.141380913517;6361.077643741724;6070.848228794139;6292.716827742671;6301.4328710416285;6310.936890631035;6348.174737284124;6669.199696036312;6710.362515561014;6738.797836064926;6746.831329216809;6751.426128779109;4293.549177336335;4307.892302692458;4308.4399028126145;4311.417958575552;4311.892202694832;6396.968015159894;6402.711877965409;6405.071264666504;6405.935940640534;6409.807705768648;6196.690165491617;6214.658193799384;6215.564910456224;6218.31598524171;6221.720022598904;6034.547408944259;6185.103160041679;6198.411150940653;6202.751889924533;6205.565610407228;6090.269167699905;6104.4200800923845;6107.969460152671;6113.908291375722;6116.724747386289;6233.189685341058;6240;6243.8126856194385;6248.875022499434;6249.8750024998335;5869.4717475427415;6100.389961003864;6106.3588323227195;6107.328193898578;6109.633421994695 14:26:21 INFO - PROCESS | 31972 | |5;yui.html;714.2107970692384;749.2170681637688;792.184050428059;793.8055176481763;795.1174196641726;13125.212487250772;13209.933950330258;13222.20666759995;13229.536966206197;13915.165090094588;13050.347482625879;13211.801822972639;13302.268375239382;13312.534061307857;13439.731205375887;824.7979245084947;836.4855613797531;842.1872892658583;842.7092653034694;843.0726201178685;835.4068611285994;837.4849467577457;838.329336530776;839.3159574946399;839.6473481137937;875.0330884372772;877.784942689042;877.9648814047431;877.9692710755124;878.1174919206189;872.2411501993244;872.8123453457505;873.1312344217545;873.7771868173575;874.0298268921492;641.3874749614107;643.855132595167;643.9452646525051;643.9806805795833;644.2269276867777;12995.805062924064;12999;13008.414621342063;13026.54407095747;13040.478380864753;10239.692809215661;10272.435016074112;10420.947895260475;10524.736881578021;10591.417472039035;9110.954445227731;9210.723678289662;9390.5304734763;9441.811163776685;9484.308170307286;3134.059782065394;3161.525771134325;3192.106210261107;3193.552902593639;3288.8026718396973;48384;48629;48661;48666.27000594994;48766.512334876905;7551.207123252089;7639.350655194371;7777.338926191337;7780.14418413974;7867.095284042294;16652.50042498727;16689.582760431087;16689.6662066758;16691.33234670624;16695.666086678197;7464.290892365217;7549.245075492407;7593.430492712958;7644.961775191088;7660.119086305035;4030.5163380393956;4044.51465824103;4049.493813273341;4058.0463591056077;4241.851535196253;3060.3879224155257;3097.1018404662395;3097.4734295169874;3103.581016562735;3104.286014216743;533.2747463449705;533.5784730063284;538.8652836790802;543.4405339204081;557.1753804369556;534.74599565207;591.2461611445442;608.4514909555193;616.6731632234922;617.8239201827547;7716.189800071024;8234.794130146794;8309.169083091763;8388.832223355499;8464.492130472192;673.4477728262875;673.8214373191108;686.5983399711125;702.5749421599859;705.562551218248;3644.0820860733147;3723.1436769542615;3745;3836.405357169643;3876.186000939778;55927.16109258364;57588;57589.424105759244;57867.42132578704;58017.41982580205;49339;49601.50398496041;50262.74868625634;51638.74180629073;51845.48154518482;43561;44144.117117657464;44192;44284.335734964;44695.99999999935;8310.667573297;8512.872306915277;8539.402241843012;8710.12898710124;8887.111288871061;32620.83689581537;33442.49836252409;33969;34018.489722653685;34817.12957176091;38267;42917;43345.34981975336;43827.78086109677;44073.55926440695;10381.712655745463;10643.787124257316;10794.244402891722;11053.778924421627;11082.335059896432;11428.657140285804;11795.174337796272;11801;11931.33516611893;11971.673721769444;11727.35499547533;12050.337231452355;12162.878371216175;12401.941362916292;12468;11487.36819474937;11526.827097593376;11825.46785394642;11878.940605296919;11990;11136.80519830784;11402.372869492257;11609.825852612386;11718.676578969604;12011.459484323052;9750.512474376112;9846.409215447096;9852.852207216754;10076.69769906904;10088.142507886912;8919.286457083288;8919.375643705138;9066.727998160066;9291.6283348668;9539.570719317786 14:26:21 INFO - PROCESS | 31972 | __end_tp_report 14:26:21 INFO - PROCESS | 31972 | __start_cc_report 14:26:21 INFO - PROCESS | 31972 | _x_x_mozilla_cycle_collect,766 14:26:21 INFO - PROCESS | 31972 | __end_cc_report 14:26:21 INFO - PROCESS | 31972 | __startTimestamp1457735181331__endTimestamp 14:26:21 INFO - PROCESS | 31972 | 14:26:21 INFO - PROCESS | 31972 | ------- Summary: start ------- 14:26:21 INFO - PROCESS | 31972 | Number of tests: 6 14:26:21 INFO - PROCESS | 31972 | 14:26:21 INFO - PROCESS | 31972 | [#0] dojo.html Cycles:165 Average:5216.05 Median:5416.70 stddev:578.82 (10.7%) stddev-sans-first:556.90 14:26:21 INFO - PROCESS | 31972 | Values: 3126.8 3187.7 3248.0 3254.9 3284.0 5101.3 5173.2 5179.9 5217.2 5265.2 5193.3 5205.0 5215.5 5233.1 5265.1 4690.6 4691.8 4697.7 4742.7 4873.4 4797.9 4839.5 4845.7 4849.7 4882.7 4687.5 4698.5 4715.5 4802.2 4844.6 4757.9 4775.2 4781.3 4793.0 4835.9 4759.3 4776.5 4783.6 4785.6 4799.2 4992.1 5003.5 5044.8 5045.7 5062.5 5566.5 5572.2 5579.3 5581.4 5586.6 5511.2 5582.4 5603.2 5604.8 5611.3 5272.1 5292.3 5317.4 5347.7 5368.3 5764.7 5779.9 5781.8 5787.5 5818.9 5416.4 5477.6 5534.2 5541.5 5543.0 5602.2 5603.9 5605.5 5608.3 5656.5 5582.0 5603.8 5605.7 5611.0 5615.9 5490.7 5565.6 5587.2 5600.0 5660.2 4268.4 4277.4 4281.6 4310.6 4323.7 3852.0 3861.1 3861.5 3887.4 3900.6 5133.0 5162.8 5205.9 5235.8 5315.5 5557.1 5569.4 5573.3 5584.9 5588.4 5247.2 5247.7 5248.6 5248.7 5297.5 4656.5 4779.3 4807.4 4847.8 4864.7 5914.4 5959.4 5959.6 5962.9 5967.7 5390.6 5609.5 5654.5 5658.3 5660.9 5922.3 5967.3 5970.7 5991.7 6010.5 5556.4 5586.5 5587.3 5589.4 5597.7 5502.1 5587.0 5645.2 5663.8 5673.5 5423.5 5477.4 5478.0 5484.8 5530.4 5451.5 5458.5 5471.7 5471.8 5475.2 5320.2 5324.9 5378.3 5379.2 5416.7 5535.7 5536.3 5544.6 5578.0 5586.6 5384.2 5417.8 5427.4 5430.5 5433.0 14:26:21 INFO - PROCESS | 31972 | 14:26:21 INFO - PROCESS | 31972 | [#1] ext.html Cycles:180 Average:41805.93 Median:31646.60 stddev:68451.82 (216.3%) stddev-sans-first:68573.66 14:26:21 INFO - PROCESS | 31972 | Values: 519.6 521.8 559.2 607.8 610.1 28419.9 28783.7 36661.0 37265.3 37299.4 43008.4 43937.0 44018.8 44038.8 44170.0 7504.6 8644.0 8856.6 8861.9 8863.2 10340.1 10632.7 10635.9 10639.2 10645.0 10332.6 10453.8 10459.3 10461.9 10468.0 10145.6 10219.7 10224.4 10246.9 10259.6 10341.4 10446.6 10477.1 10482.5 10485.7 40778.2 40985.6 41217.0 41261.2 41305.6 3029.8 3104.9 3127.0 3147.8 3289.3 31040.5 31634.4 31810.5 31907.0 32750.8 3896.5 3901.6 3915.0 3923.4 4039.0 280447.0 280458.0 280524.0 280773.0 281324.0 40482.8 41432.4 59193.4 59485.0 59647.7 39963.4 40265.8 40323.6 40344.6 40345.0 13611.7 13822.9 13863.1 13887.8 13914.9 8422.5 8497.0 9721.8 10398.9 10572.2 14148.3 14269.1 14306.4 14315.7 14321.4 5616.9 5626.3 5693.7 5694.7 5761.1 923.2 954.6 956.8 964.5 970.5 28036.2 28938.4 29101.9 29258.4 29484.4 1021.1 1046.4 1082.7 1093.9 1140.5 13340.2 13713.5 13867.9 13945.4 14031.5 305083.0 310003.0 311875.0 311988.0 312114.0 53266.7 53716.5 53799.0 53832.5 53948.0 1119.5 1307.8 1329.2 1331.9 1351.4 24854.8 26560.5 26644.7 26698.5 26713.7 37337.6 37599.6 38153.4 38313.8 38314.8 174376.0 174660.0 174906.0 174937.0 175209.1 27347.3 30909.7 32622.5 32718.2 32739.7 38108.6 38998.3 39175.0 39253.4 41413.2 35034.3 35174.8 35468.3 35836.5 35857.8 34601.3 34633.8 34869.0 35170.6 35201.8 33974.0 34414.0 34563.5 34804.5 34886.3 30025.8 30878.8 31156.2 31178.4 31658.8 24672.4 24699.3 24831.8 24877.5 25005.0 14:26:21 INFO - PROCESS | 31972 | 14:26:21 INFO - PROCESS | 31972 | [#2] jquery.html Cycles:180 Average:24678.06 Median:227444.61 stddev:74722.22 (32.9%) stddev-sans-first:74909.51 14:26:21 INFO - PROCESS | 31972 | Values: 353.4 364.7 369.7 377.8 383.0 16382.3 16962.8 18241.3 18385.7 18395.4 16575.8 17511.5 17513.1 17513.2 17528.5 4662.3 4855.4 4855.4 4858.7 4861.1 3791.9 4824.2 5210.7 5420.2 5449.1 5428.3 5429.3 5437.7 5443.8 5445.5 5244.1 5398.3 5484.6 5485.5 5489.3 5265.7 5275.2 5275.3 5277.3 5280.1 12760.7 12994.7 13198.9 13228.1 13239.7 1859.9 1884.3 1889.9 1917.0 1942.0 9004.5 9085.5 9198.1 9198.8 9546.4 1517.4 1519.4 1560.3 1645.7 1664.7 56291.0 58684.4 61165.4 62111.7 62880.4 9816.9 9902.0 10455.4 10503.4 10596.8 13877.3 13978.0 13983.1 13990.4 14009.1 7279.9 7311.9 7357.8 7435.0 7436.7 6937.3 6971.5 7065.9 7137.5 7163.4 4450.2 4491.2 4527.9 4579.0 4631.5 1684.8 1710.2 1829.5 1841.0 1872.6 389.5 392.3 395.5 397.3 932.0 9900.0 9990.9 10089.8 10094.4 10360.2 424.5 426.5 426.8 431.3 433.9 5474.5 5509.6 5509.8 5574.1 5651.0 447309.0 450398.0 454068.0 458419.0 468178.0 73191.3 73476.6 73516.0 74141.6 75181.6 457.0 460.7 462.1 465.6 465.7 8178.8 9802.5 10194.4 10271.5 10446.8 30715.0 31022.7 31110.5 31527.8 32114.0 39979.2 41679.4 41707.8 41759.8 42150.9 7512.4 7598.8 7736.5 7793.8 7805.4 9988.9 11400.5 11677.0 11695.4 11906.9 10181.5 10197.1 10279.2 10383.6 10704.6 9893.4 10198.0 10228.9 10391.6 10419.3 10187.8 10497.5 10528.5 10657.5 10829.8 7438.1 7501.2 7519.5 7737.0 7994.3 7749.6 8928.9 9787.5 9915.8 10006.6 14:26:21 INFO - PROCESS | 31972 | 14:26:21 INFO - PROCESS | 31972 | [#3] mootools.html Cycles:180 Average:5677.87 Median:6648.33 stddev:2967.45 (44.6%) stddev-sans-first:2958.06 14:26:21 INFO - PROCESS | 31972 | Values: 1363.8 1471.9 1489.2 1682.5 1842.3 7763.7 7948.1 7957.2 7963.3 7973.6 7904.8 8086.2 8089.2 8098.4 8101.1 2077.3 2306.2 2325.3 2349.8 2354.7 2346.8 2359.7 2361.8 2362.1 2362.5 2299.9 2364.4 2366.3 2366.9 2371.3 2319.3 2336.2 2386.2 2386.9 2388.4 2309.4 2336.5 2340.6 2388.7 2390.0 8190.0 8247.1 8251.5 8260.6 8263.4 4841.7 4982.0 4996.9 5005.3 5006.0 3111.4 3208.8 3261.5 3272.9 3279.3 961.9 967.8 993.1 1016.8 1017.2 11464.1 11486.1 11486.7 11493.8 11495.3 4435.0 4527.2 4618.6 4632.5 4634.4 9795.1 9820.5 9834.2 9836.7 9848.0 4421.3 5039.6 5058.3 5059.9 5070.8 4012.6 4018.6 4047.2 4393.4 4465.2 3758.7 3847.5 3865.0 3895.9 3900.4 1231.6 1233.4 1241.2 1247.0 1251.7 1320.9 1338.7 1351.8 1358.1 1358.4 7473.9 7486.2 7664.2 7664.3 7677.7 1114.0 1128.2 1133.1 1138.7 1140.2 5706.8 5726.4 5739.1 5764.2 5780.2 9356.0 9533.3 9709.2 9812.0 9959.5 9929.3 9975.9 9989.1 10058.6 10058.9 7502.4 7754.8 7870.0 7900.8 7906.9 7285.9 7298.7 7351.9 7361.6 7363.0 8206.0 8732.3 8835.5 9041.0 9050.4 8640.4 8670.6 8743.9 8747.7 8861.1 6698.7 7396.8 7581.5 7676.7 7762.6 7707.6 7737.5 7742.1 7766.9 7804.8 6813.2 6863.3 6888.3 7041.4 7073.5 6785.5 6812.2 6927.7 6931.4 6941.4 6894.9 7087.2 7137.0 7328.3 7381.2 6498.5 6644.7 6656.7 6681.9 6690.9 6652.0 6693.2 6729.5 6745.9 6775.5 14:26:21 INFO - PROCESS | 31972 | 14:26:21 INFO - PROCESS | 31972 | [#4] prototype.html Cycles:180 Average:5164.91 Median:5945.80 stddev:1573.26 (26.5%) stddev-sans-first:1535.03 14:26:21 INFO - PROCESS | 31972 | Values: 317.5 318.5 324.0 325.9 326.0 5764.1 5784.2 5790.8 5795.7 5795.9 5659.0 5677.6 5698.1 5700.5 5703.0 4239.9 4346.9 4455.8 4481.4 4498.2 4465.7 4476.9 4485.2 4485.8 4502.1 4254.6 4434.0 4449.2 4451.2 4454.6 4317.9 4339.0 4346.8 4434.7 4440.3 3889.4 3890.7 3893.9 3896.1 3903.0 5532.3 5535.3 5536.4 5542.4 5544.1 5141.2 5157.1 5158.1 5162.5 5163.2 6109.3 6115.6 6120.3 6123.3 6129.3 4218.4 4309.6 4314.5 4316.4 4325.3 6380.2 6395.7 6403.6 6403.6 6408.0 4394.8 4397.8 4404.3 4404.8 4408.1 4455.6 4459.4 4461.9 4464.1 4464.1 5070.6 5131.1 5133.3 5138.6 5144.5 5935.0 6098.5 6137.6 6143.0 6154.8 1505.3 1517.4 1529.7 1530.4 1531.8 929.7 993.6 998.4 1006.2 1007.4 5827.4 5953.5 5998.7 6001.6 6002.0 6325.6 6396.0 6398.3 6399.2 6402.5 5944.2 5947.4 5968.9 5973.1 5974.0 3391.5 3422.4 3422.6 3425.2 3427.7 6539.9 6700.9 6704.2 6714.4 6734.8 6505.6 6520.1 6521.7 6534.8 6540.4 6699.3 6701.5 6705.7 6707.8 6715.4 6352.8 6358.4 6360.1 6360.1 6361.1 6070.8 6292.7 6301.4 6310.9 6348.2 6669.2 6710.4 6738.8 6746.8 6751.4 4293.5 4307.9 4308.4 4311.4 4311.9 6397.0 6402.7 6405.1 6405.9 6409.8 6196.7 6214.7 6215.6 6218.3 6221.7 6034.5 6185.1 6198.4 6202.8 6205.6 6090.3 6104.4 6108.0 6113.9 6116.7 6233.2 6240.0 6243.8 6248.9 6249.9 5869.5 6100.4 6106.4 6107.3 6109.6 14:26:21 INFO - PROCESS | 31972 | 14:26:21 INFO - PROCESS | 31972 | [#5] yui.html Cycles:180 Average:13418.79 Median:48716.39 stddev:15681.51 (32.2%) stddev-sans-first:15696.47 14:26:21 INFO - PROCESS | 31972 | Values: 714.2 749.2 792.2 793.8 795.1 13125.2 13209.9 13222.2 13229.5 13915.2 13050.3 13211.8 13302.3 13312.5 13439.7 824.8 836.5 842.2 842.7 843.1 835.4 837.5 838.3 839.3 839.6 875.0 877.8 878.0 878.0 878.1 872.2 872.8 873.1 873.8 874.0 641.4 643.9 643.9 644.0 644.2 12995.8 12999.0 13008.4 13026.5 13040.5 10239.7 10272.4 10420.9 10524.7 10591.4 9111.0 9210.7 9390.5 9441.8 9484.3 3134.1 3161.5 3192.1 3193.6 3288.8 48384.0 48629.0 48661.0 48666.3 48766.5 7551.2 7639.4 7777.3 7780.1 7867.1 16652.5 16689.6 16689.7 16691.3 16695.7 7464.3 7549.2 7593.4 7645.0 7660.1 4030.5 4044.5 4049.5 4058.0 4241.9 3060.4 3097.1 3097.5 3103.6 3104.3 533.3 533.6 538.9 543.4 557.2 534.7 591.2 608.5 616.7 617.8 7716.2 8234.8 8309.2 8388.8 8464.5 673.4 673.8 686.6 702.6 705.6 3644.1 3723.1 3745.0 3836.4 3876.2 55927.2 57588.0 57589.4 57867.4 58017.4 49339.0 49601.5 50262.7 51638.7 51845.5 43561.0 44144.1 44192.0 44284.3 44696.0 8310.7 8512.9 8539.4 8710.1 8887.1 32620.8 33442.5 33969.0 34018.5 34817.1 38267.0 42917.0 43345.3 43827.8 44073.6 10381.7 10643.8 10794.2 11053.8 11082.3 11428.7 11795.2 11801.0 11931.3 11971.7 11727.4 12050.3 12162.9 12401.9 12468.0 11487.4 11526.8 11825.5 11878.9 11990.0 11136.8 11402.4 11609.8 11718.7 12011.5 9750.5 9846.4 9852.9 10076.7 10088.1 8919.3 8919.4 9066.7 9291.6 9539.6 14:26:21 INFO - PROCESS | 31972 | -------- Summary: end -------- 14:26:21 INFO - PROCESS | 31972 | 14:26:22 INFO - TEST-INFO | 31972: exit 0 14:26:22 INFO - TEST-OK | dromaeo_css | took 1113171ms 14:26:22 INFO - TEST-START | kraken 14:26:22 INFO - operating with platform_type : linux_ 14:26:22 INFO - Initialising browser for kraken test... 14:26:22 INFO - TEST-INFO | started process 32160 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA1bhh4/profile http://localhost:49259/getInfo.html) 14:26:26 INFO - PROCESS | 32160 | __metrics Screen width/height:1600/1200 14:26:26 INFO - PROCESS | 32160 | colorDepth:24 14:26:26 INFO - PROCESS | 32160 | Browser inner width/height: 1024/697 14:26:26 INFO - PROCESS | 32160 | __metrics 14:26:27 ERROR - PROCESS | 32160 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:26:28 INFO - TEST-INFO | 32160: exit 0 14:26:28 INFO - Browser initialized. 14:26:28 INFO - Running cycle 1/1 for kraken test... 14:26:28 INFO - TEST-INFO | started process 32245 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA1bhh4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:26:39 INFO - PROCESS | 32245 | RSS: Main: 154832896 14:26:39 INFO - PROCESS | 32245 | 14:26:42 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-beat-detection) 14:26:43 INFO - PROCESS | 32245 | RSS: Main: 195198976 14:26:43 INFO - PROCESS | 32245 | 14:26:45 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-dft) 14:26:46 INFO - PROCESS | 32245 | RSS: Main: 185225216 14:26:46 INFO - PROCESS | 32245 | 14:26:49 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-fft) 14:26:49 INFO - PROCESS | 32245 | RSS: Main: 169533440 14:26:49 INFO - PROCESS | 32245 | 14:26:51 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49259/tests/kraken/driver.html?testName=audio-oscillator) 14:26:52 INFO - PROCESS | 32245 | RSS: Main: 172769280 14:26:52 INFO - PROCESS | 32245 | 14:26:54 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49259/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:26:55 INFO - PROCESS | 32245 | RSS: Main: 175468544 14:26:55 INFO - PROCESS | 32245 | 14:26:58 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49259/tests/kraken/driver.html?testName=imaging-darkroom) 14:26:58 INFO - PROCESS | 32245 | RSS: Main: 175874048 14:26:58 INFO - PROCESS | 32245 | 14:27:02 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49259/tests/kraken/driver.html?testName=imaging-desaturate) 14:27:02 INFO - PROCESS | 32245 | RSS: Main: 176463872 14:27:02 INFO - PROCESS | 32245 | 14:27:05 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49259/tests/kraken/driver.html?testName=json-parse-financial) 14:27:06 INFO - PROCESS | 32245 | RSS: Main: 176193536 14:27:06 INFO - PROCESS | 32245 | 14:27:07 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49259/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:27:08 INFO - PROCESS | 32245 | RSS: Main: 184107008 14:27:08 INFO - PROCESS | 32245 | 14:27:10 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:27:10 INFO - PROCESS | 32245 | RSS: Main: 180310016 14:27:10 INFO - PROCESS | 32245 | 14:27:12 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:27:13 INFO - PROCESS | 32245 | RSS: Main: 194871296 14:27:13 INFO - PROCESS | 32245 | 14:27:15 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:27:16 INFO - PROCESS | 32245 | RSS: Main: 200298496 14:27:16 INFO - PROCESS | 32245 | 14:27:18 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:27:19 INFO - PROCESS | 32245 | RSS: Main: 199696384 14:27:19 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | Cycle 1(1): loaded http://localhost:49259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49259/tests/kraken/driver.html?testName=ai-astar) 14:27:21 INFO - PROCESS | 32245 | RSS: Main: 260980736 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | __start_tp_report 14:27:21 INFO - PROCESS | 32245 | _x_x_mozilla_page_load 14:27:21 INFO - PROCESS | 32245 | _x_x_mozilla_page_load_details 14:27:21 INFO - PROCESS | 32245 | |i|pagename|runs| 14:27:21 INFO - PROCESS | 32245 | |0;ai-astar;109;111;106;111;112;110;100;112;113;111 14:27:21 INFO - PROCESS | 32245 | |1;audio-beat-detection;158;135;149;176;128;149;150;130;169;130 14:27:21 INFO - PROCESS | 32245 | |2;audio-dft;161;160;160;159;159;160;161;165;162;161 14:27:21 INFO - PROCESS | 32245 | |3;audio-fft;76;72;98;92;75;72;74;130;98;76 14:27:21 INFO - PROCESS | 32245 | |4;audio-oscillator;94;94;146;93;93;93;139;93;94;145 14:27:21 INFO - PROCESS | 32245 | |5;imaging-gaussian-blur;118;117;116;117;116;117;117;116;116;116 14:27:21 INFO - PROCESS | 32245 | |6;imaging-darkroom;147;148;147;146;147;147;147;147;148;145 14:27:21 INFO - PROCESS | 32245 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;97;96 14:27:21 INFO - PROCESS | 32245 | |8;json-parse-financial;56;55;56;56;57;56;58;64;55;54 14:27:21 INFO - PROCESS | 32245 | |9;json-stringify-tinderbox;68;69;68;68;69;69;68;68;67;68 14:27:21 INFO - PROCESS | 32245 | |10;stanford-crypto-aes;80;81;81;80;82;80;81;80;82;81 14:27:21 INFO - PROCESS | 32245 | |11;stanford-crypto-ccm;118;120;118;115;120;115;115;115;114;115 14:27:21 INFO - PROCESS | 32245 | |12;stanford-crypto-pbkdf2;154;140;154;150;150;149;141;155;147;148 14:27:21 INFO - PROCESS | 32245 | |13;stanford-crypto-sha256-iterative;71;68;68;66;69;68;66;68;67;69 14:27:21 INFO - PROCESS | 32245 | __end_tp_report 14:27:21 INFO - PROCESS | 32245 | __start_cc_report 14:27:21 INFO - PROCESS | 32245 | _x_x_mozilla_cycle_collect,1055 14:27:21 INFO - PROCESS | 32245 | __end_cc_report 14:27:21 INFO - PROCESS | 32245 | __startTimestamp1457735241355__endTimestamp 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | ------- Summary: start ------- 14:27:21 INFO - PROCESS | 32245 | Number of tests: 14 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.87 (3.5%) stddev-sans-first:4.10 14:27:21 INFO - PROCESS | 32245 | Values: 109.0 111.0 106.0 111.0 112.0 110.0 100.0 112.0 113.0 111.0 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:149.50 stddev:16.81 (11.2%) stddev-sans-first:17.39 14:27:21 INFO - PROCESS | 32245 | Values: 158.0 135.0 149.0 176.0 128.0 149.0 150.0 130.0 169.0 130.0 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.75 (1.1%) stddev-sans-first:1.86 14:27:21 INFO - PROCESS | 32245 | Values: 161.0 160.0 160.0 159.0 159.0 160.0 161.0 165.0 162.0 161.0 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#3] audio-fft Cycles:10 Average:86.30 Median:76.00 stddev:18.61 (24.5%) stddev-sans-first:19.36 14:27:21 INFO - PROCESS | 32245 | Values: 76.0 72.0 98.0 92.0 75.0 72.0 74.0 130.0 98.0 76.0 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:93.00 stddev:24.18 (26.0%) stddev-sans-first:25.07 14:27:21 INFO - PROCESS | 32245 | Values: 94.0 94.0 146.0 93.0 93.0 93.0 139.0 93.0 94.0 145.0 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 14:27:21 INFO - PROCESS | 32245 | Values: 118.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 14:27:21 INFO - PROCESS | 32245 | Values: 147.0 148.0 147.0 146.0 147.0 147.0 147.0 147.0 148.0 145.0 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:27:21 INFO - PROCESS | 32245 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:2.79 (5.0%) stddev-sans-first:2.95 14:27:21 INFO - PROCESS | 32245 | Values: 56.0 55.0 56.0 56.0 57.0 56.0 58.0 64.0 55.0 54.0 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 14:27:21 INFO - PROCESS | 32245 | Values: 68.0 69.0 68.0 68.0 69.0 69.0 68.0 68.0 67.0 68.0 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.00 stddev:0.79 (1.0%) stddev-sans-first:0.78 14:27:21 INFO - PROCESS | 32245 | Values: 80.0 81.0 81.0 80.0 82.0 80.0 81.0 80.0 82.0 81.0 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#11] stanford-crypto-ccm Cycles:10 Average:116.50 Median:116.50 stddev:2.27 (2.0%) stddev-sans-first:2.35 14:27:21 INFO - PROCESS | 32245 | Values: 118.0 120.0 118.0 115.0 120.0 115.0 115.0 115.0 114.0 115.0 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:150.00 stddev:5.14 (3.4%) stddev-sans-first:5.09 14:27:21 INFO - PROCESS | 32245 | Values: 154.0 140.0 154.0 150.0 150.0 149.0 141.0 155.0 147.0 148.0 14:27:21 INFO - PROCESS | 32245 | 14:27:21 INFO - PROCESS | 32245 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.49 (2.2%) stddev-sans-first:1.12 14:27:21 INFO - PROCESS | 32245 | Values: 71.0 68.0 68.0 66.0 69.0 68.0 66.0 68.0 67.0 69.0 14:27:21 INFO - PROCESS | 32245 | -------- Summary: end -------- 14:27:21 INFO - PROCESS | 32245 | 14:27:22 INFO - TEST-INFO | 32245: exit 0 14:27:22 INFO - TEST-OK | kraken | took 60282ms 14:27:22 INFO - SUITE-END | took 1173s 14:27:22 INFO - Completed test suite (00:19:33) 14:27:22 INFO - javascript benchmark 14:27:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3126.781125321227, 3187.6652951440083, 3247.9837600812007, 3254.934901301974, 3283.9835800820993, 5101.285819985205, 5173.224016397542, 5179.948200517993, 5217.243499692542, 5265.157574788034, 5193.3248677671945, 5204.9739751301195, 5215.530602245797, 5233.084210263208, 5265.131253343194, 4690.624750020007, 4691.835785747499, 4697.735074123486, 4742.668013239075, 4873.439554451248, 4797.856064318059, 4839.540243676845, 4845.685030473026, 4849.660523763338, 4882.6826256293225, 4687.460941991663, 4698.483166851678, 4715.504871988426, 4802.207635740098, 4844.636652251095, 4757.9286310705365, 4775.235962246059, 4781.258904869751, 4792.952070479286, 4835.9032819343765, 4759.333693282943, 4776.522347765231, 4783.593394561466, 4785.64107691921, 4799.208130658437, 4992.051510213048, 5003.4996500350035, 5044.8234311798915, 5045.747712614391, 5062.493750624945, 5566.4990150886615, 5572.219889215513, 5579.274694289757, 5581.358143813432, 5586.55307575393, 5511.200875872976, 5582.358028826697, 5603.159526071081, 5604.8318550443555, 5611.326640803089, 5272.051030814452, 5292.259083728281, 5317.441668624816, 5347.679139251619, 5368.30212072432, 5764.654120752768, 5779.884402312015, 5781.797637082682, 5787.536997040227, 5818.883622327529, 5416.431274716177, 5477.616566840283, 5534.1975413564805, 5541.473560011793, 5542.972285138549, 5602.215689803431, 5603.915941260884, 5605.523530499953, 5608.298962629671, 5656.462636049569, 5582.023145949443, 5603.831885043455, 5605.663660180402, 5611.046122159243, 5615.943840561624, 5490.69801160932, 5565.554755619541, 5587.161925711094, 5600.019996500596, 5660.179274005246, 4268.381084742695, 4277.358396240589, 4281.550437204049, 4310.590493903074, 4323.675724320626, 3852.0, 3861.092643228839, 3861.498005259298, 3887.358585833306, 3900.6099390060767, 5132.999065182254, 5162.793488260428, 5205.895882082337, 5235.842924712265, 5315.521603055744, 5557.083081291623, 5569.387367389584, 5573.27547418833, 5584.888302233932, 5588.441155884379, 5247.1866860636665, 5247.711375874287, 5248.606354523426, 5248.737563121905, 5297.470252974672, 4656.4645065817185, 4779.283107533898, 4807.423109226916, 4847.781849816767, 4864.708117512961, 5914.408559144137, 5959.404059594092, 5959.612625179263, 5962.880742385128, 5967.731452084667, 5390.649607775482, 5609.523190528687, 5654.491095801398, 5658.321001479684, 5660.858478537904, 5922.348541660328, 5967.343592204941, 5970.731317090655, 5991.700414979146, 6010.459058684739, 5556.388797232382, 5586.525145362527, 5587.3015873015875, 5589.385167631639, 5597.748101335531, 5502.147167189092, 5587.0, 5645.209670646195, 5663.801766938137, 5673.489385955284, 5423.484768946943, 5477.397486276586, 5478.04134276492, 5484.808031719031, 5530.391656917816, 5451.536619387396, 5458.536024437808, 5471.699056551769, 5471.8084867029465, 5475.2334673145, 5320.17537281722, 5324.920126198032, 5378.327709036371, 5379.246905433164, 5416.7020813855615, 5535.723213839373, 5536.335639723259, 5544.611877168721, 5578.023845827045, 5586.608937374344, 5384.192371144203, 5417.756200971045, 5427.4301198373605, 5430.51125398716, 5433.049216387196], "unit": "score", "name": "dojo.html", "value": 5179.148860058603}, {"lowerIsBetter": false, "replicates": [519.6128883981432, 521.7938914128922, 559.2478116932725, 607.7963882099497, 610.0513701194641, 28419.857900710493, 28783.712162878364, 36661.0, 37265.254694906085, 37299.4405083924, 43008.35487467691, 43937.0, 44018.779906100426, 44038.77980610092, 44170.0, 7504.5872477013745, 8643.956780216105, 8856.5571721414, 8861.867071993925, 8863.246624036932, 10340.121089707383, 10632.681019569425, 10635.946820265888, 10639.202059845504, 10645.0, 10332.638357657483, 10453.84319235212, 10459.267851250415, 10461.947690261539, 10468.0, 10145.64490242838, 10219.744506387326, 10224.437655928921, 10246.89753102467, 10259.589616415335, 10341.431221282826, 10446.582136714522, 10477.109445697124, 10482.528286227061, 10485.685429437053, 40778.18443631141, 40985.590144098474, 41217.0, 41261.174776504304, 41305.586944130475, 3029.8338236542645, 3104.922376940572, 3127.0, 3147.7796554241213, 3289.3256882339065, 31040.53439198414, 31634.36731265362, 31810.522842157385, 31907.0, 32750.836245818617, 3896.5129358830145, 3901.5708272090046, 3914.9804250978564, 3923.3722604383447, 4038.9798051009557, 280447.0, 280458.0, 280524.0, 280772.99999999796, 281324.0, 40482.79758601247, 41432.37851432231, 59193.40806591965, 59485.0, 59647.70176149091, 39963.40054899179, 40265.79867100704, 40323.59676403257, 40344.596554034084, 40345.0, 13611.659708507366, 13822.861771382157, 13863.098898571561, 13887.79168312476, 13914.930425347808, 8422.452540584842, 8496.957515212385, 9721.756956076155, 10398.948005260077, 10572.154227661922, 14148.292585370691, 14269.143851368952, 14306.356213970397, 14315.713685726436, 14321.427142914376, 5616.85957851057, 5626.268585083994, 5693.715314234271, 5694.743736531866, 5761.135829625506, 923.215267023025, 954.6086104697041, 956.8086382723483, 964.4791812421214, 970.5389939778548, 28036.158915232576, 28938.421231575252, 29101.85449072741, 29258.414831703245, 29484.410311793643, 1021.0861279155115, 1046.3617193511952, 1082.6643740440331, 1093.9398333091597, 1140.5152810055858, 13340.199588024556, 13713.520026799015, 13867.930660346634, 13945.372458239404, 14031.508897188549, 305083.0, 310003.0, 311875.0, 311988.0, 312114.0, 53266.73366633142, 53716.46283537193, 53799.0, 53832.46167538274, 53948.0, 1119.4514687802919, 1307.7907534794388, 1329.195836518892, 1331.8534961154264, 1351.418889877362, 24854.751452485965, 26560.468790624465, 26644.733552665002, 26698.46603067889, 26713.732862671124, 37337.62662373341, 37599.624003759614, 38153.42769858399, 38313.808430957666, 38314.80842595881, 174376.0, 174660.0, 174906.0, 174937.0, 175209.1239543845, 27347.31631709223, 30909.69090309158, 32622.51066233961, 32718.182045449055, 32739.672603274616, 38108.618913810504, 38998.250437390656, 39175.0, 39253.41119883147, 41413.1717365657, 35034.299314013064, 35174.82412588023, 35468.290634186655, 35836.462453062704, 35857.82071089628, 34601.30797383988, 34633.826830865684, 34869.0, 35170.64829351674, 35201.823990880905, 33973.980780576625, 34414.0, 34563.48154777731, 34804.477932831534, 34886.30227395488, 30025.849870750506, 30878.84560577183, 31156.22109447282, 31178.376432471676, 31658.841705791325, 24672.383190419667, 24699.259022229362, 24831.751682483668, 24877.507349559084, 25005.0], "unit": "score", "name": "ext.html", "value": 17472.244161398878}, {"lowerIsBetter": false, "replicates": [353.3974573352434, 364.6626870145115, 369.72270796902313, 377.758234729773, 383.0328420737639, 16382.344706211752, 16962.830371696295, 18241.270349186016, 18385.724214136764, 18395.356162534314, 16575.83424165758, 17511.474655760314, 17513.124343782823, 17513.211905464254, 17528.474145775614, 4662.347271382001, 4855.393075865517, 4855.417349918015, 4858.659893807435, 4861.1492988727005, 3791.9431208531896, 4824.155772739774, 5210.661307015051, 5420.186971954218, 5449.100898351767, 5428.267183930178, 5429.321334833146, 5437.673739575618, 5443.782248710047, 5445.50990410863, 5244.134717771563, 5398.271233383502, 5484.561235101202, 5485.533729632986, 5489.258950041733, 5265.657732247391, 5275.182346736224, 5275.26146339509, 5277.261183434322, 5280.102382594968, 12760.680982975407, 12994.740105197938, 13198.86801131986, 13228.074034817566, 13239.735205295936, 1859.888406695589, 1884.274554296592, 1889.9244030238774, 1916.9712454313196, 1941.9611607767906, 9004.459732416011, 9085.51926861473, 9198.126178013077, 9198.816023679556, 9546.42721436716, 1517.4006267524376, 1519.3694616734042, 1560.2978659603111, 1645.695546323934, 1664.7419649954277, 56291.0, 58684.41315586832, 61165.388346116415, 62111.689441553404, 62880.37119628791, 9816.852747208797, 9901.950490247647, 10455.372677639367, 10503.369797812156, 10596.788064238826, 13877.306134693225, 13978.0, 13983.09109907873, 13990.370433330525, 14009.08940918837, 7279.854402911912, 7311.926880731231, 7357.816054598571, 7435.0, 7436.692378283148, 6937.306269373023, 6971.54684945487, 7065.89401158983, 7137.464690148259, 7163.3552980232025, 4450.221211288076, 4491.214037543482, 4527.864164075083, 4578.9771051144535, 4631.513691062457, 1684.8399402056784, 1710.1705672748708, 1829.5243236758272, 1840.9723854142198, 1872.5786697992842, 389.5481241759602, 392.30757712637217, 395.4562476594682, 397.34239833076305, 931.967376168681, 9899.950500247596, 9990.900090999143, 10089.848652270222, 10094.444805535619, 10360.222983276284, 424.4969710892602, 426.5286858021903, 426.82073529117844, 431.3228231676238, 433.93707912352534, 5474.479924407175, 5509.559235261169, 5509.807156749494, 5574.080276754371, 5651.039323314964, 447309.0, 450398.0, 454068.0, 458419.0, 468178.0, 73191.26808731844, 73476.63261683764, 73516.0, 74141.6292918532, 75181.62409187919, 457.0, 460.7005446459761, 462.142725244673, 465.5577201658438, 465.71125901940337, 8178.754637360888, 9802.460864652512, 10194.388336699822, 10271.537780800032, 10446.843297350697, 30715.0, 31022.689773102884, 31110.53334200034, 31527.84236078805, 32114.0, 39979.2004159921, 41679.37480937849, 41707.7914610425, 41759.7912010438, 42150.927966650605, 7512.436567257369, 7598.772036838904, 7736.535807851547, 7793.766187014398, 7805.375569954504, 9988.900110998797, 11400.543978241109, 11677.007454366474, 11695.415229238673, 11906.940465297617, 10181.490925453845, 10197.13324367437, 10279.177665786869, 10383.584656613953, 10704.625338113128, 9893.35693179941, 10198.0, 10228.897711022795, 10391.63629273002, 10419.270651054354, 10187.796244075225, 10497.47512624381, 10528.46033441849, 10657.467126643793, 10829.837552436562, 7438.070241219848, 7501.212372701006, 7519.473636845587, 7736.961315193388, 7994.2805147537, 7749.573773442515, 8928.910710892807, 9787.510624468605, 9915.801683966425, 10006.599736010477], "unit": "score", "name": "jquery.html", "value": 7243.566200151309}, {"lowerIsBetter": false, "replicates": [1363.7681594128996, 1471.9264036798158, 1489.1809504772375, 1682.5457126575825, 1842.3275504440883, 7763.650635721392, 7948.085970113439, 7957.164497727742, 7963.323117535002, 7973.60131993401, 7904.802379940505, 8086.150954149818, 8089.2315230053055, 8098.392620553467, 8101.14937931516, 2077.2937201351538, 2306.1813056365, 2325.3140323604493, 2349.788519033287, 2354.6703461515403, 2346.812255019603, 2359.7050368703913, 2361.8346715729904, 2362.14962613459, 2362.4684445999683, 2299.8850057497143, 2364.361622361961, 2366.290112966103, 2366.92899213023, 2371.312319427364, 2319.2926157521947, 2336.19401306549, 2386.2364043506, 2386.868722220277, 2388.3551441110803, 2309.353381053291, 2336.4859730859184, 2340.648902664597, 2388.6536452214505, 2389.952200955971, 8189.95905020477, 8247.092819789817, 8251.504909705436, 8260.628271727786, 8263.421560490768, 4841.70949743013, 4982.0, 4996.875078123039, 5005.274235235906, 5006.048850718352, 3111.4399408106533, 3208.8395580220895, 3261.5270785735934, 3272.8690852365876, 3279.2949515854207, 961.9470929098967, 967.7774111954219, 993.1409330928767, 1016.8017236638858, 1017.1710056304089, 11464.082873370111, 11486.13853960948, 11486.655400338002, 11493.770124597544, 11495.310281383227, 4435.0, 4527.185106680763, 4618.584327410549, 4632.4904260531985, 4634.420697412824, 9795.118439340493, 9820.459874706818, 9834.213262938947, 9836.704898853046, 9848.0, 4421.292593185075, 5039.596832253411, 5058.342415486037, 5059.87350316245, 5070.797168113308, 4012.558618551957, 4018.5981401860163, 4047.1500984793524, 4393.428854248991, 4465.24090904547, 3758.699304055669, 3847.480590120354, 3864.961350386516, 3895.863644772476, 3900.4344370066183, 1231.612042206702, 1233.4079641772, 1241.1746188784539, 1247.0460098025019, 1251.6557946564767, 1320.947162113524, 1338.732253549294, 1351.8107464954915, 1358.0968655843951, 1358.3615700620692, 7473.887891681629, 7486.213947535431, 7664.156942736295, 7664.271894170045, 7677.731279405194, 1113.9554417823358, 1128.1651577832345, 1133.1274918312854, 1138.698244965085, 1140.156284349592, 5706.80026199081, 5726.427357264323, 5739.13912913058, 5764.221830052889, 5780.1907732917425, 9356.0, 9533.285003624756, 9709.174720148725, 9812.0, 9959.452230127268, 9929.25530585209, 9975.900240997642, 9989.05104015132, 10058.647947321808, 10058.949705251427, 7502.362299204519, 7754.844903101906, 7869.960650196713, 7900.762977110696, 7906.881396779053, 7285.854282914418, 7298.708051678086, 7351.889721654073, 7361.631918404166, 7363.042804435389, 8205.95897020511, 8732.34507411934, 8835.514046727234, 9040.954795225982, 9050.411723237969, 8640.35197360213, 8670.566471676264, 8743.912560874563, 8747.693830715894, 8861.069587693199, 6698.66506674674, 7396.778096657109, 7581.50720203185, 7676.692932282646, 7762.5730584818375, 7707.614619269127, 7737.458377913492, 7742.1483636798785, 7766.88349674744, 7804.765857024298, 6813.182418109858, 6863.347981941708, 6888.345607167311, 7041.366277035091, 7073.504854660125, 6785.457163426815, 6812.182538095262, 6927.653617319214, 6931.44548436134, 6941.409980151744, 6894.8621027578165, 7087.184973728087, 7137.0, 7328.3404493595835, 7381.1511676157925, 6498.512611554058, 6644.700988455627, 6656.667166641745, 6681.899771503528, 6690.899636505554, 6651.966740166268, 6693.196816382066, 6729.495287853529, 6745.86508269822, 6775.457963363017], "unit": "score", "name": "mootools.html", "value": 4661.041035255468}, {"lowerIsBetter": false, "replicates": [317.5427384566223, 318.5460718476171, 323.9886603968861, 325.87779582656486, 326.03168589289817, 5764.106563482662, 5784.248047753791, 5790.797322093727, 5795.739191736371, 5795.942040579593, 5658.971705141479, 5677.630953987988, 5698.145278208271, 5700.515456186229, 5702.971485142569, 4239.851605193819, 4346.8913277168, 4455.84404545841, 4481.395011673431, 4498.167838949788, 4465.732056076646, 4476.8656940291685, 4485.237509623372, 4485.775711214426, 4502.144592527426, 4254.617084462413, 4434.00234947136, 4449.176902273073, 4451.176532341511, 4454.599086082252, 4317.935230971538, 4338.978305108486, 4346.76092814895, 4434.733915965053, 4440.289553671397, 3889.3776995680837, 3890.6692931100893, 3893.8831835044994, 3896.08442016126, 3903.0, 5532.28080349552, 5535.335759708861, 5536.390996990328, 5542.39033706292, 5544.140658197985, 5141.228815677641, 5157.097507936096, 5158.097332966716, 5162.483751624845, 5163.225516172567, 6109.266887973427, 6115.571909966304, 6120.265568131853, 6123.295820980599, 6129.325774164839, 4218.367244913257, 4309.6336811371075, 4314.546972567867, 4316.417283666728, 4325.286327755916, 6380.234371875405, 6395.744170233185, 6403.551751377406, 6403.647799371032, 6408.0, 4394.758288294111, 4397.758123303185, 4404.251277282806, 4404.845830395985, 4408.118376324684, 4455.576720211575, 4459.44256967879, 4461.933071003938, 4464.084862603158, 4464.129494748493, 5070.594352451795, 5131.076406246837, 5133.332666753298, 5138.640295179376, 5144.511271429208, 5935.0207215808905, 6098.5426093042315, 6137.631742095399, 6143.0, 6154.846128846814, 1505.2548988250667, 1517.4006267524487, 1529.701708166919, 1530.4260902161689, 1531.7625768005978, 929.6885543343055, 993.6293150279055, 998.4159266828987, 1006.2201793610011, 1007.3905287301224, 5827.446392592697, 5953.493953013955, 5998.730057147439, 6001.639901605918, 6002.039673652194, 6325.588836725598, 6396.008618664115, 6398.296187419473, 6399.200099987502, 6402.519811014193, 5944.167816505693, 5947.434993675681, 5968.85077873048, 5973.074173503114, 5974.0, 3391.491276308524, 3422.418188907842, 3422.606400263952, 3425.1950791563963, 3427.657234276602, 6539.934600653933, 6700.932990670129, 6704.161979752531, 6714.429273511709, 6734.797956061326, 6505.642189679613, 6520.119783829123, 6521.706523206467, 6534.8366290843105, 6540.37866402691, 6699.330066993261, 6701.497387695942, 6705.664716764142, 6707.832304192434, 6715.395614394728, 6352.777652782131, 6358.427741503287, 6360.141380913517, 6360.141380913517, 6361.077643741724, 6070.848228794139, 6292.716827742671, 6301.4328710416285, 6310.936890631035, 6348.174737284124, 6669.199696036312, 6710.362515561014, 6738.797836064926, 6746.831329216809, 6751.426128779109, 4293.549177336335, 4307.892302692458, 4308.4399028126145, 4311.417958575552, 4311.892202694832, 6396.968015159894, 6402.711877965409, 6405.071264666504, 6405.935940640534, 6409.807705768648, 6196.690165491617, 6214.658193799384, 6215.564910456224, 6218.31598524171, 6221.720022598904, 6034.547408944259, 6185.103160041679, 6198.411150940653, 6202.751889924533, 6205.565610407228, 6090.269167699905, 6104.4200800923845, 6107.969460152671, 6113.908291375722, 6116.724747386289, 6233.189685341058, 6240.0, 6243.8126856194385, 6248.875022499434, 6249.8750024998335, 5869.4717475427415, 6100.389961003864, 6106.3588323227195, 6107.328193898578, 6109.633421994695], "unit": "score", "name": "prototype.html", "value": 4645.999332122509}, {"lowerIsBetter": false, "replicates": [714.2107970692384, 749.2170681637688, 792.184050428059, 793.8055176481763, 795.1174196641726, 13125.212487250772, 13209.933950330258, 13222.20666759995, 13229.536966206197, 13915.165090094588, 13050.347482625879, 13211.801822972639, 13302.268375239382, 13312.534061307857, 13439.731205375887, 824.7979245084947, 836.4855613797531, 842.1872892658583, 842.7092653034694, 843.0726201178685, 835.4068611285994, 837.4849467577457, 838.329336530776, 839.3159574946399, 839.6473481137937, 875.0330884372772, 877.784942689042, 877.9648814047431, 877.9692710755124, 878.1174919206189, 872.2411501993244, 872.8123453457505, 873.1312344217545, 873.7771868173575, 874.0298268921492, 641.3874749614107, 643.855132595167, 643.9452646525051, 643.9806805795833, 644.2269276867777, 12995.805062924064, 12999.0, 13008.414621342063, 13026.54407095747, 13040.478380864753, 10239.692809215661, 10272.435016074112, 10420.947895260475, 10524.736881578021, 10591.417472039035, 9110.954445227731, 9210.723678289662, 9390.5304734763, 9441.811163776685, 9484.308170307286, 3134.059782065394, 3161.525771134325, 3192.106210261107, 3193.552902593639, 3288.8026718396973, 48384.0, 48629.0, 48661.0, 48666.27000594994, 48766.512334876905, 7551.207123252089, 7639.350655194371, 7777.338926191337, 7780.14418413974, 7867.095284042294, 16652.50042498727, 16689.582760431087, 16689.6662066758, 16691.33234670624, 16695.666086678197, 7464.290892365217, 7549.245075492407, 7593.430492712958, 7644.961775191088, 7660.119086305035, 4030.5163380393956, 4044.51465824103, 4049.493813273341, 4058.0463591056077, 4241.851535196253, 3060.3879224155257, 3097.1018404662395, 3097.4734295169874, 3103.581016562735, 3104.286014216743, 533.2747463449705, 533.5784730063284, 538.8652836790802, 543.4405339204081, 557.1753804369556, 534.74599565207, 591.2461611445442, 608.4514909555193, 616.6731632234922, 617.8239201827547, 7716.189800071024, 8234.794130146794, 8309.169083091763, 8388.832223355499, 8464.492130472192, 673.4477728262875, 673.8214373191108, 686.5983399711125, 702.5749421599859, 705.562551218248, 3644.0820860733147, 3723.1436769542615, 3745.0, 3836.405357169643, 3876.186000939778, 55927.16109258364, 57588.0, 57589.424105759244, 57867.42132578704, 58017.41982580205, 49339.0, 49601.50398496041, 50262.74868625634, 51638.74180629073, 51845.48154518482, 43561.0, 44144.117117657464, 44192.0, 44284.335734964, 44695.99999999935, 8310.667573297, 8512.872306915277, 8539.402241843012, 8710.12898710124, 8887.111288871061, 32620.83689581537, 33442.49836252409, 33969.0, 34018.489722653685, 34817.12957176091, 38267.0, 42917.0, 43345.34981975336, 43827.78086109677, 44073.55926440695, 10381.712655745463, 10643.787124257316, 10794.244402891722, 11053.778924421627, 11082.335059896432, 11428.657140285804, 11795.174337796272, 11801.0, 11931.33516611893, 11971.673721769444, 11727.35499547533, 12050.337231452355, 12162.878371216175, 12401.941362916292, 12468.0, 11487.36819474937, 11526.827097593376, 11825.46785394642, 11878.940605296919, 11990.0, 11136.80519830784, 11402.372869492257, 11609.825852612386, 11718.676578969604, 12011.459484323052, 9750.512474376112, 9846.409215447096, 9852.852207216754, 10076.69769906904, 10088.142507886912, 8919.286457083288, 8919.375643705138, 9066.727998160066, 9291.6283348668, 9539.570719317786], "unit": "score", "name": "yui.html", "value": 6140.840630267281}], "name": "dromaeo_css", "value": 6658.82119617288}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 111.0, 112.0, 110.0, 100.0, 112.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [158.0, 135.0, 149.0, 176.0, 128.0, 149.0, 150.0, 130.0, 169.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 159.0, 159.0, 160.0, 161.0, 165.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 98.0, 92.0, 75.0, 72.0, 74.0, 130.0, 98.0, 76.0], "unit": "score", "name": "audio-fft", "value": 86.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 146.0, 93.0, 93.0, 93.0, 139.0, 93.0, 94.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 56.0, 57.0, 56.0, 58.0, 64.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 81.0, 80.0, 82.0, 80.0, 81.0, 80.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.8}, {"lowerIsBetter": true, "replicates": [118.0, 120.0, 118.0, 115.0, 120.0, 115.0, 115.0, 115.0, 114.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.5}, {"lowerIsBetter": true, "replicates": [154.0, 140.0, 154.0, 150.0, 150.0, 149.0, 141.0, 155.0, 147.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 68.0, 66.0, 69.0, 68.0, 66.0, 68.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1511.0}]} 14:27:22 INFO - Return code: 0 14:27:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:27:22 ERROR - # TBPL SUCCESS # 14:27:22 INFO - Running post-action listener: _resource_record_post_action 14:27:22 INFO - Running post-run listener: _resource_record_post_run 14:27:23 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 533540864; Read time: 396; Write time: 478268 14:27:23 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 241012736; Read time: 276; Write time: 276128 14:27:23 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292528128; Read time: 120; Write time: 202140 14:27:23 INFO - Running post-run listener: _upload_blobber_files 14:27:23 INFO - Blob upload gear active. 14:27:23 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:27:23 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:27:23 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:27:23 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:27:24 INFO - (blobuploader) - INFO - Open directory for files ... 14:27:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:27:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:27:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:25 INFO - (blobuploader) - INFO - Done attempting. 14:27:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:27:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:27:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:25 INFO - (blobuploader) - INFO - Done attempting. 14:27:25 INFO - (blobuploader) - INFO - Iteration through files over. 14:27:25 INFO - Return code: 0 14:27:25 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:27:25 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:27:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2ce2627bb772b1c2e46f993b88497aaf7a7b3f7dbb3809e3d5d81c0cf43f4d3f061d673d3cb6adba7d5867fdb956c5784bcbe31e2da061f69e79b97ae23d39f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0956723e16b988152947e9b7a9a7f1695ab1005c62255bdad8b38b142fda1ddfb1e1358c65f63b5b110d04e5082f066fe7b83f9d30e3e0bfb66cd1fca3aed846"} 14:27:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:27:25 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:27:25 INFO - Contents: 14:27:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2ce2627bb772b1c2e46f993b88497aaf7a7b3f7dbb3809e3d5d81c0cf43f4d3f061d673d3cb6adba7d5867fdb956c5784bcbe31e2da061f69e79b97ae23d39f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0956723e16b988152947e9b7a9a7f1695ab1005c62255bdad8b38b142fda1ddfb1e1358c65f63b5b110d04e5082f066fe7b83f9d30e3e0bfb66cd1fca3aed846"} 14:27:25 INFO - Running post-run listener: copy_logs_to_upload_dir 14:27:25 INFO - Copying logs to upload dir... 14:27:25 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:27:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.677776 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-11 14:27:25.893985) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 14:27:25.897420) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548 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/e2ce2627bb772b1c2e46f993b88497aaf7a7b3f7dbb3809e3d5d81c0cf43f4d3f061d673d3cb6adba7d5867fdb956c5784bcbe31e2da061f69e79b97ae23d39f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0956723e16b988152947e9b7a9a7f1695ab1005c62255bdad8b38b142fda1ddfb1e1358c65f63b5b110d04e5082f066fe7b83f9d30e3e0bfb66cd1fca3aed846"} build_url:https://queue.taskcluster.net/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011459 build_url: 'https://queue.taskcluster.net/v1/task/INwpwHCyRSmZ_ziXkduMbA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2ce2627bb772b1c2e46f993b88497aaf7a7b3f7dbb3809e3d5d81c0cf43f4d3f061d673d3cb6adba7d5867fdb956c5784bcbe31e2da061f69e79b97ae23d39f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0956723e16b988152947e9b7a9a7f1695ab1005c62255bdad8b38b142fda1ddfb1e1358c65f63b5b110d04e5082f066fe7b83f9d30e3e0bfb66cd1fca3aed846"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 14:27:25.922973) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 14:27:25.923333) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1457733626.339114-505085548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004769 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 14:27:26.006697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 14:27:26.007027) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 14:27:26.007351) ========= ========= Total master_lag: 1.84 =========