builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1456221214.19 results: success (0) buildid: 20160222083110 builduid: 443930374c0d4c20873d4c60c1bf3c68 revision: 135340a254f4b16c86b0c7dd320253c4a1a0776e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.188337) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.188814) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.189117) ========= 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=0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007524 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.210655) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.210961) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.230043) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.230431) ========= 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=0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014366 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.279098) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.279416) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.279764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.280034) ========= 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=0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-23 01:53:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.8M=0s 2016-02-23 01:53:34 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.211043 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.503560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.503871) ========= 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=0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.077055 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:34.592256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 01:53:34.592615) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 135340a254f4b16c86b0c7dd320253c4a1a0776e --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 135340a254f4b16c86b0c7dd320253c4a1a0776e --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=0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-23 01:53:34,877 truncating revision to first 12 chars 2016-02-23 01:53:34,878 Setting DEBUG logging. 2016-02-23 01:53:34,878 attempt 1/10 2016-02-23 01:53:34,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/135340a254f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 01:53:35,983 unpacking tar archive at: fx-team-135340a254f4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.387246 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 01:53:35.992586) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:35.992937) ========= echo 135340a254f4b16c86b0c7dd320253c4a1a0776e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'135340a254f4b16c86b0c7dd320253c4a1a0776e'] 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=0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 135340a254f4b16c86b0c7dd320253c4a1a0776e program finished with exit code 0 elapsedTime=0.003338 script_repo_revision: '135340a254f4b16c86b0c7dd320253c4a1a0776e' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:36.041020) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:36.041343) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 01:53:36.050977) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-02-23 01:53:36.051344) ========= /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=0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:53:36 INFO - MultiFileLogger online at 20160223 01:53:36 in /builds/slave/test-pgo 01:53:36 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 01:53:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:53:36 INFO - {'append_to_log': False, 01:53:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:53:36 INFO - 'blob_upload_branch': 'Fx-Team', 01:53:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:53:36 INFO - 'branch': 'Fx-Team', 01:53:36 INFO - 'buildbot_json_path': 'buildprops.json', 01:53:36 INFO - 'config_files': ('talos/linux_config.py',), 01:53:36 INFO - 'default_actions': ('clobber', 01:53:36 INFO - 'read-buildbot-config', 01:53:36 INFO - 'download-and-extract', 01:53:36 INFO - 'populate-webroot', 01:53:36 INFO - 'create-virtualenv', 01:53:36 INFO - 'install', 01:53:36 INFO - 'run-tests'), 01:53:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:53:36 INFO - 'download_minidump_stackwalk': True, 01:53:36 INFO - 'download_symbols': 'ondemand', 01:53:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:53:36 INFO - 'tooltool.py': '/tools/tooltool.py', 01:53:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:53:36 INFO - '/tools/misc-python/virtualenv.py')}, 01:53:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:53:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:53:36 INFO - 'installer_path': 'installer.exe', 01:53:36 INFO - 'log_level': 'info', 01:53:36 INFO - 'log_name': 'talos', 01:53:36 INFO - 'log_to_console': True, 01:53:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:53:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:53:36 INFO - 'opt_config_files': (), 01:53:36 INFO - 'pip_index': False, 01:53:36 INFO - 'sps_profile': False, 01:53:36 INFO - 'sps_profile_interval': 0, 01:53:36 INFO - 'suite': 'dromaeojs', 01:53:36 INFO - 'system_bits': '32', 01:53:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:53:36 INFO - 'title': 'talos-linux64-ix-029', 01:53:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:53:36 INFO - 'use_talos_json': True, 01:53:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:53:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:53:36 INFO - 'work_dir': 'build'} 01:53:36 INFO - ##### 01:53:36 INFO - ##### Running clobber step. 01:53:36 INFO - ##### 01:53:36 INFO - Running pre-action listener: _resource_record_pre_action 01:53:36 INFO - Running main action method: clobber 01:53:36 INFO - rmtree: /builds/slave/test-pgo/build 01:53:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:53:40 INFO - Running post-action listener: _resource_record_post_action 01:53:40 INFO - ##### 01:53:40 INFO - ##### Running read-buildbot-config step. 01:53:40 INFO - ##### 01:53:40 INFO - Running pre-action listener: _resource_record_pre_action 01:53:40 INFO - Running main action method: read_buildbot_config 01:53:40 INFO - Using buildbot properties: 01:53:40 INFO - { 01:53:40 INFO - "project": "", 01:53:40 INFO - "product": "firefox", 01:53:40 INFO - "script_repo_revision": "production", 01:53:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:53:40 INFO - "repository": "", 01:53:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:53:40 INFO - "buildid": "20160222083110", 01:53:40 INFO - "pgo_build": "True", 01:53:40 INFO - "basedir": "/builds/slave/test-pgo", 01:53:40 INFO - "buildnumber": 661, 01:53:40 INFO - "slavename": "talos-linux64-ix-029", 01:53:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:53:40 INFO - "platform": "ubuntu64_hw", 01:53:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:53:40 INFO - "branch": "fx-team", 01:53:40 INFO - "repo_path": "integration/fx-team", 01:53:40 INFO - "revision": "135340a254f4b16c86b0c7dd320253c4a1a0776e", 01:53:40 INFO - "stage_platform": "linux64-pgo", 01:53:40 INFO - "builduid": "443930374c0d4c20873d4c60c1bf3c68", 01:53:40 INFO - "slavebuilddir": "test" 01:53:40 INFO - } 01:53:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 01:53:40 INFO - Running post-action listener: _resource_record_post_action 01:53:40 INFO - ##### 01:53:40 INFO - ##### Running download-and-extract step. 01:53:40 INFO - ##### 01:53:40 INFO - Running pre-action listener: _resource_record_pre_action 01:53:40 INFO - Running main action method: download_and_extract 01:53:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:40 INFO - https://queue.taskcluster.net/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/test_packages.json 01:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/test_packages.json 01:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:53:41 INFO - Downloaded 1448 bytes. 01:53:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:53:41 INFO - Using the following test package requirements: 01:53:41 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 01:53:41 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:53:41 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:53:41 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:41 INFO - u'jsshell-linux-x86_64.zip'], 01:53:41 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:53:41 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 01:53:41 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:53:41 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:53:41 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:53:41 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 01:53:41 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:53:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:53:41 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:41 INFO - https://queue.taskcluster.net/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:53:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:53:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:53:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:53:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:53:42 INFO - Downloaded 23366288 bytes. 01:53:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:53:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:53:43 INFO - Return code: 0 01:53:43 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:43 INFO - https://queue.taskcluster.net/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:53:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:53:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:53:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:53:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:53:44 INFO - Downloaded 23366288 bytes. 01:53:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:53:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:53:46 INFO - Return code: 0 01:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:46 INFO - https://queue.taskcluster.net/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:53:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 01:53:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 01:53:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 01:53:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:53:47 INFO - Downloaded 10707015 bytes. 01:53:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:53:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 01:53:47 INFO - Return code: 0 01:53: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')]} 01:53:47 INFO - https://queue.taskcluster.net/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:53:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:53:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:53:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:53:48 INFO - Downloaded 56559816 bytes. 01:53:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:53:48 INFO - mkdir: /builds/slave/test-pgo/properties 01:53:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:53:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:53:48 INFO - Contents: 01:53:48 INFO - build_url:https://queue.taskcluster.net/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:53:49 INFO - Running post-action listener: _resource_record_post_action 01:53:49 INFO - Running post-action listener: set_extra_try_arguments 01:53:49 INFO - ##### 01:53:49 INFO - ##### Running populate-webroot step. 01:53:49 INFO - ##### 01:53:49 INFO - Running pre-action listener: _resource_record_pre_action 01:53:49 INFO - Running main action method: populate_webroot 01:53:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:53:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:53:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:53:49 INFO - '--tppagecycles', 01:53:49 INFO - '7'], 01:53:49 INFO - 'tests': ['tsvgm']}}, 01:53:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:53:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:53:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:53:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:53:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:53:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:53:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'tests': ['damp', 'tps']}, 01:53:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['damp', 'tps']}, 01:53:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:53:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:53:49 INFO - 'other': {'tests': ['a11yr', 01:53:49 INFO - 'ts_paint', 01:53:49 INFO - 'tpaint', 01:53:49 INFO - 'sessionrestore', 01:53:49 INFO - 'sessionrestore_no_auto_restore']}, 01:53:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['a11yr', 01:53:49 INFO - 'ts_paint', 01:53:49 INFO - 'tpaint', 01:53:49 INFO - 'sessionrestore', 01:53:49 INFO - 'sessionrestore_no_auto_restore']}, 01:53:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['a11yr', 01:53:49 INFO - 'ts_paint', 01:53:49 INFO - 'tpaint', 01:53:49 INFO - 'sessionrestore', 01:53:49 INFO - 'sessionrestore_no_auto_restore']}, 01:53:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['a11yr', 01:53:49 INFO - 'ts_paint', 01:53:49 INFO - 'tpaint', 01:53:49 INFO - 'sessionrestore', 01:53:49 INFO - 'sessionrestore_no_auto_restore']}, 01:53:49 INFO - 'other_l64': {'tests': ['a11yr', 01:53:49 INFO - 'ts_paint', 01:53:49 INFO - 'tpaint', 01:53:49 INFO - 'sessionrestore', 01:53:49 INFO - 'sessionrestore_no_auto_restore']}, 01:53:49 INFO - 'other_nol64': {'tests': ['a11yr', 01:53:49 INFO - 'ts_paint', 01:53:49 INFO - 'tpaint', 01:53:49 INFO - 'sessionrestore', 01:53:49 INFO - 'sessionrestore_no_auto_restore']}, 01:53:49 INFO - 'svgr': {'tests': ['tsvgx', 01:53:49 INFO - 'tsvgr_opacity', 01:53:49 INFO - 'tart', 01:53:49 INFO - 'tscrollx', 01:53:49 INFO - 'cart']}, 01:53:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['tsvgx', 01:53:49 INFO - 'tsvgr_opacity', 01:53:49 INFO - 'tart', 01:53:49 INFO - 'tscrollx', 01:53:49 INFO - 'cart']}, 01:53:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'tests': ['tp5o']}, 01:53:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'talos_options': ['--e10s'], 01:53:49 INFO - 'tests': ['tp5o']}, 01:53:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'talos_options': ['--xperf_path', 01:53:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:53:49 INFO - 'tests': ['tp5n']}, 01:53:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:53:49 INFO - 'talos_options': ['--e10s', 01:53:49 INFO - '--xperf_path', 01:53:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:53:49 INFO - 'tests': ['tp5n']}}, 01:53:49 INFO - 'talos.zip': {'path': '', 01:53:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:53:49 INFO - Running post-action listener: _resource_record_post_action 01:53:49 INFO - ##### 01:53:49 INFO - ##### Running create-virtualenv step. 01:53:49 INFO - ##### 01:53:49 INFO - Running pre-action listener: _resource_record_pre_action 01:53:49 INFO - Running main action method: create_virtualenv 01:53:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:53:49 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 01:53:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:53:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:53:49 INFO - Using real prefix '/usr' 01:53:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:53:50 INFO - Installing distribute.............................................................................................................................................................................................done. 01:53:52 INFO - Installing pip.................done. 01:53:52 INFO - Return code: 0 01:53:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:53:52 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')]} 01:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:52 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')]} 01:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:52 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 0x7f83f379df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8c0>, '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 0x24fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fbc50>, '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': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', '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 01:53:52 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 01:53:52 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 01:53:52 INFO - Using env: {'DISPLAY': ':0', 01:53:52 INFO - 'HOME': '/home/cltbld', 01:53:52 INFO - 'LANG': 'en_US.UTF-8', 01:53:52 INFO - 'LANGUAGE': 'en_US:en', 01:53:52 INFO - 'LOGNAME': 'cltbld', 01:53:52 INFO - 'MAIL': '/var/mail/cltbld', 01:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:52 INFO - 'MOZ_NO_REMOTE': '1', 01:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:52 INFO - 'NO_EM_RESTART': '1', 01:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:53:52 INFO - 'PWD': '/builds/slave/test-pgo', 01:53:52 INFO - 'SHELL': '/bin/bash', 01:53:52 INFO - 'SHLVL': '1', 01:53:52 INFO - 'TERM': 'linux', 01:53:52 INFO - 'TMOUT': '86400', 01:53:52 INFO - 'USER': 'cltbld', 01:53:52 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', 01:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:52 INFO - '_': '/tools/buildbot/bin/python'} 01:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:52 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 01:53:52 INFO - Cleaning up... 01:53:52 INFO - Return code: 0 01:53:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:53:52 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')]} 01:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:52 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')]} 01:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:52 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 0x7f83f379df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8c0>, '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 0x24fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fbc50>, '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': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', '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 01:53:52 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 01:53:52 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 01:53:52 INFO - Using env: {'DISPLAY': ':0', 01:53:52 INFO - 'HOME': '/home/cltbld', 01:53:52 INFO - 'LANG': 'en_US.UTF-8', 01:53:52 INFO - 'LANGUAGE': 'en_US:en', 01:53:52 INFO - 'LOGNAME': 'cltbld', 01:53:52 INFO - 'MAIL': '/var/mail/cltbld', 01:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:52 INFO - 'MOZ_NO_REMOTE': '1', 01:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:52 INFO - 'NO_EM_RESTART': '1', 01:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:53:52 INFO - 'PWD': '/builds/slave/test-pgo', 01:53:52 INFO - 'SHELL': '/bin/bash', 01:53:52 INFO - 'SHLVL': '1', 01:53:52 INFO - 'TERM': 'linux', 01:53:52 INFO - 'TMOUT': '86400', 01:53:52 INFO - 'USER': 'cltbld', 01:53:52 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', 01:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:52 INFO - '_': '/tools/buildbot/bin/python'} 01:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:52 INFO - Downloading/unpacking psutil>=0.7.1 01:53:52 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 01:53:52 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 01:53:52 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 01:53:52 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 01:53:52 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 01:53:52 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 01:53:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:53:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:53:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:53:54 INFO - Installing collected packages: psutil 01:53:54 INFO - Running setup.py install for psutil 01:53:54 INFO - building 'psutil._psutil_linux' extension 01:53:54 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 01:53:54 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 01:53:54 INFO - building 'psutil._psutil_posix' extension 01:53:54 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 01:53:55 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 01:53:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:53:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:53:55 INFO - Successfully installed psutil 01:53:55 INFO - Cleaning up... 01:53:55 INFO - Return code: 0 01:53:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:53:55 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')]} 01:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:55 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')]} 01:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:55 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 0x7f83f379df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8c0>, '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 0x24fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fbc50>, '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': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', '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 01:53:55 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 01:53:55 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 01:53:55 INFO - Using env: {'DISPLAY': ':0', 01:53:55 INFO - 'HOME': '/home/cltbld', 01:53:55 INFO - 'LANG': 'en_US.UTF-8', 01:53:55 INFO - 'LANGUAGE': 'en_US:en', 01:53:55 INFO - 'LOGNAME': 'cltbld', 01:53:55 INFO - 'MAIL': '/var/mail/cltbld', 01:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:55 INFO - 'MOZ_NO_REMOTE': '1', 01:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:55 INFO - 'NO_EM_RESTART': '1', 01:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:53:55 INFO - 'PWD': '/builds/slave/test-pgo', 01:53:55 INFO - 'SHELL': '/bin/bash', 01:53:55 INFO - 'SHLVL': '1', 01:53:55 INFO - 'TERM': 'linux', 01:53:55 INFO - 'TMOUT': '86400', 01:53:55 INFO - 'USER': 'cltbld', 01:53:55 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', 01:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:55 INFO - '_': '/tools/buildbot/bin/python'} 01:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:53:55 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 01:53:55 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 01:53:55 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 01:53:55 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 01:53:55 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 01:53:55 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 01:53:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:53:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:53:57 INFO - Installing collected packages: mozsystemmonitor 01:53:57 INFO - Running setup.py install for mozsystemmonitor 01:53:57 INFO - Successfully installed mozsystemmonitor 01:53:57 INFO - Cleaning up... 01:53:57 INFO - Return code: 0 01:53:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:53: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')]} 01:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53: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')]} 01:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:53:57 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 0x7f83f379df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8c0>, '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 0x24fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fbc50>, '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': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', '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 01:53:57 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 01:53:57 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 01:53:57 INFO - Using env: {'DISPLAY': ':0', 01:53:57 INFO - 'HOME': '/home/cltbld', 01:53:57 INFO - 'LANG': 'en_US.UTF-8', 01:53:57 INFO - 'LANGUAGE': 'en_US:en', 01:53:57 INFO - 'LOGNAME': 'cltbld', 01:53:57 INFO - 'MAIL': '/var/mail/cltbld', 01:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:57 INFO - 'MOZ_NO_REMOTE': '1', 01:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:57 INFO - 'NO_EM_RESTART': '1', 01:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:53:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:53:57 INFO - 'SHELL': '/bin/bash', 01:53:57 INFO - 'SHLVL': '1', 01:53:57 INFO - 'TERM': 'linux', 01:53:57 INFO - 'TMOUT': '86400', 01:53:57 INFO - 'USER': 'cltbld', 01:53:57 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', 01:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:57 INFO - '_': '/tools/buildbot/bin/python'} 01:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:53:57 INFO - Downloading/unpacking blobuploader==1.2.4 01:53:57 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 01:53:57 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 01:53:57 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 01:53:57 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 01:53:57 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 01:53:57 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 01:53:59 INFO - Downloading blobuploader-1.2.4.tar.gz 01:53:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:53:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:53:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:54:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:54:00 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 01:54:00 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 01:54:00 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 01:54:00 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 01:54:00 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 01:54:00 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 01:54:00 INFO - Downloading docopt-0.6.1.tar.gz 01:54:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:54:00 INFO - Installing collected packages: blobuploader, requests, docopt 01:54:00 INFO - Running setup.py install for blobuploader 01:54:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:54:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:54:00 INFO - Running setup.py install for requests 01:54:00 INFO - Running setup.py install for docopt 01:54:00 INFO - Successfully installed blobuploader requests docopt 01:54:00 INFO - Cleaning up... 01:54:00 INFO - Return code: 0 01:54:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:54:00 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')]} 01:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:00 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')]} 01:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:00 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 0x7f83f379df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8c0>, '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 0x24fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fbc50>, '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': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', '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 01:54:00 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 01:54:00 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 01:54:00 INFO - Using env: {'DISPLAY': ':0', 01:54:00 INFO - 'HOME': '/home/cltbld', 01:54:00 INFO - 'LANG': 'en_US.UTF-8', 01:54:00 INFO - 'LANGUAGE': 'en_US:en', 01:54:00 INFO - 'LOGNAME': 'cltbld', 01:54:00 INFO - 'MAIL': '/var/mail/cltbld', 01:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:00 INFO - 'MOZ_NO_REMOTE': '1', 01:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:00 INFO - 'NO_EM_RESTART': '1', 01:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:00 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:00 INFO - 'SHELL': '/bin/bash', 01:54:00 INFO - 'SHLVL': '1', 01:54:00 INFO - 'TERM': 'linux', 01:54:00 INFO - 'TMOUT': '86400', 01:54:00 INFO - 'USER': 'cltbld', 01:54:00 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', 01:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:00 INFO - '_': '/tools/buildbot/bin/python'} 01:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:54:01 INFO - Running setup.py (path:/tmp/pip-nCCOtt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:54:01 INFO - Running setup.py (path:/tmp/pip-lwmxda-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:54:01 INFO - Running setup.py (path:/tmp/pip-_KrvEl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:54:01 INFO - Running setup.py (path:/tmp/pip-YPyka6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:54:01 INFO - Running setup.py (path:/tmp/pip-wfL8Yn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:54:01 INFO - Running setup.py (path:/tmp/pip-2uRq2s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:54:01 INFO - Running setup.py (path:/tmp/pip-N_Di5s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:54:01 INFO - Running setup.py (path:/tmp/pip-HWXzIl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:54:01 INFO - Running setup.py (path:/tmp/pip-LnwW4V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:54:01 INFO - Running setup.py (path:/tmp/pip-HF1mbM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:54:01 INFO - Running setup.py (path:/tmp/pip-chvxbo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:54:01 INFO - Running setup.py (path:/tmp/pip-MxzQfL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:54:01 INFO - Running setup.py (path:/tmp/pip-HzQxeU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:54:02 INFO - Running setup.py (path:/tmp/pip-hBpJnA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:54:02 INFO - Running setup.py (path:/tmp/pip-2WLiRm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:54:02 INFO - Running setup.py (path:/tmp/pip-nHc0mT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:54:02 INFO - Running setup.py (path:/tmp/pip-4i7FSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:54:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:54:02 INFO - Running setup.py install for manifestparser 01:54:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:54:02 INFO - Running setup.py install for mozcrash 01:54:02 INFO - Running setup.py install for mozdebug 01:54:02 INFO - Running setup.py install for mozdevice 01:54:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:54:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:54:02 INFO - Running setup.py install for mozfile 01:54:02 INFO - Running setup.py install for mozhttpd 01:54:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:54:02 INFO - Running setup.py install for mozinfo 01:54:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Running setup.py install for mozInstall 01:54:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Running setup.py install for mozleak 01:54:03 INFO - Running setup.py install for mozlog 01:54:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Running setup.py install for moznetwork 01:54:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Running setup.py install for mozprocess 01:54:03 INFO - Running setup.py install for mozprofile 01:54:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Running setup.py install for mozrunner 01:54:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:54:03 INFO - Running setup.py install for mozscreenshot 01:54:03 INFO - Running setup.py install for moztest 01:54:03 INFO - Running setup.py install for mozversion 01:54:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:54:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:54:04 INFO - Cleaning up... 01:54:04 INFO - Return code: 0 01:54:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:54: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')]} 01:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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')]} 01:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:04 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 0x7f83f379df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8c0>, '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 0x24fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fbc50>, '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': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', '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 01:54:04 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 01:54:04 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 01:54:04 INFO - Using env: {'DISPLAY': ':0', 01:54:04 INFO - 'HOME': '/home/cltbld', 01:54:04 INFO - 'LANG': 'en_US.UTF-8', 01:54:04 INFO - 'LANGUAGE': 'en_US:en', 01:54:04 INFO - 'LOGNAME': 'cltbld', 01:54:04 INFO - 'MAIL': '/var/mail/cltbld', 01:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:04 INFO - 'MOZ_NO_REMOTE': '1', 01:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:04 INFO - 'NO_EM_RESTART': '1', 01:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:04 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:04 INFO - 'SHELL': '/bin/bash', 01:54:04 INFO - 'SHLVL': '1', 01:54:04 INFO - 'TERM': 'linux', 01:54:04 INFO - 'TMOUT': '86400', 01:54:04 INFO - 'USER': 'cltbld', 01:54:04 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', 01:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:04 INFO - '_': '/tools/buildbot/bin/python'} 01:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:54:04 INFO - Running setup.py (path:/tmp/pip-j6N4fG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:54:04 INFO - Running setup.py (path:/tmp/pip-SWocJF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:54:04 INFO - Running setup.py (path:/tmp/pip-vKuF6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:54:04 INFO - Running setup.py (path:/tmp/pip-7UZwU9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:54:04 INFO - Running setup.py (path:/tmp/pip-tVTgWf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:54:04 INFO - Running setup.py (path:/tmp/pip-Fo3INd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:54:04 INFO - Running setup.py (path:/tmp/pip-dYtGKQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:54:04 INFO - Running setup.py (path:/tmp/pip-BMzA7v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:54:04 INFO - Running setup.py (path:/tmp/pip-g6QXYH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:54:04 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)) 01:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:54:04 INFO - Running setup.py (path:/tmp/pip-ecjhNs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:54:05 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)) 01:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:54:05 INFO - Running setup.py (path:/tmp/pip-5yct8O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:54:05 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)) 01:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:54:05 INFO - Running setup.py (path:/tmp/pip-o2RCcU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:54:05 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)) 01:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:54:05 INFO - Running setup.py (path:/tmp/pip-_uraO6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:54:05 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)) 01:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:54:05 INFO - Running setup.py (path:/tmp/pip-1Kl7sq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:54:05 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)) 01:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:54:05 INFO - Running setup.py (path:/tmp/pip-hk1Kb9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:54:05 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)) 01:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:54:05 INFO - Running setup.py (path:/tmp/pip-HTotIu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:54:05 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)) 01:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:54:05 INFO - Running setup.py (path:/tmp/pip-oaskYw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:54:05 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)) 01:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:54:05 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)) 01:54:05 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)) 01:54:05 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)) 01:54:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:54:05 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 01:54:05 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 01:54:05 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 01:54:05 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 01:54:05 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 01:54:05 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 01:54:07 INFO - Downloading blessings-1.6.tar.gz 01:54:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:54:07 INFO - Installing collected packages: blessings 01:54:07 INFO - Running setup.py install for blessings 01:54:07 INFO - Successfully installed blessings 01:54:07 INFO - Cleaning up... 01:54:07 INFO - Return code: 0 01:54:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:54:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:54:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:54:07 INFO - Reading from file tmpfile_stdout 01:54:07 INFO - Current package versions: 01:54:07 INFO - argparse == 1.2.1 01:54:07 INFO - blessings == 1.6 01:54:07 INFO - blobuploader == 1.2.4 01:54:07 INFO - docopt == 0.6.1 01:54:07 INFO - manifestparser == 1.1 01:54:07 INFO - mozInstall == 1.12 01:54:07 INFO - mozcrash == 0.16 01:54:07 INFO - mozdebug == 0.1 01:54:07 INFO - mozdevice == 0.48 01:54:07 INFO - mozfile == 1.2 01:54:07 INFO - mozhttpd == 0.7 01:54:07 INFO - mozinfo == 0.9 01:54:07 INFO - mozleak == 0.1 01:54:07 INFO - mozlog == 3.1 01:54:07 INFO - moznetwork == 0.27 01:54:07 INFO - mozprocess == 0.22 01:54:07 INFO - mozprofile == 0.28 01:54:07 INFO - mozrunner == 6.11 01:54:07 INFO - mozscreenshot == 0.1 01:54:07 INFO - mozsystemmonitor == 0.0 01:54:07 INFO - moztest == 0.7 01:54:07 INFO - mozversion == 1.4 01:54:07 INFO - psutil == 3.1.1 01:54:07 INFO - requests == 1.2.3 01:54:07 INFO - wsgiref == 0.1.2 01:54:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:07 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 0x7f83f379df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8c0>, '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 0x24fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fbc50>, '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': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', '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 01:54:07 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 01:54:07 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 01:54:07 INFO - Using env: {'DISPLAY': ':0', 01:54:07 INFO - 'HOME': '/home/cltbld', 01:54:07 INFO - 'LANG': 'en_US.UTF-8', 01:54:07 INFO - 'LANGUAGE': 'en_US:en', 01:54:07 INFO - 'LOGNAME': 'cltbld', 01:54:07 INFO - 'MAIL': '/var/mail/cltbld', 01:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:07 INFO - 'MOZ_NO_REMOTE': '1', 01:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:07 INFO - 'NO_EM_RESTART': '1', 01:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:07 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:07 INFO - 'SHELL': '/bin/bash', 01:54:07 INFO - 'SHLVL': '1', 01:54:07 INFO - 'TERM': 'linux', 01:54:07 INFO - 'TMOUT': '86400', 01:54:07 INFO - 'USER': 'cltbld', 01:54:07 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', 01:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:07 INFO - '_': '/tools/buildbot/bin/python'} 01:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:08 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)) 01:54:08 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)) 01:54:08 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)) 01:54:08 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)) 01:54:08 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)) 01:54:08 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)) 01:54:08 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)) 01:54:08 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)) 01:54:08 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)) 01:54:08 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)) 01:54:08 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)) 01:54:08 INFO - Cleaning up... 01:54:08 INFO - Return code: 0 01:54:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:54:08 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')]} 01:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:08 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')]} 01:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54:08 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 0x7f83f379df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8c0>, '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 0x24fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fbc50>, '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': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', '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 01:54:08 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 01:54:08 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 01:54:08 INFO - Using env: {'DISPLAY': ':0', 01:54:08 INFO - 'HOME': '/home/cltbld', 01:54:08 INFO - 'LANG': 'en_US.UTF-8', 01:54:08 INFO - 'LANGUAGE': 'en_US:en', 01:54:08 INFO - 'LOGNAME': 'cltbld', 01:54:08 INFO - 'MAIL': '/var/mail/cltbld', 01:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:08 INFO - 'MOZ_NO_REMOTE': '1', 01:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:08 INFO - 'NO_EM_RESTART': '1', 01:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:08 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:08 INFO - 'SHELL': '/bin/bash', 01:54:08 INFO - 'SHLVL': '1', 01:54:08 INFO - 'TERM': 'linux', 01:54:08 INFO - 'TMOUT': '86400', 01:54:08 INFO - 'USER': 'cltbld', 01:54:08 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', 01:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:08 INFO - '_': '/tools/buildbot/bin/python'} 01:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:08 INFO - Downloading/unpacking jsonschema 01:54:08 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 01:54:08 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 01:54:08 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 01:54:08 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 01:54:08 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 01:54:08 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 01:54:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:54:10 INFO - Downloading/unpacking functools32 (from jsonschema) 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:10 INFO - Downloading functools32-3.2.3-2.tar.gz 01:54:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:54:10 INFO - warning: no files found matching '*.txt' 01:54:10 INFO - no previously-included directories found matching 'build' 01:54:10 INFO - no previously-included directories found matching 'dist' 01:54:10 INFO - no previously-included directories found matching '.git*' 01:54:10 INFO - Installing collected packages: jsonschema, functools32 01:54:10 INFO - Running setup.py install for functools32 01:54:10 INFO - warning: no files found matching '*.txt' 01:54:10 INFO - no previously-included directories found matching 'build' 01:54:10 INFO - no previously-included directories found matching 'dist' 01:54:10 INFO - no previously-included directories found matching '.git*' 01:54:10 INFO - Successfully installed jsonschema functools32 01:54:10 INFO - Cleaning up... 01:54:10 INFO - Return code: 0 01:54:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:54: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')]} 01:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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')]} 01:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:54: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83f379df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fa8c0>, '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 0x24fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fbc50>, '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': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', '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 01:54: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', 'flake8'] in /builds/slave/test-pgo/build 01:54: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 flake8 01:54:10 INFO - Using env: {'DISPLAY': ':0', 01:54:10 INFO - 'HOME': '/home/cltbld', 01:54:10 INFO - 'LANG': 'en_US.UTF-8', 01:54:10 INFO - 'LANGUAGE': 'en_US:en', 01:54:10 INFO - 'LOGNAME': 'cltbld', 01:54:10 INFO - 'MAIL': '/var/mail/cltbld', 01:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:10 INFO - 'MOZ_NO_REMOTE': '1', 01:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:10 INFO - 'NO_EM_RESTART': '1', 01:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:10 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:10 INFO - 'SHELL': '/bin/bash', 01:54:10 INFO - 'SHLVL': '1', 01:54:10 INFO - 'TERM': 'linux', 01:54:10 INFO - 'TMOUT': '86400', 01:54:10 INFO - 'USER': 'cltbld', 01:54:10 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', 01:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:10 INFO - '_': '/tools/buildbot/bin/python'} 01:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:54:10 INFO - Downloading/unpacking flake8 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:54:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:54:12 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 01:54:12 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 01:54:12 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 01:54:12 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 01:54:12 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 01:54:12 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 01:54:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:54:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:54:12 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 01:54:12 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 01:54:12 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 01:54:12 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 01:54:12 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 01:54:12 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 01:54:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54: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 01:54:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:54:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:54:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:54:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:54:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:54:13 INFO - no previously-included directories found matching 'docs/_build' 01:54:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:54:13 INFO - Running setup.py install for pep8 01:54:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:54:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:54:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:54:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:54:13 INFO - no previously-included directories found matching 'docs/_build' 01:54:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:54:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:54:13 INFO - Cleaning up... 01:54:13 INFO - Return code: 0 01:54:13 INFO - Running post-action listener: _resource_record_post_action 01:54:13 INFO - Running post-action listener: _start_resource_monitoring 01:54:13 INFO - Starting resource monitoring. 01:54:13 INFO - ##### 01:54:13 INFO - ##### Running install step. 01:54:13 INFO - ##### 01:54:13 INFO - Running pre-action listener: _resource_record_pre_action 01:54:13 INFO - Running main action method: install 01:54:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:54:13 INFO - Reading from file tmpfile_stdout 01:54:13 INFO - Detecting whether we're running mozinstall >=1.0... 01:54:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:54:13 INFO - Reading from file tmpfile_stdout 01:54:13 INFO - Output received: 01:54:13 INFO - Usage: mozinstall [options] installer 01:54:13 INFO - Options: 01:54:13 INFO - -h, --help show this help message and exit 01:54:13 INFO - -d DEST, --destination=DEST 01:54:13 INFO - Directory to install application into. [default: 01:54:13 INFO - "/builds/slave/test-pgo"] 01:54:13 INFO - --app=APP Application being installed. [default: firefox] 01:54:13 INFO - mkdir: /builds/slave/test-pgo/build/application 01:54:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 01:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 01:54:30 INFO - Reading from file tmpfile_stdout 01:54:30 INFO - Output received: 01:54:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:54:30 INFO - Running post-action listener: _resource_record_post_action 01:54:30 INFO - ##### 01:54:30 INFO - ##### Running run-tests step. 01:54:30 INFO - ##### 01:54:30 INFO - Running pre-action listener: _resource_record_pre_action 01:54:30 INFO - Running main action method: run_tests 01:54:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:54:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:54:30 INFO - Python 2.7.3 01:54:30 INFO - Return code: 0 01:54:30 INFO - grabbing minidump binary from tooltool 01:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:30 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 0x24fa8c0>, '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 0x24fb7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fbc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:54:30 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 01:54:30 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 01:54:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:54:30 INFO - Return code: 0 01:54:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:54:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:54:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:54:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:54:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:54:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:54:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:54:31 INFO - Return code: 0 01:54:31 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/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 01:54:31 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/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 01:54:31 INFO - Using env: {'DISPLAY': ':0', 01:54:31 INFO - 'HOME': '/home/cltbld', 01:54:31 INFO - 'LANG': 'en_US.UTF-8', 01:54:31 INFO - 'LANGUAGE': 'en_US:en', 01:54:31 INFO - 'LOGNAME': 'cltbld', 01:54:31 INFO - 'MAIL': '/var/mail/cltbld', 01:54:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:54:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:54:31 INFO - 'MOZ_NO_REMOTE': '1', 01:54:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:54:31 INFO - 'NO_EM_RESTART': '1', 01:54:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:54:31 INFO - 'PWD': '/builds/slave/test-pgo', 01:54:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:54:31 INFO - 'SHELL': '/bin/bash', 01:54:31 INFO - 'SHLVL': '1', 01:54:31 INFO - 'TERM': 'linux', 01:54:31 INFO - 'TMOUT': '86400', 01:54:31 INFO - 'USER': 'cltbld', 01:54:31 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186', 01:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:54:31 INFO - '_': '/tools/buildbot/bin/python'} 01:54:31 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/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 01:54:31 INFO - mozversion application_buildid: 20160222083110 01:54:31 INFO - mozversion application_changeset: 135340a254f4b16c86b0c7dd320253c4a1a0776e 01:54:31 INFO - mozversion application_display_name: Nightly 01:54:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:54:31 INFO - mozversion application_name: Firefox 01:54:31 INFO - mozversion application_remotingname: firefox 01:54:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:54:31 INFO - mozversion application_vendor: Mozilla 01:54:31 INFO - mozversion application_version: 47.0a1 01:54:31 INFO - mozversion platform_buildid: 20160222083110 01:54:31 INFO - mozversion platform_changeset: 135340a254f4b16c86b0c7dd320253c4a1a0776e 01:54:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:54:31 INFO - mozversion platform_version: 47.0a1 01:54:31 INFO - using testdate: 1456221271 01:54:31 INFO - actual date: 1456221271 01:54:31 INFO - starting webserver on 'localhost:55657' 01:54:31 INFO - SUITE-START | Running 2 tests 01:54:31 INFO - TEST-START | dromaeo_css 01:54:31 INFO - operating with platform_type : linux_ 01:54:31 INFO - Initialising browser for dromaeo_css test... 01:54:31 INFO - TEST-INFO | started process 18275 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1pDwMc/profile http://localhost:55657/getInfo.html) 01:54:35 INFO - PROCESS | 18275 | __metrics Screen width/height:1600/1200 01:54:35 INFO - PROCESS | 18275 | colorDepth:24 01:54:35 INFO - PROCESS | 18275 | Browser inner width/height: 1024/697 01:54:35 INFO - PROCESS | 18275 | __metrics 01:54:36 INFO - PROCESS | 18275 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:54:36 INFO - PROCESS | 18275 | 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. 01:54:36 INFO - TEST-INFO | 18275: exit 0 01:54:36 INFO - Browser initialized. 01:54:36 INFO - Running cycle 1/1 for dromaeo_css test... 01:54:36 INFO - TEST-INFO | started process 18369 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1pDwMc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:54:48 INFO - PROCESS | 18369 | RSS: Main: 147415040 01:54:48 INFO - PROCESS | 18369 | 01:55:40 INFO - PROCESS | 18369 | 1456221340236 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:57:48 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:55657/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55657/tests/dromaeo/cssquery-ext.html) 01:57:49 INFO - PROCESS | 18369 | RSS: Main: 211255296 01:57:49 INFO - PROCESS | 18369 | 02:00:51 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:55657/tests/dromaeo/cssquery-ext.html (next: http://localhost:55657/tests/dromaeo/cssquery-jquery.html) 02:00:51 INFO - PROCESS | 18369 | RSS: Main: 236388352 02:00:51 INFO - PROCESS | 18369 | 02:03:53 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:55657/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55657/tests/dromaeo/cssquery-mootools.html) 02:03:54 INFO - PROCESS | 18369 | RSS: Main: 241905664 02:03:54 INFO - PROCESS | 18369 | 02:06:56 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:55657/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55657/tests/dromaeo/cssquery-prototype.html) 02:06:56 INFO - PROCESS | 18369 | RSS: Main: 210571264 02:06:56 INFO - PROCESS | 18369 | 02:09:59 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:55657/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55657/tests/dromaeo/cssquery-yui.html) 02:09:59 INFO - PROCESS | 18369 | RSS: Main: 185946112 02:09:59 INFO - PROCESS | 18369 | 02:13:02 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:55657/tests/dromaeo/cssquery-yui.html (next: http://localhost:55657/tests/dromaeo/cssquery-dojo.html) 02:13:02 INFO - PROCESS | 18369 | RSS: Main: 281604096 02:13:02 INFO - PROCESS | 18369 | 02:13:02 INFO - PROCESS | 18369 | __start_tp_report 02:13:02 INFO - PROCESS | 18369 | _x_x_mozilla_page_load 02:13:02 INFO - PROCESS | 18369 | _x_x_mozilla_page_load_details 02:13:02 INFO - PROCESS | 18369 | |i|pagename|runs| 02:13:02 INFO - PROCESS | 18369 | |0;dojo.html;3103.7982531135476;3140.0736782649115;3172.9524057139147;3179.888703895364;3206.182423482012;5082.796688132475;5089.592832573395;5127.3078134451835;5136.1268584340705;5156.355455568054;5107.846764597068;5148.5623721983675;5154.793808247666;5160.354955630546;5262.368515778103;4618.099470603233;4673.135469938064;4735.124002059612;4763.833265835697;4883.243097319903;4646.53534646536;4724.858254252378;4797.544233297848;4809.014152098812;4894.681845680019;4781.904361912742;4797.184478638623;4800.1119792838435;4816.109019831325;4822.68652537584;4784.30627559002;4784.976075119602;4796.136695394827;4814.10938976287;4831.130396528623;4665.2535594304745;4753.809847606091;4791.808327666889;4805.879853003668;4833.830815921426;4963.305137280783;4982.900341993176;4994.175960966436;5006.599472042264;5055.292259083694;5476.945230547723;5554.86112847178;5559.166125081229;5564.33228012637;5565.777368905239;5593.496585307342;5605.775768969236;5636.182753500761;5640;5690.715464226813;5196.870078248036;5305.708186049766;5306.204069389584;5311.548518375904;5313.8405847825015;5579.4420557944695;5665.263515742927;5730.054541000772;5748.48263656273;5773.451522105393;5531.751071201725;5544.500994910478;5546.889062218814;5558.527525160326;5561.721913904369;5597.608167428322;5599.916001259984;5606;5608.130739735348;5615.831525054255;5416.647917885325;5466.753996070186;5479.589030822704;5527.032769265363;5568.192612071227;5473.972630136824;5481.177823326533;5487.6981766003255;5490.533304669148;5502.147167189092;4241.1941731071;4294.227039132924;4302.182585308781;4302.311630139163;4342.261815491374;3920.4511368408444;3929.8821035368983;3936.252112098692;3937.6062393760394;3951;5183.81856635016;5218.112920803473;5257.868553286198;5260.263563101169;5314.1497360422145;5420.593455490854;5562.276904002454;5597.244372009726;5606.327240731139;5630.690312032795;5218.843434696965;5226.503482169188;5235.476452354734;5242.449542798027;5250;4678.906421871544;4786.904261914742;4822.590079843252;4823.252395878644;4850.563449289511;5745.712714364265;5746.051901436216;5760.049591817387;5796.217510636095;5823.941760582425;5542.0855558832345;5592.748326325406;5602.52378547828;5610.242617246619;5617.157426386075;5690.544756419559;5713.800016999385;5778.046622307273;5843.211166492469;5855.443732845373;5424.538914192338;5440.591955603267;5448.618596698193;5452.400235974119;5468.0977638690765;5505.9174112387545;5509.559235261089;5510.1459273812625;5522.641028333145;5558.972205138948;5257.0537303284245;5395.487428694268;5403.324584426947;5436.6194366393975;5478.424765399575;5336.199570064521;5371.194320851903;5372.838814835562;5373.811916582901;5379.462053794589;5231.398389185292;5261.342332208474;5282.418933917343;5300.469953004668;5339.519443250126;5391.05656510117;5429.592780541396;5432.483914028161;5461.317335333083;5499.752511137089;5226.8954620908125;5298.576113910955;5379.704116273486;5393.865153371197;5429.5656347492895 02:13:02 INFO - PROCESS | 18369 | |1;ext.html;523.037610796135;555.7554675942584;557.0418879527211;601.9097135429685;603.8007457539011;35274.823625881865;35965;35976.82011589938;35981.64018359816;36053.81973090134;40175.19649607014;41017.58982410175;41150.38274425886;41243.79378103113;41381.58618413815;8496.2778163856;8742.86885696715;8765.649374025063;8771.16673915977;8774.473531588093;8446.155384461566;8563.058063612998;8570.357223208253;8571.657133714674;8579.828403431928;8571.314294856396;8612.827743445127;8622.267107295887;8642.178992995656;8647.437916535406;8517.276031537327;8558.18697223769;8567.400281980295;8574.828503429928;8579.742607721779;8585.656573737044;8627.65489380424;8677.869831952527;8703.390762646617;8708.825823483558;37297.440538391944;37776.62223377786;37800.62199377998;37803.4329485058;37828.621713782784;2384.5350156719446;3406.369821583015;3551.200979779555;3967.504061992251;4117.423560701504;26880.193594192206;27206;27471.725282747117;27489.31276718078;27524.724752752416;3744.4383342498572;3752.5121734174654;3755.286495565834;3803.9239215215816;3910.432987216866;179116;179986;180222;180972;228437;56316;57423;57437.42562574404;57537.13694294589;57547.71226143843;61004;61166.69416652977;61292.69353653203;61293.69353153206;61331.38668613346;16589.50231493057;16826.83173168277;16841.578960526083;16845.41041063557;16868.24092915822;12563.685907852378;12610.936945315214;12611.30637814929;12626.936865315614;12628.684282893002;18849.251557809985;20372.185112595627;20553;20563.588728225353;20663;6568.540202185801;7709.267619576131;7719.768406947801;7790.727324543614;7984.800379990431;1033.3748082410184;1042.7705904700954;1052.6210564196883;1077.0831155773867;1097.9843644628686;29149;29873.16488564857;30225;30280.5457918127;30574.38851222963;1072.104792498257;1121.4224674292745;1163.2380790582183;1165.1610840195046;1249.450241893564;15597.454089106826;15597.922010389875;15829.604259893595;15973.840261597468;16013.439529616408;360643;360838;362514;364101;365107;48821;49636.25545616819;55354.446455534926;56026.71986640041;56499.15251271152;1343.650650830791;1344.892408607309;1347.8989075819352;1359.286374653295;1360.3334366160707;24681.382965426008;27114.1865744028;29293.414131717673;30019.249518762204;30066;39804.60195398009;44388.89027774332;50229.246561300875;50239.497605024946;50293;223355;223395;225006;226054;226245;41610.375844361755;42086.36870446885;42336;42464.78767606142;42637.786811065744;30277.697223027488;46151;46351.3047304284;46406.303905442124;47030;36577.268454630226;37499.25001500009;38209.235815282984;38247.6175238244;38481.23037539177;36531.63468365389;37010.8149459251;37130.44304335383;37501;37590.248195036496;36977.630223697415;37213.44179837251;37308.06729831776;38210.2357952845;39381.606183937794;31918.52122218215;33155.668443315255;33318;33555.57205434741;34027.48958765571;24539.38651533726;24851.502969940862;24947.126850560144;25334.746652533977;25401.237962861145 02:13:02 INFO - PROCESS | 18369 | |2;jquery.html;355.9145805006799;367.32779014403627;368.43261377478683;368.64794121613863;374.33742276171193;13931.651708707263;16460.024797024358;16956.74564881528;16975.74536381955;18453.16960736767;16338.754918676199;16354;16636.83363166368;16670.58323541912;16680.58298542537;5305.098133317336;5497.862553436156;5498.285222921015;5526.447355264461;5553.139263414157;4034.919301613966;5170.146925757245;5808.186853840466;6000.969995150018;6010.038393856984;5947.762089516415;5953.1070339449;5955.464008239258;5963.791267305645;5991.340952495222;5020.196768517038;5194.168932970744;5194.896102077975;5195.506426889458;5946.108083787445;4927.211646136601;4962.578180854632;4972.726500042496;4983.9252411213865;4986;12220.388980550937;12483.625491235278;12545.247285162919;12568.622941311774;12587.811182832265;1822.82683145101;2151.8924053797405;2288.6567014947723;2711.267957651423;2789.246903336108;9042.140996605312;9294.676330917271;9381.5309234538;11047.889521104766;12386.75226495465;1764.4794785538297;1823.0520129532702;1828.9176987035614;1883.274939148424;1904.0384605774134;60185.6990715048;63929.68035159841;65720;66942;67104.66447667731;15017.24913754308;15544.300506477235;15553.30010149546;15570.766438503431;15721.135337556316;24430.389240269134;24494;24674.13640522573;24680.382990425023;24710.752892471206;9056.683016094405;9101.681441149529;9139.223166030828;9448.811023779486;9626.181774549243;7905.921229433937;7920.5247685139075;7951.721689740947;8259.050209226016;8385.790355241168;7863.33161681252;8027.07688615805;8076.313513351313;8081.797955051054;8088.191180881982;2674.211107723226;2927.3852490977133;2953.291210109558;3005.413944280844;3045.421369939704;883.6597909804643;945.6217512994857;975.1467465967279;988.6342053440274;1002.8997100290059;15437.536873893801;15812.92093539525;15866.365345386055;16370.345186192419;16433.91783041077;948.3835506920557;972.1260775808398;972.9978122533802;977.4819345746765;1008.4755926917961;7111.679974401164;8047.597620118971;9535.618575256913;9719;10030.598776048877;401309;407329;407968;409664;410325;71849.28150718531;72017.27982720106;73333;74101.25898740944;74697.62651186818;924.6440120553501;926.4765407544716;1081.70793885652;1089.199438412766;1097.6158344579333;14645.194514301389;14857.702845942804;14908;15242.695146096794;15897.52307430779;31626.683733163296;32118.518222227154;32236.19409514781;32317.838410807795;32712.83643581767;39595.406068908414;42576.1484770309;43835.780821095694;44348.11303773842;44471.55528444803;7950.562719050507;8020.117787043304;8132.30875375576;8145.755627331189;8247.793805154919;11914.761704765682;12419.130660853654;12521.123521353782;12716.237025778482;13402.32988350559;10371.533281002223;10548.84176737365;10600.363978161335;10686.25196236256;10694.679159625224;10680.038796508352;10719;10766.676999690022;10844.783104338027;11648.242864213798;9966.302358834811;10656.307340022873;10688.625898093529;10945.507452164513;11030.448477575928;7999.120096789232;8016.519008859487;8124.309433698202;8124.39067069984;8271.875921861056;8371.455855369382;10613.310134841211;10682.83975740349;10689.786204276026;10761.085307748928 02:13:02 INFO - PROCESS | 18369 | |3;mootools.html;1377.6418131285864;1496.97754533682;1497.101738956626;1687.9071651059187;1836.1645451319644;7473.476856620032;7625.084989801225;7676.232376762321;7678.308952194295;7684.654190561424;7612.77161685149;7766.728164514243;7787.532748035122;7788.766337009884;7789.532628042321;1957.07039156401;2257.6726374675663;2301.355620426275;2321.3384185507134;2331.3821837213154;2286.8399212055165;2312.7455979842202;2321.0947730385165;2321.7097862767155;2324.174917904145;2301.746807851135;2306.850054746436;2307.7346105197867;2309.1225334372916;2310.295359915225;2166.274298110135;2283.6574513822893;2284.6344584866424;2284.862908225512;2287.336672365012;2264.1283106004144;2276.2374604507345;2277.214361045437;2283.2807665585287;2287.782660647236;7682.423818213656;7693.653785579662;7737.57443340616;7742.380609551279;7807.726729564438;4736.550027747358;4834.274858771178;4837.419509658828;4845.63657725672;4857.368542089541;3004.2939909121337;3024.8790048398037;3062.770292228092;3066.953995690066;3100.5659207710937;924.912133347331;927.4852456886425;952.6665667016558;979.1579241852002;979.4172467381896;10972.122230221643;10999.065079468255;11011.28426652265;11017.44912754359;11029.062529684987;4267.466566679165;4353.10761293934;4366.868993930188;4399.010222699931;4424.601785839225;9490.762730931643;9547;9553.570089345996;9566.282528810367;9569.712908612753;4335.82656693735;4654.115718013567;4840.927386089212;4843.612510999112;4888.804447822118;4260.297050986553;4272.359146128106;4294.205571969195;4312.633426158749;4336.566343365701;3706.9073273167846;3720.6465385788306;3729.6270372962485;3766;3779.433085037266;1114.9498272577753;1122.410734364449;1127.9436028198556;1128.966131016071;1169.0121847039238;1292.8965682745359;1309.607117864656;1328.4420543371807;1329.8936085113169;1357.6673714939902;7168;7296.233895441009;7297.744578939712;7300.342969132804;7301.306375894282;422.2167878585242;429.6906227516183;433.6725772042088;434.38751360581426;440.2515723270389;5469.644473109235;5490.588205884575;5491.066518691832;5528.143137813645;5531.944680553143;9388.389754665925;9501.667441639509;9698.175655069257;9709.611615535441;9784.364016338915;9586.520673966274;9614.471204083842;9646.565904534313;9677.806443871083;9692.612295508241;7306.305900939402;7465.104187497426;7476.476646634792;7562.546247225184;7599.164091949881;7142.464315176278;7193.784186474414;7200.819979500555;7213.963930180315;7251.41988640918;8388.748337549883;8397.832043359222;8672.696455624024;8707.998580163363;8835.646574136963;8622.82754344897;8749.387542871938;8776.297896168418;8951.597178126869;8957.328200385127;6009.819705408845;6647.634380109141;6817.522773405814;7059.258777828254;7113.324234197743;7275.490715649854;7279.381252593589;7287.599182044826;7316.451266155166;7318.451116166202;6637.734490620321;6758.324167583202;6765.864682706417;6845.520813543004;6907.551009184387;6597.835054123685;6633.568818026813;6818.318168183142;6878.7248510059035;6955.686994085379;6768.120144381199;6873.450123989969;6903.482238832007;6915.757948471779;6938.8612227756175;6253.343398943045;6256;6313.494920406265;6322.3045464997895;6326.3041065483685;6598.571092878948;6627.536072474881;6630.204375474974;6634.867302653824;6637.037629543785 02:13:02 INFO - PROCESS | 18369 | |4;prototype.html;310.6722407859707;329.8350824587706;329.8828915734914;331.31252650749684;334.29130243882986;5741.540676745861;5849.9707501462535;5857.326407463143;5898.734556944937;5904.734286957087;5814.418558144183;5831.387704291052;5842.152887831262;5866.530677545797;5874.471297583216;4552.840650577239;4553.726776393411;4560.452745670525;4564.9087018259615;4565.726056436608;4324.567543245682;4420.9336859947125;4501.482329532113;4507.368968344418;4564.97717511412;4437.866863994069;4451.777411129447;4451.910961780763;4460.732356058631;4474.217012022899;4501.437320334958;4510.864674059783;4514.142312960527;4520.208963431386;4520.367148599199;3972.980135099306;3977.960220397788;3980.1840622672285;3980.661643760284;3981.402789581586;5610.270664813548;5629.240052592889;5634.352049514277;5641.407652196543;5648.237487939116;5248.921266181011;5265.473452654742;5268.024490815944;5273.683578985235;5278.788848446057;5959.553033522503;6257.124002639634;6260.217472815898;6295.779647712308;6300.369963003709;4283.828646854122;4288.463942007249;4289.420928174688;4290.163418133465;4292.270314046619;6311.116443697886;6409.4231519163495;6496.740130394778;6500.382463665944;6521.054447105191;4353.6299414549485;4370;4370.125974805052;4381.211381951216;4382.2112019836095;4415.845445409395;4426.468823741172;4427.712198707074;4438.289873620205;4439.822407103744;5158.303629010111;5168.793248270103;5173.172292433268;5181.067407866545;5181.5595674368105;6008.459238668541;6161.5994960328335;6316.684165791692;6327;6329.715162817684;1539.7844301797757;1549.1324858079286;1556.0274828232355;1556.0352581399604;1557.369265447473;968.7674958010027;969.680005598151;978.3200675530438;990.1039559198937;997.8203923293877;5861.472467477947;5874.412558744091;5876.823695289148;5877.265341832271;5887.8233652990475;6336.904946425807;6348.396902294275;6351.745930162834;6356.269029061717;6357;5847.649141051465;5847.883042339129;5849.736761845727;5851.444112809277;5857.062869940789;3441.7934923904145;3474.6872781449792;3475.6176820549717;3478.0087675013006;3478.5477887874413;6601.966990165019;6692.196936367667;6716.093327400738;6807.931920680829;6818.113645226188;6631.602103873783;6649.069130321759;6666.100076489709;6717.731290748316;6727.125473688389;6751.223609284995;6784.660766961632;6792.117024786746;6793;6793.490488213305;6438.452731517874;6471.838204044937;6484.383983521558;6485.513586481127;6488.935110648833;6273.15312432834;6433.678316084271;6437.7103030362805;6452.161219041494;6455.0317452382515;6788.151481064867;6833.965830170818;6856.931430685829;6864.622445765531;6873.759418420332;4353.085851971122;4388.319810429389;4392.868213953587;4392.934105988476;4393.011572396185;6226;6324.335944725922;6527.445167160845;6566.409023187936;6567.44176744982;6274.403931626488;6313.589616674902;6328.778492752732;6334.081558173947;6337.176167098248;6265.906011409741;6310;6311.779087731908;6317.5893566918;6326.810195694136;6203;6210.596311239755;6216.72024758896;6222.844428889314;6224.37756224374;6207.596506227081;6326.367363263821;6351.777687780906;6364.490840732823;6370.554061215856;6164.630122192682;6186;6193.81418557444;6208.410201030895;6211.192544969125 02:13:02 INFO - PROCESS | 18369 | |5;yui.html;728.8578727148205;734.7942576078698;742.402366095293;789.0491957191584;834.9415540912139;13125.934370328147;13206.801897971538;13227.007974401935;13252.337383130842;13258;12330.691732706688;12425.56510522132;12429.254244745322;12438.067144964141;12441.502339906392;673.1921693967234;806.2219957740808;825.1171246765963;825.781167990483;826.8759686047081;825.9380546459009;835.4402550291319;835.6114406800837;837.5142417397894;844.7381311793333;713.7038129176385;870.7387783664907;877.4472082587961;877.4779006491127;879.3404946290283;711.7188710459366;859.1623167411786;867.9435836670659;870.0342619692136;870.0516437083546;638.594492497263;640.6892657061321;640.8013515810114;642.4314481683743;642.6080091144398;12814.23114613117;12826.55107071248;12861.935690321581;12881;12891.226526408445;12640.241585504898;12949.093563450562;12951.676208094874;12988.740225195443;13161;10496;10509.316894401916;10661.573537058508;10695.09091727204;10783.676489705322;3502.509648649191;3591.6408359164134;3627.9274414511824;3643.580988186366;3653.671169594723;48694.51305486935;48717.51282487165;48732.756336218095;48860.51139488631;48972.26541601879;9590.712278631652;9775.608975641037;9852;9891.35706179096;10027.699169024942;16803.831961680226;16893.493195204162;16902;16921.238544265536;16927.576810579834;7651.387888968869;7790.259925307087;7889.8816517752275;7901.130875603679;7978.880316795253;4320.719153255029;4340.001799586113;4359.564043595615;4362.541933097043;4408.118376324748;3171.20719820045;3188.952165717516;3196.9680303197138;3197;3198;513.8464147987717;545.8116949652364;582.5718097198555;601.2274227617578;611.7308384310888;590.6160995353055;591.4883625663856;616.1989413762092;662.456785435938;677.9288723816456;7751.92248077512;7894.368450523944;7949;8515.40392172542;8726.214640682369;544.0017567763199;601.6149664214906;610.502440510991;614.149403076733;615.3108518459264;3752.9061773455337;3802.8098595070137;3814.6948244140403;3835.4055121456217;3925.2542017016676;50238.24642630364;50350.49649503458;50494;50625.24062139071;53906.19140712892;42873.57126428758;42934;43455.56544434515;48341.516584834404;48526.514734852906;42221.788891055345;42292.78853605712;42786;43881.56118438839;44209.778951105036;7952.36381089523;8167.959160204161;8236.094029656613;8357.247847693738;8457.746267611981;32199.67800321967;32560.674393255766;33269;33620;33781.324373512885;36971.44542831806;37132.628673713996;40700;40761.184776303715;41263.793681031406;10440.582376704846;10602.8939710605;11041.723956901142;11093.611723589636;11130.721731956442;12062.75874482523;12276;12340.50637974471;12504.187227830162;12905.41925613331;10877.238593298393;11188.776224475629;11250.156238281998;11260.324380536866;11301.208915376174;11311.660650180507;11434.942825286153;11533.135014874086;11792.70518237051;12043.390314520064;10083.193344532567;10353.378797272188;10480.266381353233;10486.423246721199;10503.684889453329;9357.906420935704;9630.566624502055;9645.614175432904;9984.051515106054;10046.8492972604;8592.785180370542;8732.56337183151;8923.063078376677;9198.2181514572;9551.426914384881 02:13:02 INFO - PROCESS | 18369 | __end_tp_report 02:13:02 INFO - PROCESS | 18369 | __start_cc_report 02:13:02 INFO - PROCESS | 18369 | _x_x_mozilla_cycle_collect,762 02:13:02 INFO - PROCESS | 18369 | __end_cc_report 02:13:02 INFO - PROCESS | 18369 | __startTimestamp1456222382623__endTimestamp 02:13:02 INFO - PROCESS | 18369 | 02:13:02 INFO - PROCESS | 18369 | ------- Summary: start ------- 02:13:02 INFO - PROCESS | 18369 | Number of tests: 6 02:13:02 INFO - PROCESS | 18369 | 02:13:02 INFO - PROCESS | 18369 | [#0] dojo.html Cycles:165 Average:5170.94 Median:5336.20 stddev:552.55 (10.4%) stddev-sans-first:529.92 02:13:02 INFO - PROCESS | 18369 | Values: 3103.8 3140.1 3173.0 3179.9 3206.2 5082.8 5089.6 5127.3 5136.1 5156.4 5107.8 5148.6 5154.8 5160.4 5262.4 4618.1 4673.1 4735.1 4763.8 4883.2 4646.5 4724.9 4797.5 4809.0 4894.7 4781.9 4797.2 4800.1 4816.1 4822.7 4784.3 4785.0 4796.1 4814.1 4831.1 4665.3 4753.8 4791.8 4805.9 4833.8 4963.3 4982.9 4994.2 5006.6 5055.3 5476.9 5554.9 5559.2 5564.3 5565.8 5593.5 5605.8 5636.2 5640.0 5690.7 5196.9 5305.7 5306.2 5311.5 5313.8 5579.4 5665.3 5730.1 5748.5 5773.5 5531.8 5544.5 5546.9 5558.5 5561.7 5597.6 5599.9 5606.0 5608.1 5615.8 5416.6 5466.8 5479.6 5527.0 5568.2 5474.0 5481.2 5487.7 5490.5 5502.1 4241.2 4294.2 4302.2 4302.3 4342.3 3920.5 3929.9 3936.3 3937.6 3951.0 5183.8 5218.1 5257.9 5260.3 5314.1 5420.6 5562.3 5597.2 5606.3 5630.7 5218.8 5226.5 5235.5 5242.4 5250.0 4678.9 4786.9 4822.6 4823.3 4850.6 5745.7 5746.1 5760.0 5796.2 5823.9 5542.1 5592.7 5602.5 5610.2 5617.2 5690.5 5713.8 5778.0 5843.2 5855.4 5424.5 5440.6 5448.6 5452.4 5468.1 5505.9 5509.6 5510.1 5522.6 5559.0 5257.1 5395.5 5403.3 5436.6 5478.4 5336.2 5371.2 5372.8 5373.8 5379.5 5231.4 5261.3 5282.4 5300.5 5339.5 5391.1 5429.6 5432.5 5461.3 5499.8 5226.9 5298.6 5379.7 5393.9 5429.6 02:13:02 INFO - PROCESS | 18369 | 02:13:02 INFO - PROCESS | 18369 | [#1] ext.html Cycles:180 Average:43887.91 Median:37302.75 stddev:70760.24 (189.7%) stddev-sans-first:70883.83 02:13:02 INFO - PROCESS | 18369 | Values: 523.0 555.8 557.0 601.9 603.8 35274.8 35965.0 35976.8 35981.6 36053.8 40175.2 41017.6 41150.4 41243.8 41381.6 8496.3 8742.9 8765.6 8771.2 8774.5 8446.2 8563.1 8570.4 8571.7 8579.8 8571.3 8612.8 8622.3 8642.2 8647.4 8517.3 8558.2 8567.4 8574.8 8579.7 8585.7 8627.7 8677.9 8703.4 8708.8 37297.4 37776.6 37800.6 37803.4 37828.6 2384.5 3406.4 3551.2 3967.5 4117.4 26880.2 27206.0 27471.7 27489.3 27524.7 3744.4 3752.5 3755.3 3803.9 3910.4 179116.0 179986.0 180222.0 180972.0 228437.0 56316.0 57423.0 57437.4 57537.1 57547.7 61004.0 61166.7 61292.7 61293.7 61331.4 16589.5 16826.8 16841.6 16845.4 16868.2 12563.7 12610.9 12611.3 12626.9 12628.7 18849.3 20372.2 20553.0 20563.6 20663.0 6568.5 7709.3 7719.8 7790.7 7984.8 1033.4 1042.8 1052.6 1077.1 1098.0 29149.0 29873.2 30225.0 30280.5 30574.4 1072.1 1121.4 1163.2 1165.2 1249.5 15597.5 15597.9 15829.6 15973.8 16013.4 360643.0 360838.0 362514.0 364101.0 365107.0 48821.0 49636.3 55354.4 56026.7 56499.2 1343.7 1344.9 1347.9 1359.3 1360.3 24681.4 27114.2 29293.4 30019.2 30066.0 39804.6 44388.9 50229.2 50239.5 50293.0 223355.0 223395.0 225006.0 226054.0 226245.0 41610.4 42086.4 42336.0 42464.8 42637.8 30277.7 46151.0 46351.3 46406.3 47030.0 36577.3 37499.3 38209.2 38247.6 38481.2 36531.6 37010.8 37130.4 37501.0 37590.2 36977.6 37213.4 37308.1 38210.2 39381.6 31918.5 33155.7 33318.0 33555.6 34027.5 24539.4 24851.5 24947.1 25334.7 25401.2 02:13:02 INFO - PROCESS | 18369 | 02:13:02 INFO - PROCESS | 18369 | [#2] jquery.html Cycles:180 Average:24735.29 Median:19984.87 stddev:66787.46 (334.2%) stddev-sans-first:66949.73 02:13:02 INFO - PROCESS | 18369 | Values: 355.9 367.3 368.4 368.6 374.3 13931.7 16460.0 16956.7 16975.7 18453.2 16338.8 16354.0 16636.8 16670.6 16680.6 5305.1 5497.9 5498.3 5526.4 5553.1 4034.9 5170.1 5808.2 6001.0 6010.0 5947.8 5953.1 5955.5 5963.8 5991.3 5020.2 5194.2 5194.9 5195.5 5946.1 4927.2 4962.6 4972.7 4983.9 4986.0 12220.4 12483.6 12545.2 12568.6 12587.8 1822.8 2151.9 2288.7 2711.3 2789.2 9042.1 9294.7 9381.5 11047.9 12386.8 1764.5 1823.1 1828.9 1883.3 1904.0 60185.7 63929.7 65720.0 66942.0 67104.7 15017.2 15544.3 15553.3 15570.8 15721.1 24430.4 24494.0 24674.1 24680.4 24710.8 9056.7 9101.7 9139.2 9448.8 9626.2 7905.9 7920.5 7951.7 8259.1 8385.8 7863.3 8027.1 8076.3 8081.8 8088.2 2674.2 2927.4 2953.3 3005.4 3045.4 883.7 945.6 975.1 988.6 1002.9 15437.5 15812.9 15866.4 16370.3 16433.9 948.4 972.1 973.0 977.5 1008.5 7111.7 8047.6 9535.6 9719.0 10030.6 401309.0 407329.0 407968.0 409664.0 410325.0 71849.3 72017.3 73333.0 74101.3 74697.6 924.6 926.5 1081.7 1089.2 1097.6 14645.2 14857.7 14908.0 15242.7 15897.5 31626.7 32118.5 32236.2 32317.8 32712.8 39595.4 42576.1 43835.8 44348.1 44471.6 7950.6 8020.1 8132.3 8145.8 8247.8 11914.8 12419.1 12521.1 12716.2 13402.3 10371.5 10548.8 10600.4 10686.3 10694.7 10680.0 10719.0 10766.7 10844.8 11648.2 9966.3 10656.3 10688.6 10945.5 11030.4 7999.1 8016.5 8124.3 8124.4 8271.9 8371.5 10613.3 10682.8 10689.8 10761.1 02:13:02 INFO - PROCESS | 18369 | 02:13:02 INFO - PROCESS | 18369 | [#3] mootools.html Cycles:180 Average:5471.48 Median:6462.07 stddev:2900.27 (44.9%) stddev-sans-first:2892.09 02:13:02 INFO - PROCESS | 18369 | Values: 1377.6 1497.0 1497.1 1687.9 1836.2 7473.5 7625.1 7676.2 7678.3 7684.7 7612.8 7766.7 7787.5 7788.8 7789.5 1957.1 2257.7 2301.4 2321.3 2331.4 2286.8 2312.7 2321.1 2321.7 2324.2 2301.7 2306.9 2307.7 2309.1 2310.3 2166.3 2283.7 2284.6 2284.9 2287.3 2264.1 2276.2 2277.2 2283.3 2287.8 7682.4 7693.7 7737.6 7742.4 7807.7 4736.6 4834.3 4837.4 4845.6 4857.4 3004.3 3024.9 3062.8 3067.0 3100.6 924.9 927.5 952.7 979.2 979.4 10972.1 10999.1 11011.3 11017.4 11029.1 4267.5 4353.1 4366.9 4399.0 4424.6 9490.8 9547.0 9553.6 9566.3 9569.7 4335.8 4654.1 4840.9 4843.6 4888.8 4260.3 4272.4 4294.2 4312.6 4336.6 3706.9 3720.6 3729.6 3766.0 3779.4 1114.9 1122.4 1127.9 1129.0 1169.0 1292.9 1309.6 1328.4 1329.9 1357.7 7168.0 7296.2 7297.7 7300.3 7301.3 422.2 429.7 433.7 434.4 440.3 5469.6 5490.6 5491.1 5528.1 5531.9 9388.4 9501.7 9698.2 9709.6 9784.4 9586.5 9614.5 9646.6 9677.8 9692.6 7306.3 7465.1 7476.5 7562.5 7599.2 7142.5 7193.8 7200.8 7214.0 7251.4 8388.7 8397.8 8672.7 8708.0 8835.6 8622.8 8749.4 8776.3 8951.6 8957.3 6009.8 6647.6 6817.5 7059.3 7113.3 7275.5 7279.4 7287.6 7316.5 7318.5 6637.7 6758.3 6765.9 6845.5 6907.6 6597.8 6633.6 6818.3 6878.7 6955.7 6768.1 6873.5 6903.5 6915.8 6938.9 6253.3 6256.0 6313.5 6322.3 6326.3 6598.6 6627.5 6630.2 6634.9 6637.0 02:13:02 INFO - PROCESS | 18369 | 02:13:02 INFO - PROCESS | 18369 | [#4] prototype.html Cycles:180 Average:5228.48 Median:5877.04 stddev:1595.60 (27.1%) stddev-sans-first:1556.80 02:13:02 INFO - PROCESS | 18369 | Values: 310.7 329.8 329.9 331.3 334.3 5741.5 5850.0 5857.3 5898.7 5904.7 5814.4 5831.4 5842.2 5866.5 5874.5 4552.8 4553.7 4560.5 4564.9 4565.7 4324.6 4420.9 4501.5 4507.4 4565.0 4437.9 4451.8 4451.9 4460.7 4474.2 4501.4 4510.9 4514.1 4520.2 4520.4 3973.0 3978.0 3980.2 3980.7 3981.4 5610.3 5629.2 5634.4 5641.4 5648.2 5248.9 5265.5 5268.0 5273.7 5278.8 5959.6 6257.1 6260.2 6295.8 6300.4 4283.8 4288.5 4289.4 4290.2 4292.3 6311.1 6409.4 6496.7 6500.4 6521.1 4353.6 4370.0 4370.1 4381.2 4382.2 4415.8 4426.5 4427.7 4438.3 4439.8 5158.3 5168.8 5173.2 5181.1 5181.6 6008.5 6161.6 6316.7 6327.0 6329.7 1539.8 1549.1 1556.0 1556.0 1557.4 968.8 969.7 978.3 990.1 997.8 5861.5 5874.4 5876.8 5877.3 5887.8 6336.9 6348.4 6351.7 6356.3 6357.0 5847.6 5847.9 5849.7 5851.4 5857.1 3441.8 3474.7 3475.6 3478.0 3478.5 6602.0 6692.2 6716.1 6807.9 6818.1 6631.6 6649.1 6666.1 6717.7 6727.1 6751.2 6784.7 6792.1 6793.0 6793.5 6438.5 6471.8 6484.4 6485.5 6488.9 6273.2 6433.7 6437.7 6452.2 6455.0 6788.2 6834.0 6856.9 6864.6 6873.8 4353.1 4388.3 4392.9 4392.9 4393.0 6226.0 6324.3 6527.4 6566.4 6567.4 6274.4 6313.6 6328.8 6334.1 6337.2 6265.9 6310.0 6311.8 6317.6 6326.8 6203.0 6210.6 6216.7 6222.8 6224.4 6207.6 6326.4 6351.8 6364.5 6370.6 6164.6 6186.0 6193.8 6208.4 6211.2 02:13:02 INFO - PROCESS | 18369 | 02:13:02 INFO - PROCESS | 18369 | [#5] yui.html Cycles:180 Average:13065.73 Median:4361.05 stddev:14606.67 (334.9%) stddev-sans-first:14618.26 02:13:02 INFO - PROCESS | 18369 | Values: 728.9 734.8 742.4 789.0 834.9 13125.9 13206.8 13227.0 13252.3 13258.0 12330.7 12425.6 12429.3 12438.1 12441.5 673.2 806.2 825.1 825.8 826.9 825.9 835.4 835.6 837.5 844.7 713.7 870.7 877.4 877.5 879.3 711.7 859.2 867.9 870.0 870.1 638.6 640.7 640.8 642.4 642.6 12814.2 12826.6 12861.9 12881.0 12891.2 12640.2 12949.1 12951.7 12988.7 13161.0 10496.0 10509.3 10661.6 10695.1 10783.7 3502.5 3591.6 3627.9 3643.6 3653.7 48694.5 48717.5 48732.8 48860.5 48972.3 9590.7 9775.6 9852.0 9891.4 10027.7 16803.8 16893.5 16902.0 16921.2 16927.6 7651.4 7790.3 7889.9 7901.1 7978.9 4320.7 4340.0 4359.6 4362.5 4408.1 3171.2 3189.0 3197.0 3197.0 3198.0 513.8 545.8 582.6 601.2 611.7 590.6 591.5 616.2 662.5 677.9 7751.9 7894.4 7949.0 8515.4 8726.2 544.0 601.6 610.5 614.1 615.3 3752.9 3802.8 3814.7 3835.4 3925.3 50238.2 50350.5 50494.0 50625.2 53906.2 42873.6 42934.0 43455.6 48341.5 48526.5 42221.8 42292.8 42786.0 43881.6 44209.8 7952.4 8168.0 8236.1 8357.2 8457.7 32199.7 32560.7 33269.0 33620.0 33781.3 36971.4 37132.6 40700.0 40761.2 41263.8 10440.6 10602.9 11041.7 11093.6 11130.7 12062.8 12276.0 12340.5 12504.2 12905.4 10877.2 11188.8 11250.2 11260.3 11301.2 11311.7 11434.9 11533.1 11792.7 12043.4 10083.2 10353.4 10480.3 10486.4 10503.7 9357.9 9630.6 9645.6 9984.1 10046.8 8592.8 8732.6 8923.1 9198.2 9551.4 02:13:02 INFO - PROCESS | 18369 | -------- Summary: end -------- 02:13:02 INFO - PROCESS | 18369 | 02:13:03 INFO - TEST-INFO | 18369: exit 0 02:13:03 INFO - TEST-OK | dromaeo_css | took 1111804ms 02:13:03 INFO - TEST-START | kraken 02:13:03 INFO - operating with platform_type : linux_ 02:13:03 INFO - Initialising browser for kraken test... 02:13:03 INFO - TEST-INFO | started process 18555 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwOqHKX/profile http://localhost:55657/getInfo.html) 02:13:07 INFO - PROCESS | 18555 | __metrics Screen width/height:1600/1200 02:13:07 INFO - PROCESS | 18555 | colorDepth:24 02:13:07 INFO - PROCESS | 18555 | Browser inner width/height: 1024/697 02:13:07 INFO - PROCESS | 18555 | __metrics 02:13:07 INFO - PROCESS | 18555 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:13:08 INFO - TEST-INFO | 18555: exit 0 02:13:08 INFO - Browser initialized. 02:13:08 INFO - Running cycle 1/1 for kraken test... 02:13:08 INFO - TEST-INFO | started process 18638 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwOqHKX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:20 INFO - PROCESS | 18638 | RSS: Main: 147292160 02:13:20 INFO - PROCESS | 18638 | 02:13:22 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55657/tests/kraken/driver.html?testName=audio-beat-detection) 02:13:23 INFO - PROCESS | 18638 | RSS: Main: 190595072 02:13:23 INFO - PROCESS | 18638 | 02:13:26 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55657/tests/kraken/driver.html?testName=audio-dft) 02:13:26 INFO - PROCESS | 18638 | RSS: Main: 179290112 02:13:26 INFO - PROCESS | 18638 | 02:13:29 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55657/tests/kraken/driver.html?testName=audio-fft) 02:13:30 INFO - PROCESS | 18638 | RSS: Main: 164540416 02:13:30 INFO - PROCESS | 18638 | 02:13:32 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55657/tests/kraken/driver.html?testName=audio-oscillator) 02:13:32 INFO - PROCESS | 18638 | RSS: Main: 167686144 02:13:32 INFO - PROCESS | 18638 | 02:13:35 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55657/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:13:35 INFO - PROCESS | 18638 | RSS: Main: 171712512 02:13:35 INFO - PROCESS | 18638 | 02:13:38 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55657/tests/kraken/driver.html?testName=imaging-darkroom) 02:13:39 INFO - PROCESS | 18638 | RSS: Main: 171827200 02:13:39 INFO - PROCESS | 18638 | 02:13:42 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55657/tests/kraken/driver.html?testName=imaging-desaturate) 02:13:43 INFO - PROCESS | 18638 | RSS: Main: 170102784 02:13:43 INFO - PROCESS | 18638 | 02:13:45 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55657/tests/kraken/driver.html?testName=json-parse-financial) 02:13:46 INFO - PROCESS | 18638 | RSS: Main: 169193472 02:13:46 INFO - PROCESS | 18638 | 02:13:47 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55657/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:13:48 INFO - PROCESS | 18638 | RSS: Main: 178802688 02:13:48 INFO - PROCESS | 18638 | 02:13:50 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55657/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:13:50 INFO - PROCESS | 18638 | RSS: Main: 175001600 02:13:50 INFO - PROCESS | 18638 | 02:13:53 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55657/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:13:53 INFO - PROCESS | 18638 | RSS: Main: 191311872 02:13:53 INFO - PROCESS | 18638 | 02:13:56 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:13:56 INFO - PROCESS | 18638 | RSS: Main: 195895296 02:13:56 INFO - PROCESS | 18638 | 02:13:59 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:13:59 INFO - PROCESS | 18638 | RSS: Main: 196562944 02:13:59 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | Cycle 1(1): loaded http://localhost:55657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55657/tests/kraken/driver.html?testName=ai-astar) 02:14:01 INFO - PROCESS | 18638 | RSS: Main: 255606784 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | __start_tp_report 02:14:01 INFO - PROCESS | 18638 | _x_x_mozilla_page_load 02:14:01 INFO - PROCESS | 18638 | _x_x_mozilla_page_load_details 02:14:01 INFO - PROCESS | 18638 | |i|pagename|runs| 02:14:01 INFO - PROCESS | 18638 | |0;ai-astar;108;112;105;110;110;111;102;110;110;110 02:14:01 INFO - PROCESS | 18638 | |1;audio-beat-detection;151;126;148;166;133;146;173;127;167;129 02:14:01 INFO - PROCESS | 18638 | |2;audio-dft;161;162;161;160;162;159;162;162;162;161 02:14:01 INFO - PROCESS | 18638 | |3;audio-fft;72;74;117;106;74;74;73;114;95;73 02:14:01 INFO - PROCESS | 18638 | |4;audio-oscillator;95;97;150;96;96;96;141;94;96;144 02:14:01 INFO - PROCESS | 18638 | |5;imaging-gaussian-blur;121;115;114;115;115;115;115;115;115;115 02:14:01 INFO - PROCESS | 18638 | |6;imaging-darkroom;146;147;146;146;145;146;146;146;146;145 02:14:01 INFO - PROCESS | 18638 | |7;imaging-desaturate;98;96;96;96;95;96;96;96;96;96 02:14:01 INFO - PROCESS | 18638 | |8;json-parse-financial;59;58;56;56;56;56;58;65;55;54 02:14:01 INFO - PROCESS | 18638 | |9;json-stringify-tinderbox;67;67;69;68;67;68;69;68;68;68 02:14:01 INFO - PROCESS | 18638 | |10;stanford-crypto-aes;82;90;84;84;85;85;83;84;82;83 02:14:01 INFO - PROCESS | 18638 | |11;stanford-crypto-ccm;127;122;117;133;112;128;123;119;128;116 02:14:01 INFO - PROCESS | 18638 | |12;stanford-crypto-pbkdf2;156;140;149;151;153;139;149;150;160;150 02:14:01 INFO - PROCESS | 18638 | |13;stanford-crypto-sha256-iterative;70;67;69;68;67;70;70;69;67;66 02:14:01 INFO - PROCESS | 18638 | __end_tp_report 02:14:01 INFO - PROCESS | 18638 | __start_cc_report 02:14:01 INFO - PROCESS | 18638 | _x_x_mozilla_cycle_collect,948 02:14:01 INFO - PROCESS | 18638 | __end_cc_report 02:14:01 INFO - PROCESS | 18638 | __startTimestamp1456222441773__endTimestamp 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | ------- Summary: start ------- 02:14:01 INFO - PROCESS | 18638 | Number of tests: 14 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.05 (2.8%) stddev-sans-first:3.22 02:14:01 INFO - PROCESS | 18638 | Values: 108.0 112.0 105.0 110.0 110.0 111.0 102.0 110.0 110.0 110.0 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:149.50 stddev:17.68 (11.8%) stddev-sans-first:18.68 02:14:01 INFO - PROCESS | 18638 | Values: 151.0 126.0 148.0 166.0 133.0 146.0 173.0 127.0 167.0 129.0 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 02:14:01 INFO - PROCESS | 18638 | Values: 161.0 162.0 161.0 160.0 162.0 159.0 162.0 162.0 162.0 161.0 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#3] audio-fft Cycles:10 Average:87.20 Median:73.50 stddev:18.79 (25.6%) stddev-sans-first:19.11 02:14:01 INFO - PROCESS | 18638 | Values: 72.0 74.0 117.0 106.0 74.0 74.0 73.0 114.0 95.0 73.0 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:96.00 stddev:23.92 (24.9%) stddev-sans-first:24.70 02:14:01 INFO - PROCESS | 18638 | Values: 95.0 97.0 150.0 96.0 96.0 96.0 141.0 94.0 96.0 144.0 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.00 stddev:1.96 (1.7%) stddev-sans-first:0.33 02:14:01 INFO - PROCESS | 18638 | Values: 121.0 115.0 114.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 02:14:01 INFO - PROCESS | 18638 | Values: 146.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.33 02:14:01 INFO - PROCESS | 18638 | Values: 98.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:3.09 (5.4%) stddev-sans-first:3.22 02:14:01 INFO - PROCESS | 18638 | Values: 59.0 58.0 56.0 56.0 56.0 56.0 58.0 65.0 55.0 54.0 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 02:14:01 INFO - PROCESS | 18638 | Values: 67.0 67.0 69.0 68.0 67.0 68.0 69.0 68.0 68.0 68.0 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:2.30 (2.7%) stddev-sans-first:2.30 02:14:01 INFO - PROCESS | 18638 | Values: 82.0 90.0 84.0 84.0 85.0 85.0 83.0 84.0 82.0 83.0 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:125.00 stddev:6.55 (5.2%) stddev-sans-first:6.75 02:14:01 INFO - PROCESS | 18638 | Values: 127.0 122.0 117.0 133.0 112.0 128.0 123.0 119.0 128.0 116.0 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:150.50 stddev:6.40 (4.2%) stddev-sans-first:6.36 02:14:01 INFO - PROCESS | 18638 | Values: 156.0 140.0 149.0 151.0 153.0 139.0 149.0 150.0 160.0 150.0 02:14:01 INFO - PROCESS | 18638 | 02:14:01 INFO - PROCESS | 18638 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.45 02:14:01 INFO - PROCESS | 18638 | Values: 70.0 67.0 69.0 68.0 67.0 70.0 70.0 69.0 67.0 66.0 02:14:01 INFO - PROCESS | 18638 | -------- Summary: end -------- 02:14:01 INFO - PROCESS | 18638 | 02:14:02 INFO - TEST-INFO | 18638: exit 0 02:14:02 INFO - TEST-OK | kraken | took 59412ms 02:14:02 INFO - SUITE-END | took 1171s 02:14:02 INFO - Completed test suite (00:19:31) 02:14:02 INFO - Working with test: dromaeo_css 02:14:02 INFO - Generating results file: dromaeo_css 02:14:02 INFO - Working with test: kraken 02:14:02 INFO - Generating results file: kraken 02:14:02 INFO - javascript benchmark 02:14:02 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:14:02 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 02:14:02 INFO - process_Request line: dromaeo_css 6881.43 graph.html#tests=[[72,64,35]] 02:14:02 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:14:03 INFO - process_Request line: kraken 1521.70 graph.html#tests=[[232,64,35]] 02:14:03 INFO - RETURN: dromaeo_css: 6881.43 02:14:03 INFO - RETURN: kraken: 1521.70 02:14:03 INFO - javascript benchmark 02:14:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3103.7982531135476, 3140.0736782649115, 3172.9524057139147, 3179.888703895364, 3206.182423482012, 5082.796688132475, 5089.592832573395, 5127.3078134451835, 5136.1268584340705, 5156.355455568054, 5107.846764597068, 5148.5623721983675, 5154.793808247666, 5160.354955630546, 5262.368515778103, 4618.099470603233, 4673.135469938064, 4735.124002059612, 4763.833265835697, 4883.243097319903, 4646.53534646536, 4724.858254252378, 4797.544233297848, 4809.014152098812, 4894.681845680019, 4781.904361912742, 4797.184478638623, 4800.1119792838435, 4816.109019831325, 4822.68652537584, 4784.30627559002, 4784.976075119602, 4796.136695394827, 4814.10938976287, 4831.130396528623, 4665.2535594304745, 4753.809847606091, 4791.808327666889, 4805.879853003668, 4833.830815921426, 4963.305137280783, 4982.900341993176, 4994.175960966436, 5006.599472042264, 5055.292259083694, 5476.945230547723, 5554.86112847178, 5559.166125081229, 5564.33228012637, 5565.777368905239, 5593.496585307342, 5605.775768969236, 5636.182753500761, 5640.0, 5690.715464226813, 5196.870078248036, 5305.708186049766, 5306.204069389584, 5311.548518375904, 5313.8405847825015, 5579.4420557944695, 5665.263515742927, 5730.054541000772, 5748.48263656273, 5773.451522105393, 5531.751071201725, 5544.500994910478, 5546.889062218814, 5558.527525160326, 5561.721913904369, 5597.608167428322, 5599.916001259984, 5606.0, 5608.130739735348, 5615.831525054255, 5416.647917885325, 5466.753996070186, 5479.589030822704, 5527.032769265363, 5568.192612071227, 5473.972630136824, 5481.177823326533, 5487.6981766003255, 5490.533304669148, 5502.147167189092, 4241.1941731071, 4294.227039132924, 4302.182585308781, 4302.311630139163, 4342.261815491374, 3920.4511368408444, 3929.8821035368983, 3936.252112098692, 3937.6062393760394, 3951.0, 5183.81856635016, 5218.112920803473, 5257.868553286198, 5260.263563101169, 5314.1497360422145, 5420.593455490854, 5562.276904002454, 5597.244372009726, 5606.327240731139, 5630.690312032795, 5218.843434696965, 5226.503482169188, 5235.476452354734, 5242.449542798027, 5250.0, 4678.906421871544, 4786.904261914742, 4822.590079843252, 4823.252395878644, 4850.563449289511, 5745.712714364265, 5746.051901436216, 5760.049591817387, 5796.217510636095, 5823.941760582425, 5542.0855558832345, 5592.748326325406, 5602.52378547828, 5610.242617246619, 5617.157426386075, 5690.544756419559, 5713.800016999385, 5778.046622307273, 5843.211166492469, 5855.443732845373, 5424.538914192338, 5440.591955603267, 5448.618596698193, 5452.400235974119, 5468.0977638690765, 5505.9174112387545, 5509.559235261089, 5510.1459273812625, 5522.641028333145, 5558.972205138948, 5257.0537303284245, 5395.487428694268, 5403.324584426947, 5436.6194366393975, 5478.424765399575, 5336.199570064521, 5371.194320851903, 5372.838814835562, 5373.811916582901, 5379.462053794589, 5231.398389185292, 5261.342332208474, 5282.418933917343, 5300.469953004668, 5339.519443250126, 5391.05656510117, 5429.592780541396, 5432.483914028161, 5461.317335333083, 5499.752511137089, 5226.8954620908125, 5298.576113910955, 5379.704116273486, 5393.865153371197, 5429.5656347492895], "unit": "score", "name": "dojo.html", "value": 5136.6555149035685}, {"lowerIsBetter": false, "replicates": [523.037610796135, 555.7554675942584, 557.0418879527211, 601.9097135429685, 603.8007457539011, 35274.823625881865, 35965.0, 35976.82011589938, 35981.64018359816, 36053.81973090134, 40175.19649607014, 41017.58982410175, 41150.38274425886, 41243.79378103113, 41381.58618413815, 8496.2778163856, 8742.86885696715, 8765.649374025063, 8771.16673915977, 8774.473531588093, 8446.155384461566, 8563.058063612998, 8570.357223208253, 8571.657133714674, 8579.828403431928, 8571.314294856396, 8612.827743445127, 8622.267107295887, 8642.178992995656, 8647.437916535406, 8517.276031537327, 8558.18697223769, 8567.400281980295, 8574.828503429928, 8579.742607721779, 8585.656573737044, 8627.65489380424, 8677.869831952527, 8703.390762646617, 8708.825823483558, 37297.440538391944, 37776.62223377786, 37800.62199377998, 37803.4329485058, 37828.621713782784, 2384.5350156719446, 3406.369821583015, 3551.200979779555, 3967.504061992251, 4117.423560701504, 26880.193594192206, 27206.0, 27471.725282747117, 27489.31276718078, 27524.724752752416, 3744.4383342498572, 3752.5121734174654, 3755.286495565834, 3803.9239215215816, 3910.432987216866, 179116.0, 179986.0, 180222.0, 180972.0, 228437.0, 56316.0, 57423.0, 57437.42562574404, 57537.13694294589, 57547.71226143843, 61004.0, 61166.69416652977, 61292.69353653203, 61293.69353153206, 61331.38668613346, 16589.50231493057, 16826.83173168277, 16841.578960526083, 16845.41041063557, 16868.24092915822, 12563.685907852378, 12610.936945315214, 12611.30637814929, 12626.936865315614, 12628.684282893002, 18849.251557809985, 20372.185112595627, 20553.0, 20563.588728225353, 20663.0, 6568.540202185801, 7709.267619576131, 7719.768406947801, 7790.727324543614, 7984.800379990431, 1033.3748082410184, 1042.7705904700954, 1052.6210564196883, 1077.0831155773867, 1097.9843644628686, 29149.0, 29873.16488564857, 30225.0, 30280.5457918127, 30574.38851222963, 1072.104792498257, 1121.4224674292745, 1163.2380790582183, 1165.1610840195046, 1249.450241893564, 15597.454089106826, 15597.922010389875, 15829.604259893595, 15973.840261597468, 16013.439529616408, 360643.0, 360838.0, 362514.0, 364101.0, 365107.0, 48821.0, 49636.25545616819, 55354.446455534926, 56026.71986640041, 56499.15251271152, 1343.650650830791, 1344.892408607309, 1347.8989075819352, 1359.286374653295, 1360.3334366160707, 24681.382965426008, 27114.1865744028, 29293.414131717673, 30019.249518762204, 30066.0, 39804.60195398009, 44388.89027774332, 50229.246561300875, 50239.497605024946, 50293.0, 223355.0, 223395.0, 225006.0, 226054.0, 226245.0, 41610.375844361755, 42086.36870446885, 42336.0, 42464.78767606142, 42637.786811065744, 30277.697223027488, 46151.0, 46351.3047304284, 46406.303905442124, 47030.0, 36577.268454630226, 37499.25001500009, 38209.235815282984, 38247.6175238244, 38481.23037539177, 36531.63468365389, 37010.8149459251, 37130.44304335383, 37501.0, 37590.248195036496, 36977.630223697415, 37213.44179837251, 37308.06729831776, 38210.2357952845, 39381.606183937794, 31918.52122218215, 33155.668443315255, 33318.0, 33555.57205434741, 34027.48958765571, 24539.38651533726, 24851.502969940862, 24947.126850560144, 25334.746652533977, 25401.237962861145], "unit": "score", "name": "ext.html", "value": 18512.26795355806}, {"lowerIsBetter": false, "replicates": [355.9145805006799, 367.32779014403627, 368.43261377478683, 368.64794121613863, 374.33742276171193, 13931.651708707263, 16460.024797024358, 16956.74564881528, 16975.74536381955, 18453.16960736767, 16338.754918676199, 16354.0, 16636.83363166368, 16670.58323541912, 16680.58298542537, 5305.098133317336, 5497.862553436156, 5498.285222921015, 5526.447355264461, 5553.139263414157, 4034.919301613966, 5170.146925757245, 5808.186853840466, 6000.969995150018, 6010.038393856984, 5947.762089516415, 5953.1070339449, 5955.464008239258, 5963.791267305645, 5991.340952495222, 5020.196768517038, 5194.168932970744, 5194.896102077975, 5195.506426889458, 5946.108083787445, 4927.211646136601, 4962.578180854632, 4972.726500042496, 4983.9252411213865, 4986.0, 12220.388980550937, 12483.625491235278, 12545.247285162919, 12568.622941311774, 12587.811182832265, 1822.82683145101, 2151.8924053797405, 2288.6567014947723, 2711.267957651423, 2789.246903336108, 9042.140996605312, 9294.676330917271, 9381.5309234538, 11047.889521104766, 12386.75226495465, 1764.4794785538297, 1823.0520129532702, 1828.9176987035614, 1883.274939148424, 1904.0384605774134, 60185.6990715048, 63929.68035159841, 65720.0, 66942.0, 67104.66447667731, 15017.24913754308, 15544.300506477235, 15553.30010149546, 15570.766438503431, 15721.135337556316, 24430.389240269134, 24494.0, 24674.13640522573, 24680.382990425023, 24710.752892471206, 9056.683016094405, 9101.681441149529, 9139.223166030828, 9448.811023779486, 9626.181774549243, 7905.921229433937, 7920.5247685139075, 7951.721689740947, 8259.050209226016, 8385.790355241168, 7863.33161681252, 8027.07688615805, 8076.313513351313, 8081.797955051054, 8088.191180881982, 2674.211107723226, 2927.3852490977133, 2953.291210109558, 3005.413944280844, 3045.421369939704, 883.6597909804643, 945.6217512994857, 975.1467465967279, 988.6342053440274, 1002.8997100290059, 15437.536873893801, 15812.92093539525, 15866.365345386055, 16370.345186192419, 16433.91783041077, 948.3835506920557, 972.1260775808398, 972.9978122533802, 977.4819345746765, 1008.4755926917961, 7111.679974401164, 8047.597620118971, 9535.618575256913, 9719.0, 10030.598776048877, 401309.0, 407329.0, 407968.0, 409664.0, 410325.0, 71849.28150718531, 72017.27982720106, 73333.0, 74101.25898740944, 74697.62651186818, 924.6440120553501, 926.4765407544716, 1081.70793885652, 1089.199438412766, 1097.6158344579333, 14645.194514301389, 14857.702845942804, 14908.0, 15242.695146096794, 15897.52307430779, 31626.683733163296, 32118.518222227154, 32236.19409514781, 32317.838410807795, 32712.83643581767, 39595.406068908414, 42576.1484770309, 43835.780821095694, 44348.11303773842, 44471.55528444803, 7950.562719050507, 8020.117787043304, 8132.30875375576, 8145.755627331189, 8247.793805154919, 11914.761704765682, 12419.130660853654, 12521.123521353782, 12716.237025778482, 13402.32988350559, 10371.533281002223, 10548.84176737365, 10600.363978161335, 10686.25196236256, 10694.679159625224, 10680.038796508352, 10719.0, 10766.676999690022, 10844.783104338027, 11648.242864213798, 9966.302358834811, 10656.307340022873, 10688.625898093529, 10945.507452164513, 11030.448477575928, 7999.120096789232, 8016.519008859487, 8124.309433698202, 8124.39067069984, 8271.875921861056, 8371.455855369382, 10613.310134841211, 10682.83975740349, 10689.786204276026, 10761.085307748928], "unit": "score", "name": "jquery.html", "value": 8798.661287702582}, {"lowerIsBetter": false, "replicates": [1377.6418131285864, 1496.97754533682, 1497.101738956626, 1687.9071651059187, 1836.1645451319644, 7473.476856620032, 7625.084989801225, 7676.232376762321, 7678.308952194295, 7684.654190561424, 7612.77161685149, 7766.728164514243, 7787.532748035122, 7788.766337009884, 7789.532628042321, 1957.07039156401, 2257.6726374675663, 2301.355620426275, 2321.3384185507134, 2331.3821837213154, 2286.8399212055165, 2312.7455979842202, 2321.0947730385165, 2321.7097862767155, 2324.174917904145, 2301.746807851135, 2306.850054746436, 2307.7346105197867, 2309.1225334372916, 2310.295359915225, 2166.274298110135, 2283.6574513822893, 2284.6344584866424, 2284.862908225512, 2287.336672365012, 2264.1283106004144, 2276.2374604507345, 2277.214361045437, 2283.2807665585287, 2287.782660647236, 7682.423818213656, 7693.653785579662, 7737.57443340616, 7742.380609551279, 7807.726729564438, 4736.550027747358, 4834.274858771178, 4837.419509658828, 4845.63657725672, 4857.368542089541, 3004.2939909121337, 3024.8790048398037, 3062.770292228092, 3066.953995690066, 3100.5659207710937, 924.912133347331, 927.4852456886425, 952.6665667016558, 979.1579241852002, 979.4172467381896, 10972.122230221643, 10999.065079468255, 11011.28426652265, 11017.44912754359, 11029.062529684987, 4267.466566679165, 4353.10761293934, 4366.868993930188, 4399.010222699931, 4424.601785839225, 9490.762730931643, 9547.0, 9553.570089345996, 9566.282528810367, 9569.712908612753, 4335.82656693735, 4654.115718013567, 4840.927386089212, 4843.612510999112, 4888.804447822118, 4260.297050986553, 4272.359146128106, 4294.205571969195, 4312.633426158749, 4336.566343365701, 3706.9073273167846, 3720.6465385788306, 3729.6270372962485, 3766.0, 3779.433085037266, 1114.9498272577753, 1122.410734364449, 1127.9436028198556, 1128.966131016071, 1169.0121847039238, 1292.8965682745359, 1309.607117864656, 1328.4420543371807, 1329.8936085113169, 1357.6673714939902, 7168.0, 7296.233895441009, 7297.744578939712, 7300.342969132804, 7301.306375894282, 422.2167878585242, 429.6906227516183, 433.6725772042088, 434.38751360581426, 440.2515723270389, 5469.644473109235, 5490.588205884575, 5491.066518691832, 5528.143137813645, 5531.944680553143, 9388.389754665925, 9501.667441639509, 9698.175655069257, 9709.611615535441, 9784.364016338915, 9586.520673966274, 9614.471204083842, 9646.565904534313, 9677.806443871083, 9692.612295508241, 7306.305900939402, 7465.104187497426, 7476.476646634792, 7562.546247225184, 7599.164091949881, 7142.464315176278, 7193.784186474414, 7200.819979500555, 7213.963930180315, 7251.41988640918, 8388.748337549883, 8397.832043359222, 8672.696455624024, 8707.998580163363, 8835.646574136963, 8622.82754344897, 8749.387542871938, 8776.297896168418, 8951.597178126869, 8957.328200385127, 6009.819705408845, 6647.634380109141, 6817.522773405814, 7059.258777828254, 7113.324234197743, 7275.490715649854, 7279.381252593589, 7287.599182044826, 7316.451266155166, 7318.451116166202, 6637.734490620321, 6758.324167583202, 6765.864682706417, 6845.520813543004, 6907.551009184387, 6597.835054123685, 6633.568818026813, 6818.318168183142, 6878.7248510059035, 6955.686994085379, 6768.120144381199, 6873.450123989969, 6903.482238832007, 6915.757948471779, 6938.8612227756175, 6253.343398943045, 6256.0, 6313.494920406265, 6322.3045464997895, 6326.3041065483685, 6598.571092878948, 6627.536072474881, 6630.204375474974, 6634.867302653824, 6637.037629543785], "unit": "score", "name": "mootools.html", "value": 4392.730961315372}, {"lowerIsBetter": false, "replicates": [310.6722407859707, 329.8350824587706, 329.8828915734914, 331.31252650749684, 334.29130243882986, 5741.540676745861, 5849.9707501462535, 5857.326407463143, 5898.734556944937, 5904.734286957087, 5814.418558144183, 5831.387704291052, 5842.152887831262, 5866.530677545797, 5874.471297583216, 4552.840650577239, 4553.726776393411, 4560.452745670525, 4564.9087018259615, 4565.726056436608, 4324.567543245682, 4420.9336859947125, 4501.482329532113, 4507.368968344418, 4564.97717511412, 4437.866863994069, 4451.777411129447, 4451.910961780763, 4460.732356058631, 4474.217012022899, 4501.437320334958, 4510.864674059783, 4514.142312960527, 4520.208963431386, 4520.367148599199, 3972.980135099306, 3977.960220397788, 3980.1840622672285, 3980.661643760284, 3981.402789581586, 5610.270664813548, 5629.240052592889, 5634.352049514277, 5641.407652196543, 5648.237487939116, 5248.921266181011, 5265.473452654742, 5268.024490815944, 5273.683578985235, 5278.788848446057, 5959.553033522503, 6257.124002639634, 6260.217472815898, 6295.779647712308, 6300.369963003709, 4283.828646854122, 4288.463942007249, 4289.420928174688, 4290.163418133465, 4292.270314046619, 6311.116443697886, 6409.4231519163495, 6496.740130394778, 6500.382463665944, 6521.054447105191, 4353.6299414549485, 4370.0, 4370.125974805052, 4381.211381951216, 4382.2112019836095, 4415.845445409395, 4426.468823741172, 4427.712198707074, 4438.289873620205, 4439.822407103744, 5158.303629010111, 5168.793248270103, 5173.172292433268, 5181.067407866545, 5181.5595674368105, 6008.459238668541, 6161.5994960328335, 6316.684165791692, 6327.0, 6329.715162817684, 1539.7844301797757, 1549.1324858079286, 1556.0274828232355, 1556.0352581399604, 1557.369265447473, 968.7674958010027, 969.680005598151, 978.3200675530438, 990.1039559198937, 997.8203923293877, 5861.472467477947, 5874.412558744091, 5876.823695289148, 5877.265341832271, 5887.8233652990475, 6336.904946425807, 6348.396902294275, 6351.745930162834, 6356.269029061717, 6357.0, 5847.649141051465, 5847.883042339129, 5849.736761845727, 5851.444112809277, 5857.062869940789, 3441.7934923904145, 3474.6872781449792, 3475.6176820549717, 3478.0087675013006, 3478.5477887874413, 6601.966990165019, 6692.196936367667, 6716.093327400738, 6807.931920680829, 6818.113645226188, 6631.602103873783, 6649.069130321759, 6666.100076489709, 6717.731290748316, 6727.125473688389, 6751.223609284995, 6784.660766961632, 6792.117024786746, 6793.0, 6793.490488213305, 6438.452731517874, 6471.838204044937, 6484.383983521558, 6485.513586481127, 6488.935110648833, 6273.15312432834, 6433.678316084271, 6437.7103030362805, 6452.161219041494, 6455.0317452382515, 6788.151481064867, 6833.965830170818, 6856.931430685829, 6864.622445765531, 6873.759418420332, 4353.085851971122, 4388.319810429389, 4392.868213953587, 4392.934105988476, 4393.011572396185, 6226.0, 6324.335944725922, 6527.445167160845, 6566.409023187936, 6567.44176744982, 6274.403931626488, 6313.589616674902, 6328.778492752732, 6334.081558173947, 6337.176167098248, 6265.906011409741, 6310.0, 6311.779087731908, 6317.5893566918, 6326.810195694136, 6203.0, 6210.596311239755, 6216.72024758896, 6222.844428889314, 6224.37756224374, 6207.596506227081, 6326.367363263821, 6351.777687780906, 6364.490840732823, 6370.554061215856, 6164.630122192682, 6186.0, 6193.81418557444, 6208.410201030895, 6211.192544969125], "unit": "score", "name": "prototype.html", "value": 4701.684311523089}, {"lowerIsBetter": false, "replicates": [728.8578727148205, 734.7942576078698, 742.402366095293, 789.0491957191584, 834.9415540912139, 13125.934370328147, 13206.801897971538, 13227.007974401935, 13252.337383130842, 13258.0, 12330.691732706688, 12425.56510522132, 12429.254244745322, 12438.067144964141, 12441.502339906392, 673.1921693967234, 806.2219957740808, 825.1171246765963, 825.781167990483, 826.8759686047081, 825.9380546459009, 835.4402550291319, 835.6114406800837, 837.5142417397894, 844.7381311793333, 713.7038129176385, 870.7387783664907, 877.4472082587961, 877.4779006491127, 879.3404946290283, 711.7188710459366, 859.1623167411786, 867.9435836670659, 870.0342619692136, 870.0516437083546, 638.594492497263, 640.6892657061321, 640.8013515810114, 642.4314481683743, 642.6080091144398, 12814.23114613117, 12826.55107071248, 12861.935690321581, 12881.0, 12891.226526408445, 12640.241585504898, 12949.093563450562, 12951.676208094874, 12988.740225195443, 13161.0, 10496.0, 10509.316894401916, 10661.573537058508, 10695.09091727204, 10783.676489705322, 3502.509648649191, 3591.6408359164134, 3627.9274414511824, 3643.580988186366, 3653.671169594723, 48694.51305486935, 48717.51282487165, 48732.756336218095, 48860.51139488631, 48972.26541601879, 9590.712278631652, 9775.608975641037, 9852.0, 9891.35706179096, 10027.699169024942, 16803.831961680226, 16893.493195204162, 16902.0, 16921.238544265536, 16927.576810579834, 7651.387888968869, 7790.259925307087, 7889.8816517752275, 7901.130875603679, 7978.880316795253, 4320.719153255029, 4340.001799586113, 4359.564043595615, 4362.541933097043, 4408.118376324748, 3171.20719820045, 3188.952165717516, 3196.9680303197138, 3197.0, 3198.0, 513.8464147987717, 545.8116949652364, 582.5718097198555, 601.2274227617578, 611.7308384310888, 590.6160995353055, 591.4883625663856, 616.1989413762092, 662.456785435938, 677.9288723816456, 7751.92248077512, 7894.368450523944, 7949.0, 8515.40392172542, 8726.214640682369, 544.0017567763199, 601.6149664214906, 610.502440510991, 614.149403076733, 615.3108518459264, 3752.9061773455337, 3802.8098595070137, 3814.6948244140403, 3835.4055121456217, 3925.2542017016676, 50238.24642630364, 50350.49649503458, 50494.0, 50625.24062139071, 53906.19140712892, 42873.57126428758, 42934.0, 43455.56544434515, 48341.516584834404, 48526.514734852906, 42221.788891055345, 42292.78853605712, 42786.0, 43881.56118438839, 44209.778951105036, 7952.36381089523, 8167.959160204161, 8236.094029656613, 8357.247847693738, 8457.746267611981, 32199.67800321967, 32560.674393255766, 33269.0, 33620.0, 33781.324373512885, 36971.44542831806, 37132.628673713996, 40700.0, 40761.184776303715, 41263.793681031406, 10440.582376704846, 10602.8939710605, 11041.723956901142, 11093.611723589636, 11130.721731956442, 12062.75874482523, 12276.0, 12340.50637974471, 12504.187227830162, 12905.41925613331, 10877.238593298393, 11188.776224475629, 11250.156238281998, 11260.324380536866, 11301.208915376174, 11311.660650180507, 11434.942825286153, 11533.135014874086, 11792.70518237051, 12043.390314520064, 10083.193344532567, 10353.378797272188, 10480.266381353233, 10486.423246721199, 10503.684889453329, 9357.906420935704, 9630.566624502055, 9645.614175432904, 9984.051515106054, 10046.8492972604, 8592.785180370542, 8732.56337183151, 8923.063078376677, 9198.2181514572, 9551.426914384881], "unit": "score", "name": "yui.html", "value": 6144.532910271316}], "name": "dromaeo_css", "value": 6881.435391050599}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 112.0, 105.0, 110.0, 110.0, 111.0, 102.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [151.0, 126.0, 148.0, 166.0, 133.0, 146.0, 173.0, 127.0, 167.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 160.0, 162.0, 159.0, 162.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 117.0, 106.0, 74.0, 74.0, 73.0, 114.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 87.2}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 150.0, 96.0, 96.0, 96.0, 141.0, 94.0, 96.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [121.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.5}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 56.0, 56.0, 56.0, 56.0, 58.0, 65.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 69.0, 68.0, 67.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [82.0, 90.0, 84.0, 84.0, 85.0, 85.0, 83.0, 84.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [127.0, 122.0, 117.0, 133.0, 112.0, 128.0, 123.0, 119.0, 128.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [156.0, 140.0, 149.0, 151.0, 153.0, 139.0, 149.0, 150.0, 160.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.7}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 69.0, 68.0, 67.0, 70.0, 70.0, 69.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1521.7}]} 02:14:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1521.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6881.43"}}} 02:14:03 INFO - Return code: 0 02:14:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:14:03 INFO - # TBPL SUCCESS # 02:14:03 INFO - Running post-action listener: _resource_record_post_action 02:14:03 INFO - Running post-run listener: _resource_record_post_run 02:14:04 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 28672; Write bytes: 540532736; Read time: 312; Write time: 580664 02:14:04 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 12288; Write bytes: 240615424; Read time: 208; Write time: 362552 02:14:04 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 16384; Write bytes: 299909120; Read time: 104; Write time: 218096 02:14:04 INFO - Running post-run listener: _upload_blobber_files 02:14:04 INFO - Blob upload gear active. 02:14:04 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:14:04 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 02:14:04 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'] 02:14:04 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 02:14:04 INFO - (blobuploader) - INFO - Open directory for files ... 02:14:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:14:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:14:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:14:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:14:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:14:05 INFO - (blobuploader) - INFO - Done attempting. 02:14:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:14:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:14:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:14:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:14:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:14:06 INFO - (blobuploader) - INFO - Done attempting. 02:14:06 INFO - (blobuploader) - INFO - Iteration through files over. 02:14:06 INFO - Return code: 0 02:14:06 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:14:06 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:14:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3892836d9023323a16e24cec40373b2144c5f7787d12e009a38bce363e3643917ad376b2096cbe8371541e975f750412fdb54d00b2eef59d5c33798bfade3586", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/516908ea54594e73ff7696109b375f8e3888cf3f2979d27d9745fcd3277de885be05b51e9998a82d4f3fdc2abab1c0af170a8184012617a1e8857bb0f4613c67"} 02:14:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:14:06 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:14:06 INFO - Contents: 02:14:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3892836d9023323a16e24cec40373b2144c5f7787d12e009a38bce363e3643917ad376b2096cbe8371541e975f750412fdb54d00b2eef59d5c33798bfade3586", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/516908ea54594e73ff7696109b375f8e3888cf3f2979d27d9745fcd3277de885be05b51e9998a82d4f3fdc2abab1c0af170a8184012617a1e8857bb0f4613c67"} 02:14:06 INFO - Running post-run listener: copy_logs_to_upload_dir 02:14:06 INFO - Copying logs to upload dir... 02:14:06 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:14:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.641914 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-02-23 02:14:06.713603) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 02:14:06.717925) ========= 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=0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186 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/3892836d9023323a16e24cec40373b2144c5f7787d12e009a38bce363e3643917ad376b2096cbe8371541e975f750412fdb54d00b2eef59d5c33798bfade3586", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/516908ea54594e73ff7696109b375f8e3888cf3f2979d27d9745fcd3277de885be05b51e9998a82d4f3fdc2abab1c0af170a8184012617a1e8857bb0f4613c67"} build_url:https://queue.taskcluster.net/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3892836d9023323a16e24cec40373b2144c5f7787d12e009a38bce363e3643917ad376b2096cbe8371541e975f750412fdb54d00b2eef59d5c33798bfade3586", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/516908ea54594e73ff7696109b375f8e3888cf3f2979d27d9745fcd3277de885be05b51e9998a82d4f3fdc2abab1c0af170a8184012617a1e8857bb0f4613c67"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 02:14:06.743677) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 02:14:06.743995) ========= 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=0274524eba3bdaad075c2247000001d4-1456221213.788805-379742186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 02:14:06.829968) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 02:14:06.830300) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 02:14:06.830593) ========= ========= Total master_lag: 0.25 =========