builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1456222035.41 results: success (0) buildid: 20160222083110 builduid: 443930374c0d4c20873d4c60c1bf3c68 revision: 135340a254f4b16c86b0c7dd320253c4a1a0776e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.411846) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.412304) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.412642) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008388 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.435221) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.435522) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.453575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.453879) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018306 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.500058) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.500381) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.500774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.501065) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-23 02:07:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2016-02-23 02:07:15 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096959 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.610659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.610969) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.111449 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:15.734812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 02:07:15.735344) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-23 02:07:15,797 truncating revision to first 12 chars 2016-02-23 02:07:15,797 Setting DEBUG logging. 2016-02-23 02:07:15,797 attempt 1/10 2016-02-23 02:07:15,798 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 02:07:17,038 unpacking tar archive at: fx-team-135340a254f4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.600078 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 02:07:17.348557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:17.348856) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 135340a254f4b16c86b0c7dd320253c4a1a0776e program finished with exit code 0 elapsedTime=0.003577 script_repo_revision: '135340a254f4b16c86b0c7dd320253c4a1a0776e' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:17.396425) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:17.396740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 02:07:17.406461) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-23 02:07:17.406844) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:07:17 INFO - MultiFileLogger online at 20160223 02:07:17 in /builds/slave/test-pgo 02:07:17 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 02:07:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:07:17 INFO - {'append_to_log': False, 02:07:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:07:17 INFO - 'blob_upload_branch': 'Fx-Team', 02:07:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:07:17 INFO - 'branch': 'Fx-Team', 02:07:17 INFO - 'buildbot_json_path': 'buildprops.json', 02:07:17 INFO - 'config_files': ('talos/linux_config.py',), 02:07:17 INFO - 'default_actions': ('clobber', 02:07:17 INFO - 'read-buildbot-config', 02:07:17 INFO - 'download-and-extract', 02:07:17 INFO - 'populate-webroot', 02:07:17 INFO - 'create-virtualenv', 02:07:17 INFO - 'install', 02:07:17 INFO - 'run-tests'), 02:07:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:07:17 INFO - 'download_minidump_stackwalk': True, 02:07:17 INFO - 'download_symbols': 'ondemand', 02:07:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:07:17 INFO - 'tooltool.py': '/tools/tooltool.py', 02:07:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:07:17 INFO - '/tools/misc-python/virtualenv.py')}, 02:07:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:07:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:07:17 INFO - 'installer_path': 'installer.exe', 02:07:17 INFO - 'log_level': 'info', 02:07:17 INFO - 'log_name': 'talos', 02:07:17 INFO - 'log_to_console': True, 02:07:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:07:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:07:17 INFO - 'opt_config_files': (), 02:07:17 INFO - 'pip_index': False, 02:07:17 INFO - 'sps_profile': False, 02:07:17 INFO - 'sps_profile_interval': 0, 02:07:17 INFO - 'suite': 'dromaeojs', 02:07:17 INFO - 'system_bits': '32', 02:07:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:07:17 INFO - 'title': 'talos-linux64-ix-013', 02:07:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:07:17 INFO - 'use_talos_json': True, 02:07:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:07:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:07:17 INFO - 'work_dir': 'build'} 02:07:17 INFO - ##### 02:07:17 INFO - ##### Running clobber step. 02:07:17 INFO - ##### 02:07:17 INFO - Running pre-action listener: _resource_record_pre_action 02:07:17 INFO - Running main action method: clobber 02:07:17 INFO - rmtree: /builds/slave/test-pgo/build 02:07:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:07:22 INFO - Running post-action listener: _resource_record_post_action 02:07:22 INFO - ##### 02:07:22 INFO - ##### Running read-buildbot-config step. 02:07:22 INFO - ##### 02:07:22 INFO - Running pre-action listener: _resource_record_pre_action 02:07:22 INFO - Running main action method: read_buildbot_config 02:07:22 INFO - Using buildbot properties: 02:07:22 INFO - { 02:07:22 INFO - "project": "", 02:07:22 INFO - "product": "firefox", 02:07:22 INFO - "script_repo_revision": "production", 02:07:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:07:22 INFO - "repository": "", 02:07:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:07:22 INFO - "buildid": "20160222083110", 02:07:22 INFO - "pgo_build": "True", 02:07:22 INFO - "basedir": "/builds/slave/test-pgo", 02:07:22 INFO - "buildnumber": 511, 02:07:22 INFO - "slavename": "talos-linux64-ix-013", 02:07:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:07:22 INFO - "platform": "ubuntu64_hw", 02:07:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:07:22 INFO - "branch": "fx-team", 02:07:22 INFO - "repo_path": "integration/fx-team", 02:07:22 INFO - "revision": "135340a254f4b16c86b0c7dd320253c4a1a0776e", 02:07:22 INFO - "stage_platform": "linux64-pgo", 02:07:22 INFO - "builduid": "443930374c0d4c20873d4c60c1bf3c68", 02:07:22 INFO - "slavebuilddir": "test" 02:07:22 INFO - } 02:07:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 02:07:22 INFO - Running post-action listener: _resource_record_post_action 02:07:22 INFO - ##### 02:07:22 INFO - ##### Running download-and-extract step. 02:07:22 INFO - ##### 02:07:22 INFO - Running pre-action listener: _resource_record_pre_action 02:07:22 INFO - Running main action method: download_and_extract 02:07:22 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:22 INFO - https://queue.taskcluster.net/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:07:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/test_packages.json 02:07:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/test_packages.json 02:07:22 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 02:07:22 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 02:07:23 INFO - Downloaded 1448 bytes. 02:07:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:07:23 INFO - Using the following test package requirements: 02:07:23 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:07:23 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:07:23 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:07:23 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:23 INFO - u'jsshell-linux-x86_64.zip'], 02:07:23 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:07:23 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:07:23 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:07:23 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:07:23 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:07:23 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:07:23 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:07:23 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:23 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 02:07:23 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 02:07:23 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 02:07:23 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 02:07:23 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 02:07:24 INFO - Downloaded 23366288 bytes. 02:07:24 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'] 02:07:24 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 02:07:25 INFO - Return code: 0 02:07:25 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 02:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:25 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 02:07:25 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 02:07:25 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 02:07:25 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 02:07:25 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 02:07:27 INFO - Downloaded 23366288 bytes. 02:07:27 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'] 02:07:27 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 02:07:28 INFO - Return code: 0 02:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:28 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 02:07:28 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 02:07:28 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 02:07:28 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 02:07:28 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 02:07:29 INFO - Downloaded 10707015 bytes. 02:07:29 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'] 02:07:29 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 02:07:29 INFO - Return code: 0 02:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:29 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 02:07:29 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 02:07:29 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 02:07:29 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 02:07:29 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 02:07:31 INFO - Downloaded 56559816 bytes. 02:07:31 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 02:07:31 INFO - mkdir: /builds/slave/test-pgo/properties 02:07:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:07:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:07:31 INFO - Contents: 02:07:31 INFO - build_url:https://queue.taskcluster.net/v1/task/bOlEHFCIRdSylu1vV7Loqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:07:32 INFO - Running post-action listener: _resource_record_post_action 02:07:32 INFO - Running post-action listener: set_extra_try_arguments 02:07:32 INFO - ##### 02:07:32 INFO - ##### Running populate-webroot step. 02:07:32 INFO - ##### 02:07:32 INFO - Running pre-action listener: _resource_record_pre_action 02:07:32 INFO - Running main action method: populate_webroot 02:07:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:07:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:07:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:07:32 INFO - '--tppagecycles', 02:07:32 INFO - '7'], 02:07:32 INFO - 'tests': ['tsvgm']}}, 02:07:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:07:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:07:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:07:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:07:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:07:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:07:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:32 INFO - 'talos_options': ['--e10s'], 02:07:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:32 INFO - 'tests': ['damp', 'tps']}, 02:07:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:32 INFO - 'talos_options': ['--e10s'], 02:07:32 INFO - 'tests': ['damp', 'tps']}, 02:07:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:07:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:07:32 INFO - 'other': {'tests': ['a11yr', 02:07:32 INFO - 'ts_paint', 02:07:32 INFO - 'tpaint', 02:07:32 INFO - 'sessionrestore', 02:07:32 INFO - 'sessionrestore_no_auto_restore']}, 02:07:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:07:32 INFO - 'tests': ['a11yr', 02:07:32 INFO - 'ts_paint', 02:07:32 INFO - 'tpaint', 02:07:32 INFO - 'sessionrestore', 02:07:32 INFO - 'sessionrestore_no_auto_restore']}, 02:07:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:07:32 INFO - 'tests': ['a11yr', 02:07:32 INFO - 'ts_paint', 02:07:32 INFO - 'tpaint', 02:07:32 INFO - 'sessionrestore', 02:07:32 INFO - 'sessionrestore_no_auto_restore']}, 02:07:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:07:32 INFO - 'tests': ['a11yr', 02:07:32 INFO - 'ts_paint', 02:07:32 INFO - 'tpaint', 02:07:32 INFO - 'sessionrestore', 02:07:32 INFO - 'sessionrestore_no_auto_restore']}, 02:07:32 INFO - 'other_l64': {'tests': ['a11yr', 02:07:32 INFO - 'ts_paint', 02:07:32 INFO - 'tpaint', 02:07:32 INFO - 'sessionrestore', 02:07:32 INFO - 'sessionrestore_no_auto_restore']}, 02:07:32 INFO - 'other_nol64': {'tests': ['a11yr', 02:07:32 INFO - 'ts_paint', 02:07:32 INFO - 'tpaint', 02:07:32 INFO - 'sessionrestore', 02:07:32 INFO - 'sessionrestore_no_auto_restore']}, 02:07:32 INFO - 'svgr': {'tests': ['tsvgx', 02:07:32 INFO - 'tsvgr_opacity', 02:07:32 INFO - 'tart', 02:07:32 INFO - 'tscrollx', 02:07:32 INFO - 'cart']}, 02:07:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:07:32 INFO - 'tests': ['tsvgx', 02:07:32 INFO - 'tsvgr_opacity', 02:07:32 INFO - 'tart', 02:07:32 INFO - 'tscrollx', 02:07:32 INFO - 'cart']}, 02:07:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:32 INFO - 'tests': ['tp5o']}, 02:07:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:32 INFO - 'talos_options': ['--e10s'], 02:07:32 INFO - 'tests': ['tp5o']}, 02:07:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:32 INFO - 'talos_options': ['--xperf_path', 02:07:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:32 INFO - 'tests': ['tp5n']}, 02:07:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:32 INFO - 'talos_options': ['--e10s', 02:07:32 INFO - '--xperf_path', 02:07:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:32 INFO - 'tests': ['tp5n']}}, 02:07:32 INFO - 'talos.zip': {'path': '', 02:07:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:07:32 INFO - Running post-action listener: _resource_record_post_action 02:07:32 INFO - ##### 02:07:32 INFO - ##### Running create-virtualenv step. 02:07:32 INFO - ##### 02:07:32 INFO - Running pre-action listener: _resource_record_pre_action 02:07:32 INFO - Running main action method: create_virtualenv 02:07:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:07:32 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 02:07:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:07:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:07:32 INFO - Using real prefix '/usr' 02:07:32 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:07:32 INFO - Installing distribute.............................................................................................................................................................................................done. 02:07:34 INFO - Installing pip.................done. 02:07:34 INFO - Return code: 0 02:07:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:07:34 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')]} 02:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:34 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')]} 02:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:34 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 0x7fcaf0b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23408c0>, '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 0x23417c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2341c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', '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 02:07:34 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 02:07:34 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 02:07:34 INFO - Using env: {'DISPLAY': ':0', 02:07:34 INFO - 'HOME': '/home/cltbld', 02:07:34 INFO - 'LANG': 'en_US.UTF-8', 02:07:34 INFO - 'LANGUAGE': 'en_US:en', 02:07:34 INFO - 'LOGNAME': 'cltbld', 02:07:34 INFO - 'MAIL': '/var/mail/cltbld', 02:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:34 INFO - 'MOZ_NO_REMOTE': '1', 02:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:34 INFO - 'NO_EM_RESTART': '1', 02:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:07:34 INFO - 'PWD': '/builds/slave/test-pgo', 02:07:34 INFO - 'SHELL': '/bin/bash', 02:07:34 INFO - 'SHLVL': '1', 02:07:34 INFO - 'TERM': 'linux', 02:07:34 INFO - 'TMOUT': '86400', 02:07:34 INFO - 'USER': 'cltbld', 02:07:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', 02:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:34 INFO - '_': '/tools/buildbot/bin/python'} 02:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:34 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 02:07:34 INFO - Cleaning up... 02:07:34 INFO - Return code: 0 02:07:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:07:34 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')]} 02:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:34 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')]} 02:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:34 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 0x7fcaf0b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23408c0>, '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 0x23417c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2341c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', '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 02:07:34 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 02:07:34 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 02:07:34 INFO - Using env: {'DISPLAY': ':0', 02:07:34 INFO - 'HOME': '/home/cltbld', 02:07:34 INFO - 'LANG': 'en_US.UTF-8', 02:07:34 INFO - 'LANGUAGE': 'en_US:en', 02:07:34 INFO - 'LOGNAME': 'cltbld', 02:07:34 INFO - 'MAIL': '/var/mail/cltbld', 02:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:34 INFO - 'MOZ_NO_REMOTE': '1', 02:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:34 INFO - 'NO_EM_RESTART': '1', 02:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:07:34 INFO - 'PWD': '/builds/slave/test-pgo', 02:07:34 INFO - 'SHELL': '/bin/bash', 02:07:34 INFO - 'SHLVL': '1', 02:07:34 INFO - 'TERM': 'linux', 02:07:34 INFO - 'TMOUT': '86400', 02:07:34 INFO - 'USER': 'cltbld', 02:07:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', 02:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:34 INFO - '_': '/tools/buildbot/bin/python'} 02:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:35 INFO - Downloading/unpacking psutil>=0.7.1 02:07:35 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 02:07:35 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 02:07:35 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 02:07:35 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 02:07:35 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 02:07:35 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 02:07:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:07:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:37 INFO - Installing collected packages: psutil 02:07:37 INFO - Running setup.py install for psutil 02:07:37 INFO - building 'psutil._psutil_linux' extension 02:07:37 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 02:07:37 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 02:07:37 INFO - building 'psutil._psutil_posix' extension 02:07:37 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 02:07:37 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 02:07:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:37 INFO - Successfully installed psutil 02:07:37 INFO - Cleaning up... 02:07:37 INFO - Return code: 0 02:07:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:07:37 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')]} 02:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:37 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')]} 02:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:37 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 0x7fcaf0b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23408c0>, '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 0x23417c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2341c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', '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 02:07:37 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 02:07:37 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 02:07:37 INFO - Using env: {'DISPLAY': ':0', 02:07:37 INFO - 'HOME': '/home/cltbld', 02:07:37 INFO - 'LANG': 'en_US.UTF-8', 02:07:37 INFO - 'LANGUAGE': 'en_US:en', 02:07:37 INFO - 'LOGNAME': 'cltbld', 02:07:37 INFO - 'MAIL': '/var/mail/cltbld', 02:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:37 INFO - 'MOZ_NO_REMOTE': '1', 02:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:37 INFO - 'NO_EM_RESTART': '1', 02:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:07:37 INFO - 'PWD': '/builds/slave/test-pgo', 02:07:37 INFO - 'SHELL': '/bin/bash', 02:07:37 INFO - 'SHLVL': '1', 02:07:37 INFO - 'TERM': 'linux', 02:07:37 INFO - 'TMOUT': '86400', 02:07:37 INFO - 'USER': 'cltbld', 02:07:37 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', 02:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:37 INFO - '_': '/tools/buildbot/bin/python'} 02:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:07:37 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 02:07:37 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 02:07:37 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 02:07:37 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 02:07:37 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 02:07:37 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 02:07:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:07:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:07:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:07:39 INFO - Installing collected packages: mozsystemmonitor 02:07:39 INFO - Running setup.py install for mozsystemmonitor 02:07:39 INFO - Successfully installed mozsystemmonitor 02:07:39 INFO - Cleaning up... 02:07:39 INFO - Return code: 0 02:07:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:07:39 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')]} 02:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:39 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')]} 02:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:39 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 0x7fcaf0b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23408c0>, '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 0x23417c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2341c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', '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 02:07:39 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 02:07:39 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 02:07:39 INFO - Using env: {'DISPLAY': ':0', 02:07:39 INFO - 'HOME': '/home/cltbld', 02:07:39 INFO - 'LANG': 'en_US.UTF-8', 02:07:39 INFO - 'LANGUAGE': 'en_US:en', 02:07:39 INFO - 'LOGNAME': 'cltbld', 02:07:39 INFO - 'MAIL': '/var/mail/cltbld', 02:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:39 INFO - 'MOZ_NO_REMOTE': '1', 02:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:39 INFO - 'NO_EM_RESTART': '1', 02:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:07:39 INFO - 'PWD': '/builds/slave/test-pgo', 02:07:39 INFO - 'SHELL': '/bin/bash', 02:07:39 INFO - 'SHLVL': '1', 02:07:39 INFO - 'TERM': 'linux', 02:07:39 INFO - 'TMOUT': '86400', 02:07:39 INFO - 'USER': 'cltbld', 02:07:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', 02:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:39 INFO - '_': '/tools/buildbot/bin/python'} 02:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:39 INFO - Downloading/unpacking blobuploader==1.2.4 02:07:39 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 02:07:39 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 02:07:39 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 02:07:39 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 02:07:39 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 02:07:39 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 02:07:41 INFO - Downloading blobuploader-1.2.4.tar.gz 02:07:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:07:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:07:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:42 INFO - Downloading docopt-0.6.1.tar.gz 02:07:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:07:42 INFO - Installing collected packages: blobuploader, requests, docopt 02:07:42 INFO - Running setup.py install for blobuploader 02:07:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:07:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:07:42 INFO - Running setup.py install for requests 02:07:42 INFO - Running setup.py install for docopt 02:07:43 INFO - Successfully installed blobuploader requests docopt 02:07:43 INFO - Cleaning up... 02:07:43 INFO - Return code: 0 02:07:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:07: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')]} 02:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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')]} 02:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:43 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 0x7fcaf0b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23408c0>, '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 0x23417c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2341c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', '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 02:07:43 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 02:07:43 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 02:07:43 INFO - Using env: {'DISPLAY': ':0', 02:07:43 INFO - 'HOME': '/home/cltbld', 02:07:43 INFO - 'LANG': 'en_US.UTF-8', 02:07:43 INFO - 'LANGUAGE': 'en_US:en', 02:07:43 INFO - 'LOGNAME': 'cltbld', 02:07:43 INFO - 'MAIL': '/var/mail/cltbld', 02:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:43 INFO - 'MOZ_NO_REMOTE': '1', 02:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:43 INFO - 'NO_EM_RESTART': '1', 02:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:07:43 INFO - 'PWD': '/builds/slave/test-pgo', 02:07:43 INFO - 'SHELL': '/bin/bash', 02:07:43 INFO - 'SHLVL': '1', 02:07:43 INFO - 'TERM': 'linux', 02:07:43 INFO - 'TMOUT': '86400', 02:07:43 INFO - 'USER': 'cltbld', 02:07:43 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', 02:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:43 INFO - '_': '/tools/buildbot/bin/python'} 02:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:07:43 INFO - Running setup.py (path:/tmp/pip-rMh9ws-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:07:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:07:43 INFO - Running setup.py (path:/tmp/pip-6x1Jgk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:07:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:07:43 INFO - Running setup.py (path:/tmp/pip-Na_yPB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:07:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:07:43 INFO - Running setup.py (path:/tmp/pip-V0UkPW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:07:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:07:43 INFO - Running setup.py (path:/tmp/pip-QSMzse-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:07:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:07:43 INFO - Running setup.py (path:/tmp/pip-w1FMAA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:07:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:07:43 INFO - Running setup.py (path:/tmp/pip-fC_jTq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:07:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:07:43 INFO - Running setup.py (path:/tmp/pip-sBLSgV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:07:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:07:43 INFO - Running setup.py (path:/tmp/pip-0H6v3I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:07:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:07:43 INFO - Running setup.py (path:/tmp/pip-RrTxQp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:07:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:07:44 INFO - Running setup.py (path:/tmp/pip-WwcuGn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:07:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:07:44 INFO - Running setup.py (path:/tmp/pip-KRKg0U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:07:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:07:44 INFO - Running setup.py (path:/tmp/pip-hqVcWq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:07:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:07:44 INFO - Running setup.py (path:/tmp/pip-G_YqHV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:07:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:07:44 INFO - Running setup.py (path:/tmp/pip-TdrXjO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:07:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:07:44 INFO - Running setup.py (path:/tmp/pip-HGkO_A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:07:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:07:44 INFO - Running setup.py (path:/tmp/pip-Vdja22-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:07:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:07:44 INFO - Running setup.py install for manifestparser 02:07:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:07:44 INFO - Running setup.py install for mozcrash 02:07:44 INFO - Running setup.py install for mozdebug 02:07:44 INFO - Running setup.py install for mozdevice 02:07:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:07:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:07:44 INFO - Running setup.py install for mozfile 02:07:45 INFO - Running setup.py install for mozhttpd 02:07:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:07:45 INFO - Running setup.py install for mozinfo 02:07:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:07:45 INFO - Running setup.py install for mozInstall 02:07:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:07:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:07:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:07:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:07:45 INFO - Running setup.py install for mozleak 02:07:45 INFO - Running setup.py install for mozlog 02:07:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:07:45 INFO - Running setup.py install for moznetwork 02:07:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:07:45 INFO - Running setup.py install for mozprocess 02:07:45 INFO - Running setup.py install for mozprofile 02:07:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:07:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:07:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:07:45 INFO - Running setup.py install for mozrunner 02:07:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:07:46 INFO - Running setup.py install for mozscreenshot 02:07:46 INFO - Running setup.py install for moztest 02:07:46 INFO - Running setup.py install for mozversion 02:07:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:07:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:07:46 INFO - Cleaning up... 02:07:46 INFO - Return code: 0 02:07:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:07: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')]} 02:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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')]} 02:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:46 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 0x7fcaf0b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23408c0>, '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 0x23417c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2341c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', '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 02:07:46 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 02:07:46 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 02:07:46 INFO - Using env: {'DISPLAY': ':0', 02:07:46 INFO - 'HOME': '/home/cltbld', 02:07:46 INFO - 'LANG': 'en_US.UTF-8', 02:07:46 INFO - 'LANGUAGE': 'en_US:en', 02:07:46 INFO - 'LOGNAME': 'cltbld', 02:07:46 INFO - 'MAIL': '/var/mail/cltbld', 02:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:46 INFO - 'MOZ_NO_REMOTE': '1', 02:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:46 INFO - 'NO_EM_RESTART': '1', 02:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:07:46 INFO - 'PWD': '/builds/slave/test-pgo', 02:07:46 INFO - 'SHELL': '/bin/bash', 02:07:46 INFO - 'SHLVL': '1', 02:07:46 INFO - 'TERM': 'linux', 02:07:46 INFO - 'TMOUT': '86400', 02:07:46 INFO - 'USER': 'cltbld', 02:07:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', 02:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:46 INFO - '_': '/tools/buildbot/bin/python'} 02:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:07:46 INFO - Running setup.py (path:/tmp/pip-H5u4_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:07:46 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)) 02:07:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:07:46 INFO - Running setup.py (path:/tmp/pip-avP0gM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:07:46 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)) 02:07:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:07:46 INFO - Running setup.py (path:/tmp/pip-L5Bc5F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:07:46 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)) 02:07:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:07:46 INFO - Running setup.py (path:/tmp/pip-H0YEYf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:07:46 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)) 02:07:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:07:46 INFO - Running setup.py (path:/tmp/pip-QcICmT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:07:46 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)) 02:07:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:07:46 INFO - Running setup.py (path:/tmp/pip-Q9FioS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:07:46 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)) 02:07:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:07:46 INFO - Running setup.py (path:/tmp/pip-3TwdkD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:07:47 INFO - Running setup.py (path:/tmp/pip-rUsNih-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:07:47 INFO - Running setup.py (path:/tmp/pip-xyg0l3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:07:47 INFO - Running setup.py (path:/tmp/pip-0DFhnL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:07:47 INFO - Running setup.py (path:/tmp/pip-b4rZFt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:07:47 INFO - Running setup.py (path:/tmp/pip-4KxUOt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:07:47 INFO - Running setup.py (path:/tmp/pip-jfP_a2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:07:47 INFO - Running setup.py (path:/tmp/pip-fBBVG9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:07:47 INFO - Running setup.py (path:/tmp/pip-gzmQp1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:07:47 INFO - Running setup.py (path:/tmp/pip-22d3S8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:07:47 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)) 02:07:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:07:47 INFO - Running setup.py (path:/tmp/pip-z2kHZt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:07:47 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)) 02:07:47 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)) 02:07:47 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)) 02:07:47 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)) 02:07:47 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)) 02:07:47 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)) 02:07:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:07:47 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 02:07:47 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 02:07:47 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 02:07:47 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 02:07:47 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 02:07:47 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 02:07:49 INFO - Downloading blessings-1.6.tar.gz 02:07:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:07:49 INFO - Installing collected packages: blessings 02:07:49 INFO - Running setup.py install for blessings 02:07:49 INFO - Successfully installed blessings 02:07:49 INFO - Cleaning up... 02:07:49 INFO - Return code: 0 02:07:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:07:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:07:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:07:50 INFO - Reading from file tmpfile_stdout 02:07:50 INFO - Current package versions: 02:07:50 INFO - argparse == 1.2.1 02:07:50 INFO - blessings == 1.6 02:07:50 INFO - blobuploader == 1.2.4 02:07:50 INFO - docopt == 0.6.1 02:07:50 INFO - manifestparser == 1.1 02:07:50 INFO - mozInstall == 1.12 02:07:50 INFO - mozcrash == 0.16 02:07:50 INFO - mozdebug == 0.1 02:07:50 INFO - mozdevice == 0.48 02:07:50 INFO - mozfile == 1.2 02:07:50 INFO - mozhttpd == 0.7 02:07:50 INFO - mozinfo == 0.9 02:07:50 INFO - mozleak == 0.1 02:07:50 INFO - mozlog == 3.1 02:07:50 INFO - moznetwork == 0.27 02:07:50 INFO - mozprocess == 0.22 02:07:50 INFO - mozprofile == 0.28 02:07:50 INFO - mozrunner == 6.11 02:07:50 INFO - mozscreenshot == 0.1 02:07:50 INFO - mozsystemmonitor == 0.0 02:07:50 INFO - moztest == 0.7 02:07:50 INFO - mozversion == 1.4 02:07:50 INFO - psutil == 3.1.1 02:07:50 INFO - requests == 1.2.3 02:07:50 INFO - wsgiref == 0.1.2 02:07:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:07:50 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')]} 02:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:50 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')]} 02:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:50 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 0x7fcaf0b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23408c0>, '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 0x23417c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2341c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', '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 02:07:50 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 02:07:50 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 02:07:50 INFO - Using env: {'DISPLAY': ':0', 02:07:50 INFO - 'HOME': '/home/cltbld', 02:07:50 INFO - 'LANG': 'en_US.UTF-8', 02:07:50 INFO - 'LANGUAGE': 'en_US:en', 02:07:50 INFO - 'LOGNAME': 'cltbld', 02:07:50 INFO - 'MAIL': '/var/mail/cltbld', 02:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:50 INFO - 'MOZ_NO_REMOTE': '1', 02:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:50 INFO - 'NO_EM_RESTART': '1', 02:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:07:50 INFO - 'PWD': '/builds/slave/test-pgo', 02:07:50 INFO - 'SHELL': '/bin/bash', 02:07:50 INFO - 'SHLVL': '1', 02:07:50 INFO - 'TERM': 'linux', 02:07:50 INFO - 'TMOUT': '86400', 02:07:50 INFO - 'USER': 'cltbld', 02:07:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', 02:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:50 INFO - '_': '/tools/buildbot/bin/python'} 02:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 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)) 02:07:50 INFO - Cleaning up... 02:07:50 INFO - Return code: 0 02:07:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:07:50 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')]} 02:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:50 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')]} 02:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:50 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 0x7fcaf0b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23408c0>, '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 0x23417c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2341c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', '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 02:07:50 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 02:07:50 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 02:07:50 INFO - Using env: {'DISPLAY': ':0', 02:07:50 INFO - 'HOME': '/home/cltbld', 02:07:50 INFO - 'LANG': 'en_US.UTF-8', 02:07:50 INFO - 'LANGUAGE': 'en_US:en', 02:07:50 INFO - 'LOGNAME': 'cltbld', 02:07:50 INFO - 'MAIL': '/var/mail/cltbld', 02:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:50 INFO - 'MOZ_NO_REMOTE': '1', 02:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:50 INFO - 'NO_EM_RESTART': '1', 02:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:07:50 INFO - 'PWD': '/builds/slave/test-pgo', 02:07:50 INFO - 'SHELL': '/bin/bash', 02:07:50 INFO - 'SHLVL': '1', 02:07:50 INFO - 'TERM': 'linux', 02:07:50 INFO - 'TMOUT': '86400', 02:07:50 INFO - 'USER': 'cltbld', 02:07:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', 02:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:50 INFO - '_': '/tools/buildbot/bin/python'} 02:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:50 INFO - Downloading/unpacking jsonschema 02:07:50 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 02:07:50 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 02:07:50 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 02:07:50 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 02:07:50 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 02:07:50 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 02:07:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:07:52 INFO - Downloading/unpacking functools32 (from jsonschema) 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:52 INFO - Downloading functools32-3.2.3-2.tar.gz 02:07:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:07:52 INFO - warning: no files found matching '*.txt' 02:07:52 INFO - no previously-included directories found matching 'build' 02:07:52 INFO - no previously-included directories found matching 'dist' 02:07:52 INFO - no previously-included directories found matching '.git*' 02:07:52 INFO - Installing collected packages: jsonschema, functools32 02:07:52 INFO - Running setup.py install for functools32 02:07:52 INFO - warning: no files found matching '*.txt' 02:07:52 INFO - no previously-included directories found matching 'build' 02:07:52 INFO - no previously-included directories found matching 'dist' 02:07:52 INFO - no previously-included directories found matching '.git*' 02:07:52 INFO - Successfully installed jsonschema functools32 02:07:52 INFO - Cleaning up... 02:07:52 INFO - Return code: 0 02:07:52 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:07: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')]} 02:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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')]} 02:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcaf0b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23408c0>, '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 0x23417c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2341c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', '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 02:07: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', 'flake8'] in /builds/slave/test-pgo/build 02:07: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 flake8 02:07:52 INFO - Using env: {'DISPLAY': ':0', 02:07:52 INFO - 'HOME': '/home/cltbld', 02:07:52 INFO - 'LANG': 'en_US.UTF-8', 02:07:52 INFO - 'LANGUAGE': 'en_US:en', 02:07:52 INFO - 'LOGNAME': 'cltbld', 02:07:52 INFO - 'MAIL': '/var/mail/cltbld', 02:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:52 INFO - 'MOZ_NO_REMOTE': '1', 02:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:52 INFO - 'NO_EM_RESTART': '1', 02:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:07:52 INFO - 'PWD': '/builds/slave/test-pgo', 02:07:52 INFO - 'SHELL': '/bin/bash', 02:07:52 INFO - 'SHLVL': '1', 02:07:52 INFO - 'TERM': 'linux', 02:07:52 INFO - 'TMOUT': '86400', 02:07:52 INFO - 'USER': 'cltbld', 02:07:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', 02:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:52 INFO - '_': '/tools/buildbot/bin/python'} 02:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:53 INFO - Downloading/unpacking flake8 02:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:07:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:07:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:07:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:55 INFO - no previously-included directories found matching 'docs/_build' 02:07:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:07:55 INFO - Running setup.py install for pep8 02:07:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:55 INFO - no previously-included directories found matching 'docs/_build' 02:07:55 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:07:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:07:55 INFO - Cleaning up... 02:07:55 INFO - Return code: 0 02:07:55 INFO - Running post-action listener: _resource_record_post_action 02:07:55 INFO - Running post-action listener: _start_resource_monitoring 02:07:55 INFO - Starting resource monitoring. 02:07:55 INFO - ##### 02:07:55 INFO - ##### Running install step. 02:07:55 INFO - ##### 02:07:55 INFO - Running pre-action listener: _resource_record_pre_action 02:07:55 INFO - Running main action method: install 02:07:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:07:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:07:56 INFO - Reading from file tmpfile_stdout 02:07:56 INFO - Detecting whether we're running mozinstall >=1.0... 02:07:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:07:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:07:56 INFO - Reading from file tmpfile_stdout 02:07:56 INFO - Output received: 02:07:56 INFO - Usage: mozinstall [options] installer 02:07:56 INFO - Options: 02:07:56 INFO - -h, --help show this help message and exit 02:07:56 INFO - -d DEST, --destination=DEST 02:07:56 INFO - Directory to install application into. [default: 02:07:56 INFO - "/builds/slave/test-pgo"] 02:07:56 INFO - --app=APP Application being installed. [default: firefox] 02:07:56 INFO - mkdir: /builds/slave/test-pgo/build/application 02:07:56 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'] 02:07:56 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 02:08:12 INFO - Reading from file tmpfile_stdout 02:08:12 INFO - Output received: 02:08:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:08:12 INFO - Running post-action listener: _resource_record_post_action 02:08:12 INFO - ##### 02:08:12 INFO - ##### Running run-tests step. 02:08:12 INFO - ##### 02:08:12 INFO - Running pre-action listener: _resource_record_pre_action 02:08:12 INFO - Running main action method: run_tests 02:08:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:08:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:08:12 INFO - Python 2.7.3 02:08:12 INFO - Return code: 0 02:08:12 INFO - grabbing minidump binary from tooltool 02:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:12 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 0x23408c0>, '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 0x23417c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2341c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:08:12 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 02:08:12 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 02:08:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:08:12 INFO - Return code: 0 02:08:12 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:08:12 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:08:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:08:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:08:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:08:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:08:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:08:13 INFO - Return code: 0 02:08:13 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-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 02:08:13 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-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 02:08:13 INFO - Using env: {'DISPLAY': ':0', 02:08:13 INFO - 'HOME': '/home/cltbld', 02:08:13 INFO - 'LANG': 'en_US.UTF-8', 02:08:13 INFO - 'LANGUAGE': 'en_US:en', 02:08:13 INFO - 'LOGNAME': 'cltbld', 02:08:13 INFO - 'MAIL': '/var/mail/cltbld', 02:08:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:08:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:13 INFO - 'MOZ_NO_REMOTE': '1', 02:08:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:13 INFO - 'NO_EM_RESTART': '1', 02:08:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:08:13 INFO - 'PWD': '/builds/slave/test-pgo', 02:08:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:08:13 INFO - 'SHELL': '/bin/bash', 02:08:13 INFO - 'SHLVL': '1', 02:08:13 INFO - 'TERM': 'linux', 02:08:13 INFO - 'TMOUT': '86400', 02:08:13 INFO - 'USER': 'cltbld', 02:08:13 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532', 02:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:13 INFO - '_': '/tools/buildbot/bin/python'} 02:08:13 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-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:08:13 INFO - mozversion application_buildid: 20160222083110 02:08:13 INFO - mozversion application_changeset: 135340a254f4b16c86b0c7dd320253c4a1a0776e 02:08:13 INFO - mozversion application_display_name: Nightly 02:08:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:08:13 INFO - mozversion application_name: Firefox 02:08:13 INFO - mozversion application_remotingname: firefox 02:08:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:08:13 INFO - mozversion application_vendor: Mozilla 02:08:13 INFO - mozversion application_version: 47.0a1 02:08:13 INFO - mozversion platform_buildid: 20160222083110 02:08:13 INFO - mozversion platform_changeset: 135340a254f4b16c86b0c7dd320253c4a1a0776e 02:08:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:08:13 INFO - mozversion platform_version: 47.0a1 02:08:13 INFO - using testdate: 1456222093 02:08:13 INFO - actual date: 1456222093 02:08:13 INFO - starting webserver on 'localhost:39030' 02:08:13 INFO - SUITE-START | Running 2 tests 02:08:13 INFO - TEST-START | dromaeo_css 02:08:13 INFO - operating with platform_type : linux_ 02:08:13 INFO - Initialising browser for dromaeo_css test... 02:08:13 INFO - TEST-INFO | started process 12728 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7ZdT7M/profile http://localhost:39030/getInfo.html) 02:08:17 INFO - PROCESS | 12728 | __metrics Screen width/height:1600/1200 02:08:17 INFO - PROCESS | 12728 | colorDepth:24 02:08:17 INFO - PROCESS | 12728 | Browser inner width/height: 1024/697 02:08:17 INFO - PROCESS | 12728 | __metrics 02:08:18 INFO - PROCESS | 12728 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:08:19 INFO - TEST-INFO | 12728: exit 0 02:08:19 INFO - Browser initialized. 02:08:19 INFO - Running cycle 1/1 for dromaeo_css test... 02:08:19 INFO - TEST-INFO | started process 12825 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7ZdT7M/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:31 INFO - PROCESS | 12825 | RSS: Main: 147169280 02:08:31 INFO - PROCESS | 12825 | 02:09:23 INFO - PROCESS | 12825 | 1456222163329 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] 02:11:31 INFO - PROCESS | 12825 | Cycle 1(1): loaded http://localhost:39030/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39030/tests/dromaeo/cssquery-ext.html) 02:11:32 INFO - PROCESS | 12825 | RSS: Main: 213585920 02:11:32 INFO - PROCESS | 12825 | 02:14:34 INFO - PROCESS | 12825 | Cycle 1(1): loaded http://localhost:39030/tests/dromaeo/cssquery-ext.html (next: http://localhost:39030/tests/dromaeo/cssquery-jquery.html) 02:14:35 INFO - PROCESS | 12825 | RSS: Main: 233418752 02:14:35 INFO - PROCESS | 12825 | 02:17:36 INFO - PROCESS | 12825 | Cycle 1(1): loaded http://localhost:39030/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39030/tests/dromaeo/cssquery-mootools.html) 02:17:37 INFO - PROCESS | 12825 | RSS: Main: 242958336 02:17:37 INFO - PROCESS | 12825 | 02:20:39 INFO - PROCESS | 12825 | Cycle 1(1): loaded http://localhost:39030/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39030/tests/dromaeo/cssquery-prototype.html) 02:20:40 INFO - PROCESS | 12825 | RSS: Main: 210546688 02:20:40 INFO - PROCESS | 12825 | 02:23:42 INFO - PROCESS | 12825 | Cycle 1(1): loaded http://localhost:39030/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39030/tests/dromaeo/cssquery-yui.html) 02:23:43 INFO - PROCESS | 12825 | RSS: Main: 179556352 02:23:43 INFO - PROCESS | 12825 | 02:26:46 INFO - PROCESS | 12825 | Cycle 1(1): loaded http://localhost:39030/tests/dromaeo/cssquery-yui.html (next: http://localhost:39030/tests/dromaeo/cssquery-dojo.html) 02:26:46 INFO - PROCESS | 12825 | RSS: Main: 273743872 02:26:46 INFO - PROCESS | 12825 | 02:26:46 INFO - PROCESS | 12825 | __start_tp_report 02:26:46 INFO - PROCESS | 12825 | _x_x_mozilla_page_load 02:26:46 INFO - PROCESS | 12825 | _x_x_mozilla_page_load_details 02:26:46 INFO - PROCESS | 12825 | |i|pagename|runs| 02:26:46 INFO - PROCESS | 12825 | |0;dojo.html;3125.2811853273747;3173.349463360011;3213.1003319070655;3222.371637530681;3241.189702574357;5040.571551418125;5138.768755406007;5180.300659410974;5183.559397451217;5188.195829646402;5116.1302578561645;5159.226116082589;5172.974135129319;5175.741212939347;5186.429492755794;4671.696339737923;4740.810367585293;4783.28250762385;4831.516848315158;4878.902421951559;4673.719576825401;4720.079584481027;4835.516448355172;4836.782344794493;4949.579285760715;4757.738324392157;4768.0463907218345;4771.832985845496;4771.856844294677;4786.856394308176;4751.904961900777;4762.904741905177;4764.737939413331;4771.141194584973;4779.378680771478;4673.252279635242;4701.036287561076;4736.905261894777;4765.142274390609;4806.7836947337455;4999.375078115236;5000.849974500771;5014.047331007134;5035.974820125876;5078.7460626968505;5471.5896307776675;5550.111982082847;5553.888922221573;5559.054960656698;5559.861003474905;5581.776728930838;5596.6362186458155;5612.466815652507;5637.830865074055;5686.402927692616;5251.737413129366;5309.41596424393;5311.415744268089;5311.787528498894;5314.8937021260135;5570.97214513933;5693.089105743061;5712.914306285409;5737.196792449061;5873.706314684248;5643.830685079454;5653.886922261532;5672.347680016768;5674.00704876645;5678.545716342683;5726.77092916287;5747.3677895431465;5756.539476841926;5760.510356619734;5762.9135562966585;5479.150731636602;5570.192322113352;5582.553395728332;5623.943760562342;5656.575756818255;5581.609287349846;5608.439156084441;5615.522680572116;5617.494425501724;5634;4202.894927626834;4320.373545835836;4374.606285434263;4375.47494300686;4424.336349547593;3872.4384964180035;3888.4361767543546;3893.824777885002;3916.804159791999;3918.804059796999;5180.48195180479;5201.947980520222;5212.635115541876;5214.817481388133;5252.894942101137;5490.780368785284;5564.86087847799;5593.937151941118;5638.520725738358;5695.03184458643;5166.974165129151;5170.250313704491;5183.792648294101;5199.350081239845;5201.921971170435;4683.180443422388;4798.304245884327;4821.9035619287415;4828.806847726122;4851.369321988119;5763.164341170507;5776;5789.739461724233;5839.036558967808;5877.676727779927;5515.558755299486;5586.385497595343;5592.972035139798;5593.412691667317;5597.692126933058;5680.034394153086;5794;5814.895169917702;5836.533077353716;5848.385919478394;5484.396716361117;5490.423505531861;5495.697736624524;5498.5876059296515;5504;5563.248961390161;5564;5574.442555744393;5583.581231407742;5670.631408958569;5339.7063161526485;5424.267723857387;5433.130699088127;5449.128139497661;5490.176473529003;5425.403205647454;5430.076886929152;5432.728363581884;5436.238926550207;5436.53789427903;5263.2631431600375;5286.36563612369;5290.920636190537;5324.068288049653;5382.03123437785;5498.532624726943;5511.972440137773;5525.143602741581;5540.279763630863;5588.916166257591;5281.867953301198;5293.338332708411;5360.517553420211;5364.088105022078;5372.570194384518 02:26:46 INFO - PROCESS | 12825 | |1;ext.html;524.6484855147052;552.2268823646897;573.8938296415163;596.2457491273537;600.4265926040632;35998;36581.45127823078;36857.26285474289;36861.26277474456;36864.26271474569;43108.35337469933;44365.33451998223;44378.77810610951;44431.77784111075;44449.11101777962;8502.659893604265;8630.05069442364;8672.306215502776;8678.696245631372;8683.34874884383;8585.570721463933;8705.042445331008;8707.651693932266;8725.694600688978;8731.476111433334;8711.390202685814;8777.385583009192;8796.25231855293;8798.208161265486;8808.38341316105;8636.481811091355;8684.044755076937;8736.912630873674;8742.475451472868;8750.3874728769;8543.914560854375;8665.870011949826;8671.479711217347;8673;8673.956630216871;39373.60626393728;39731.20537589261;39764.801175994224;39789.20421591552;39800.20399592021;3336.099253201622;3365.882194123194;3763.7741735495956;3903.3364328064013;4033.556308806029;30474.84762576195;30707.692923070706;30802.53796193059;30865.537016944763;31905;3097.396007778484;3180.3480286541435;3216.372807302577;3263.102646772133;3505.964940350615;264611.676941616;266568;268605;269153;269288.72468390927;58110.7094464525;58414.415855840896;58522.12216816751;58535;58569.41430585725;62495;62716;62731.37268627255;62731.37268627347;62788.68605657034;15914.920425397799;16003.919980400024;16075.276612552463;16082.919585401998;16084.597885052968;11173.497192626352;11174.44127793607;11180.440977951233;11181;11239.438028098562;18669.713075369218;20111.899440502704;20252.291169808985;20276;20336.491587710425;6366.490680745529;7400.925990740024;7623.542587444771;7658.693652253847;7734.497257678233;930.6510058727977;1034.6482196053378;1044.3472829481575;1089.2919602258596;1165.5279611757253;28594.28514287118;28674.283142921595;28745.71254287472;29009.41981160365;29301.26746831346;1099.8405231241586;1099.9065079468176;1105.0993440346092;1109.4508218431768;1176.3294921894437;14723.705525889636;15109.233254629054;15186.696266074616;15228.390864365523;15302.387904483696;298733;299432;302091;303394;303838;44748;49532.75233623809;52615.473845261826;52941.47058529365;52945;1344.9125806822722;1351.2703140304322;1361.748076605831;1363.3251540487522;1363.638635761524;25947.351316217246;26159.607605885547;26478.338041549116;26604.467910642066;26816.59775103336;39807.40288895611;39932.40101398539;40019.3997090038;40214.19571608493;40230.798846005586;188932;190529.378824851;190982;191124;191154;27517.587236191073;30672.539911900894;31596.526052109697;31781.205469862514;31799;36864;37677.4348384769;37972;38075.23849523049;38656.42015369715;34743.305133896676;35139.12152196113;35407.82296088503;35464.11339716425;35527;33923.3215335687;35087.64912350844;35405;36028.45957310695;36544.81727591345;32230.677693222766;32999.50500742443;33096.33807323888;33364.1658958528;33426.49860252147;29253.95222334416;31982.200444989063;32064;32080.51879221767;32338.83830580832;25106.62340064864;32482.187945301557;32748.578941842545;32906.835465822514;33490.16274593155 02:26:46 INFO - PROCESS | 12825 | |2;jquery.html;352.940000199966;356.21276977878887;369.5583777386023;374.16374403208823;374.51874341471216;14024.298785060731;16602.91698541507;16927.153642317895;17309.567260818487;18627.348042818503;16234.675306493864;16565.66868662626;16678;16742.83257167428;16803.32786688534;5266.52601265886;5447.536959358439;5476.069068258385;5477.315335583052;5487.286652735139;3951.6443520083185;4807.61539076873;5823.272090988627;6043.214382130317;6046.39536046394;5959.046552551593;5980.222571065756;5980.401959804029;5984.611000284989;6004.369541198177;5959.731812068446;6570.671466426684;6777.2545020047755;6818.795436136874;6825.829354266133;6445.903311450332;6467.676616169219;6473.28793832678;6476.579022363579;6478.611283323015;22360.664590031163;22504.887475562682;23077.76922230773;23184.304470865733;23199.76800231993;2362.6337917622623;2404.302752201859;2419.129113519132;2606.27024433159;2638.894444222248;12902.290374029424;13476.191428514321;13960.511382101678;14515.854841451555;14723.190224537646;1916;2063.0716177720087;2148;2194.7476040255415;2196.5936301784063;68581.65709171472;69482.65258673725;71508;72091.27908720898;73284.6335768323;15218.771718424232;15308;15858.207089645703;15922.920385397998;15971.760423593656;24253;24672;24834.627480587806;24896.626550601755;24903.750962490507;9222.44665320083;9311.115444032806;9323.953380233192;9361.297902657328;9389.483578403253;8069.677212911418;8115.3507719382305;8134.755957321171;8136.633851476698;8200.343972482187;7789.922100778919;7912.129665736765;7940.1265860755275;7952.602369881482;7957.283844454027;1856.6843636581543;1877.6244751049844;1905.247427266222;2239.1267405711787;2942.735153836165;899.7030979776658;914.1726737302752;974.9707508774748;1009.6012075230243;1013.2957594471918;17266.68264046964;17522.474325770247;17524.561885952953;17530.211140498708;17600.559986000197;945.4941606240628;960.5101398286924;969.3117886300805;981.7349315684868;1015.8019186258608;8182.836343273101;9689.515524223902;9945.850812237823;10001.649942251986;10285.897141028643;424463;426528;431107;444798;455256;55330.72334638301;76683.61658191674;77219;78394;78563.60718196486;1009.106940357774;1032.2980373346197;1042.7862288231047;1044.4412239451856;1048.7535429174138;14929.925350373613;15322.496014711942;15525.922370388076;15926;16128.274227659549;35121.297574047865;35236.29527409489;36085.81957090198;36322.8183859079;36404;46434.53565464437;46887.76556117334;47315.52684473111;47485;47670.761646191546;7779.72770953014;7844.137144913941;8032.317253033558;8138.226868447488;8169.591520424074;10079.546420410952;11200.21598488098;11489.195756296978;13169.868301316865;13247.138935969131;9869.358491698016;10166.830814456136;10761.139108871428;10829.079528240189;10937.835932460861;9758.951205243928;9944.801103977736;11391.943040285078;11669.59156429521;11713;10999.61501347481;11086.22396432242;11100.833487497855;11319;11445.084393248686;7958.204179581995;8013.318867896294;8020.959895200486;8148.144444833207;8276.586170691562;10121.392716437038;11278.548858045586;11354.489047993025;11385.658430247106;11641 02:26:46 INFO - PROCESS | 12825 | |3;mootools.html;1326.0916272353434;1448.0298200205862;1453.7455945209585;1633.730434478311;1832.5693462036427;7470.850582988343;7679.385649148068;7686.500377475467;7686.9231307686905;7696.191899850505;7552.169261381244;7714.652840622171;7719.49823261489;7719.92280077199;7729.536227826335;1935.680612698903;1987.473319570315;2194.9780502194935;2245.382519807058;2254.9323520294415;2211.5466329402516;2216.645336746121;2219.4007617943225;2220.822334213267;2222.977770222293;2192.7478339990867;2208.845380823343;2282.3038973113194;2282.543491301738;2284.097781376355;2210.049678638185;2247.381969958258;2279.509905370345;2281.8973146208377;2282.6461898405773;2172.1637169689625;2176.4341271269427;2190.1020581561484;2192.48476607997;2193.396815875631;7897.842043159105;7947.165547617475;7954.363650907913;7959.920400795976;7962.203779622049;4586.4266966629175;4680.7191568506;4716.622670186377;4723.244280915072;4726.582025392368;2920.897768578111;3043.1479185827784;3066.294752207005;3075.2311922019494;3084.9691503084905;922.2115091596655;936.737713440231;941.6657086734248;942.8350038743192;1001.6193846338417;10271.948640256825;10299.3820370778;10347.4826258686;10351.430671313075;10358.119559837423;3939.7242193046213;4001.639852413297;4048.4939382577177;4060.817263223162;4079.530853951774;8343.54110523927;8485.830283394422;8521.36089793268;8532.744017679479;8548.700795472128;4551.0215303709865;4575.9084818303445;4618.468876079227;4623.838165664253;4635.6523260755575;3721.925561488755;4181.623653871166;4229.59818817218;4291.892702682458;4292.506361768436;3434.742394320436;3470.219200679827;3486.6687664671817;3516.2967406518796;3517.402041652925;1003.5484032185545;1005.5424781724298;1011.3375738891039;1012.5645972232011;1013.5945621751212;1266.0820904843915;1289.1813698301457;1302.0039669652724;1349.5748839115647;1372.876441120304;7330.230325815819;7445.8883116753295;7530.058742657168;7535.284148005931;7545.924540754632;416.2112796251087;423.14735807348217;423.6208593309033;428.86276391555026;440.4978324709833;5851.795187168429;5899.026660601038;5902.3507414184405;5939.524838012949;5947.613405128653;8846.336524760669;9007.05425930281;9148.588313525906;9293.628254869729;9303.162715355515;9310.115539023782;9311.580978855967;9333.486658233862;9381.577828997712;9387.62449502026;7425.071866016748;7493.962530187423;7539.509931854522;7546.962265188639;7635.160132385433;7417.666205020895;7436.665350059152;7448.92551074504;7464.888026679496;7479.252074792477;7894.565798881116;8077.596120193849;8284.46151000183;8315.126911674188;8330.208630180123;8268.83462330762;8345.123762005145;8353.37349698763;8408.201220884006;8410.369222308474;6151.138840562236;6472.126262954629;6576.473882089325;6603.80188594343;6686.966565167143;7419.517731347445;7466.962665186639;7489.400847932261;7527.698892044257;7531.058617672791;6501.382368674968;6670.799876003728;6676;6750.628715420699;6818.693158807766;6760.391564759196;6760.864782704417;6795.898061528982;6819.965900170468;6910.585364878123;6684.699188536625;6717.2946840581035;6767.323267673193;6792.592444453348;6798.354156355138;6202.72087756043;6232.8130156095385;6252.937470625236;6270.216222972129;6300.338464461165;6589.27517973013;6603.702833372606;6617.66911654425;6621.106150669598;6625 02:26:46 INFO - PROCESS | 12825 | |4;prototype.html;303.5916692049196;304.34869379527817;306.13364179372377;308.10341905056276;310.7684774842742;5787.276590426197;5880.147378630096;5898.11797234103;5908.615939963899;5953.791617293396;5902.173695682608;5907.763689452428;5942;5955.851103722409;5976.3724808895095;4539.137563862863;4543.931841022388;4548.681592288541;4549.1584056949405;4551.522090180533;4310.784460776964;4385.429894113777;4504.572065653774;4522;4526;4469.217886869801;4474.485434175062;4477.932831007537;4484.551544845522;4501.189785838547;4475.977620111911;4479.126570318789;4489.483709373431;4499.707519011254;4501.954980450187;3899.415087736834;3903.1022864740985;3904.1996390739832;3909.4135879618;3910.257051160299;5649.576281778883;5659.377468478505;5661.122526008476;5663.773449062032;5666.206731057614;4889.462159162489;5207.140821764404;5221.425643179247;5227.843164705065;5227.999999999962;6212.87574248517;6221.96889015552;6246.625202487865;6258.123862659231;6258.436740693314;4111.301078816608;4112.280350938604;4113.053997580573;4115;4118.238125946709;6377.139086223347;6485.643289619069;6580.835479113012;6582.440492558138;6583.506237032242;4254.787260636956;4282.486101667758;4287.506936702257;4290.442242508517;4290.978545107317;4324.718893271927;4327.221100201931;4327.675424343124;4329.502107257706;4331.068820203672;5105.974470127626;5110.565601923804;5110.948890511122;5113.616478764107;5114.207297868762;6042.788502402394;6126.295476020315;6284.780032698834;6318.715657795318;6328.240611126602;1500.6023403798001;1509.9396024158912;1515.5756388211319;1515.8787297016213;1517.5750789778658;946.4510583861344;987.916027137687;992.6724181020246;1001.409168590535;1003.4781913405135;5996.190514280604;5997.400259973968;6001.879962400728;6001.939980600138;6006.849828754316;6465.2564955030775;6470.288268290485;6476.5466417350335;6478.255000674889;6479.319671434431;5914.822555323347;5916.970415147896;5919.289685237799;5921.61509501881;5929.229200204032;3472.652734726558;3509.280597477511;3509.78941263525;3511.297740451869;3511.701505372021;6659.101021362151;6757;6777.423918966844;6846.212685541127;6881.41507971828;6668.466522678174;6695.698693558801;6702.497312701566;6705.430038446689;6718.899216511756;6845.760398386033;6848.520603557703;6915.204751453647;6922.7923162305215;6924.792256232321;6558.540902136805;6559.6064236145985;6560.3111673275525;6565.409113179837;6569.770058047945;5873.500752436091;6219.751209951552;6301.747930082745;6505.934940650533;6506.544541882023;6529.183852018497;6737.562058466184;6780.593164409954;6790.117284752951;6791.762288319885;4160.958390416178;4209.137126889042;4219.07180420307;4236.4492615959725;4240.830366785294;6255.24937007562;6382.6170429774365;6530.836729081621;6548.967255163694;6550.246721627074;6341.8731625368155;6378.968105159444;6381.457576106083;6385.45723613498;6391.424771770563;6310.5898116622275;6364.809055728336;6374.553781235454;6379.681015949277;6380.202474690664;6237.625742455467;6266.749330026748;6270.278917924315;6271.059341098689;6275.937240627535;6080.969595151996;6405.871882562229;6407.295197528361;6412.711427985845;6413;6055.303640081447;6061.090836374403;6107.389261073857;6244.907141250354;6256.937430625636 02:26:46 INFO - PROCESS | 12825 | |5;yui.html;708.6138054760155;755.5731011978236;785.3834739729314;800.0958916424439;847.978186285526;13414.66463338417;13729.931350343235;13772.517961871325;13783;13783.793243101336;13001.349932503384;13361.398737056832;13440.462381504753;13453.798193027113;13471.730565388687;694.2814187316129;817.9836403271931;824.5135370131607;839.5760141128721;844.501743971057;827.1315119124924;837.9329653627696;838.3209600223807;839.1147339556766;839.689314953465;869.543489667923;877.0965905117707;877.8727084572733;878.2227728460294;878.508035500122;707.2573797512617;870.1037930931119;879.7976465412927;880.9779755506131;881.0440671871028;645.4158986117571;647.427027081032;648.970796314167;649.9837504062389;650.6584043377264;13494.392752326168;13553.796693049611;13558.728825423435;13595.796063059062;13599.184048957095;12341;12402.13185077045;12405;12758.489660413572;12953.48186072556;10311.690649280534;10365.740856478573;10476.26666133371;10598.841017384746;11125.610603628915;3600.8559657613664;3615.493830863681;3648;3696.4270538066644;3716.368217403021;45896.3115553267;46373.07253854938;46428.5357146431;46557.76721116373;46838.76580617075;9071.591778369857;9446.85829712555;9627.90372096284;9732.659356922615;10021.39871607706;17394.739078913826;17783.55541111457;17893.37373191932;18016;18024.2790288387;7832.686692532349;7976.202379762093;7982.401319901031;8202.548859812649;8359.414840961075;4241.088166044316;4330.523642399334;4339.587739164775;4380.759058251763;4459.10817836434;3144.8427578620976;3183.1246407238195;3183.4906414973493;3186.330870517217;3187.2350635847693;548.347466514846;551.8427248234234;560.5991715923135;583.294214001055;594.5065595555678;524.2189138184078;556.9526590239794;613.7729040255134;637.1939496536885;640.711679744117;7813.687452501837;7884.921150788534;7897.842043159105;7939.523628582304;8235.752927412188;529.1850550152722;574.2821473158551;642.6779905138003;653.3368630839701;669.7321071571411;3685.4103343464917;3708.647678470541;3733.9253214935547;3758.1919887224376;3809.466674665549;50914;51076.74461627742;51784.74107629513;51860.48139518557;52299.47700522946;45632.3155152673;45875;46047;46697;46813.765931170805;41823.58176418258;43115.56884431178;43322.566774331855;43539.56460435355;43831.561684383385;7460.142083660448;7489.063867016623;8148.592570371339;8249.422540422112;8508.787280318042;32559.348813023134;32950.50574241436;33339.49990750092;33614.663853361155;34784.652153479154;39679.40480892847;40987;41258;41274;41487.377689334084;10183.236257280585;10465.895341046493;10563;10579.682609521727;10728.141748660244;11795.41022948832;11996.210261065213;12114.757704845677;12144.33206173669;12304;8778.385513014027;9024;9123.224525915371;10783.406912619881;10830.837537436788;11327.15046371509;11538.192326537397;11826.408679565815;11871.940640296743;12056.276623402624;10578;10612.469376530988;10823;10873.565057397616;10906.727331816768;9610.855837162308;9803.705888823346;9973.60105595797;10025.348352357074;10229.641962531276;8783.780405489659;8985.236254918143;9259.490728010023;9343.953280233556;9503.334766566273 02:26:46 INFO - PROCESS | 12825 | __end_tp_report 02:26:46 INFO - PROCESS | 12825 | __start_cc_report 02:26:46 INFO - PROCESS | 12825 | _x_x_mozilla_cycle_collect,914 02:26:46 INFO - PROCESS | 12825 | __end_cc_report 02:26:46 INFO - PROCESS | 12825 | __startTimestamp1456223206296__endTimestamp 02:26:46 INFO - PROCESS | 12825 | 02:26:46 INFO - PROCESS | 12825 | ------- Summary: start ------- 02:26:46 INFO - PROCESS | 12825 | Number of tests: 6 02:26:46 INFO - PROCESS | 12825 | 02:26:46 INFO - PROCESS | 12825 | [#0] dojo.html Cycles:165 Average:5197.19 Median:5360.52 stddev:567.39 (10.6%) stddev-sans-first:545.35 02:26:46 INFO - PROCESS | 12825 | Values: 3125.3 3173.3 3213.1 3222.4 3241.2 5040.6 5138.8 5180.3 5183.6 5188.2 5116.1 5159.2 5173.0 5175.7 5186.4 4671.7 4740.8 4783.3 4831.5 4878.9 4673.7 4720.1 4835.5 4836.8 4949.6 4757.7 4768.0 4771.8 4771.9 4786.9 4751.9 4762.9 4764.7 4771.1 4779.4 4673.3 4701.0 4736.9 4765.1 4806.8 4999.4 5000.8 5014.0 5036.0 5078.7 5471.6 5550.1 5553.9 5559.1 5559.9 5581.8 5596.6 5612.5 5637.8 5686.4 5251.7 5309.4 5311.4 5311.8 5314.9 5571.0 5693.1 5712.9 5737.2 5873.7 5643.8 5653.9 5672.3 5674.0 5678.5 5726.8 5747.4 5756.5 5760.5 5762.9 5479.2 5570.2 5582.6 5623.9 5656.6 5581.6 5608.4 5615.5 5617.5 5634.0 4202.9 4320.4 4374.6 4375.5 4424.3 3872.4 3888.4 3893.8 3916.8 3918.8 5180.5 5201.9 5212.6 5214.8 5252.9 5490.8 5564.9 5593.9 5638.5 5695.0 5167.0 5170.3 5183.8 5199.4 5201.9 4683.2 4798.3 4821.9 4828.8 4851.4 5763.2 5776.0 5789.7 5839.0 5877.7 5515.6 5586.4 5593.0 5593.4 5597.7 5680.0 5794.0 5814.9 5836.5 5848.4 5484.4 5490.4 5495.7 5498.6 5504.0 5563.2 5564.0 5574.4 5583.6 5670.6 5339.7 5424.3 5433.1 5449.1 5490.2 5425.4 5430.1 5432.7 5436.2 5436.5 5263.3 5286.4 5290.9 5324.1 5382.0 5498.5 5512.0 5525.1 5540.3 5588.9 5281.9 5293.3 5360.5 5364.1 5372.6 02:26:46 INFO - PROCESS | 12825 | 02:26:46 INFO - PROCESS | 12825 | [#1] ext.html Cycles:180 Average:42702.61 Median:34333.31 stddev:67164.18 (195.6%) stddev-sans-first:67277.93 02:26:46 INFO - PROCESS | 12825 | Values: 524.6 552.2 573.9 596.2 600.4 35998.0 36581.5 36857.3 36861.3 36864.3 43108.4 44365.3 44378.8 44431.8 44449.1 8502.7 8630.1 8672.3 8678.7 8683.3 8585.6 8705.0 8707.7 8725.7 8731.5 8711.4 8777.4 8796.3 8798.2 8808.4 8636.5 8684.0 8736.9 8742.5 8750.4 8543.9 8665.9 8671.5 8673.0 8674.0 39373.6 39731.2 39764.8 39789.2 39800.2 3336.1 3365.9 3763.8 3903.3 4033.6 30474.8 30707.7 30802.5 30865.5 31905.0 3097.4 3180.3 3216.4 3263.1 3506.0 264611.7 266568.0 268605.0 269153.0 269288.7 58110.7 58414.4 58522.1 58535.0 58569.4 62495.0 62716.0 62731.4 62731.4 62788.7 15914.9 16003.9 16075.3 16082.9 16084.6 11173.5 11174.4 11180.4 11181.0 11239.4 18669.7 20111.9 20252.3 20276.0 20336.5 6366.5 7400.9 7623.5 7658.7 7734.5 930.7 1034.6 1044.3 1089.3 1165.5 28594.3 28674.3 28745.7 29009.4 29301.3 1099.8 1099.9 1105.1 1109.5 1176.3 14723.7 15109.2 15186.7 15228.4 15302.4 298733.0 299432.0 302091.0 303394.0 303838.0 44748.0 49532.8 52615.5 52941.5 52945.0 1344.9 1351.3 1361.7 1363.3 1363.6 25947.4 26159.6 26478.3 26604.5 26816.6 39807.4 39932.4 40019.4 40214.2 40230.8 188932.0 190529.4 190982.0 191124.0 191154.0 27517.6 30672.5 31596.5 31781.2 31799.0 36864.0 37677.4 37972.0 38075.2 38656.4 34743.3 35139.1 35407.8 35464.1 35527.0 33923.3 35087.6 35405.0 36028.5 36544.8 32230.7 32999.5 33096.3 33364.2 33426.5 29254.0 31982.2 32064.0 32080.5 32338.8 25106.6 32482.2 32748.6 32906.8 33490.2 02:26:46 INFO - PROCESS | 12825 | 02:26:46 INFO - PROCESS | 12825 | [#2] jquery.html Cycles:180 Average:26491.93 Median:18221.02 stddev:71550.38 (392.7%) stddev-sans-first:71724.18 02:26:46 INFO - PROCESS | 12825 | Values: 352.9 356.2 369.6 374.2 374.5 14024.3 16602.9 16927.2 17309.6 18627.3 16234.7 16565.7 16678.0 16742.8 16803.3 5266.5 5447.5 5476.1 5477.3 5487.3 3951.6 4807.6 5823.3 6043.2 6046.4 5959.0 5980.2 5980.4 5984.6 6004.4 5959.7 6570.7 6777.3 6818.8 6825.8 6445.9 6467.7 6473.3 6476.6 6478.6 22360.7 22504.9 23077.8 23184.3 23199.8 2362.6 2404.3 2419.1 2606.3 2638.9 12902.3 13476.2 13960.5 14515.9 14723.2 1916.0 2063.1 2148.0 2194.7 2196.6 68581.7 69482.7 71508.0 72091.3 73284.6 15218.8 15308.0 15858.2 15922.9 15971.8 24253.0 24672.0 24834.6 24896.6 24903.8 9222.4 9311.1 9324.0 9361.3 9389.5 8069.7 8115.4 8134.8 8136.6 8200.3 7789.9 7912.1 7940.1 7952.6 7957.3 1856.7 1877.6 1905.2 2239.1 2942.7 899.7 914.2 975.0 1009.6 1013.3 17266.7 17522.5 17524.6 17530.2 17600.6 945.5 960.5 969.3 981.7 1015.8 8182.8 9689.5 9945.9 10001.6 10285.9 424463.0 426528.0 431107.0 444798.0 455256.0 55330.7 76683.6 77219.0 78394.0 78563.6 1009.1 1032.3 1042.8 1044.4 1048.8 14929.9 15322.5 15525.9 15926.0 16128.3 35121.3 35236.3 36085.8 36322.8 36404.0 46434.5 46887.8 47315.5 47485.0 47670.8 7779.7 7844.1 8032.3 8138.2 8169.6 10079.5 11200.2 11489.2 13169.9 13247.1 9869.4 10166.8 10761.1 10829.1 10937.8 9759.0 9944.8 11391.9 11669.6 11713.0 10999.6 11086.2 11100.8 11319.0 11445.1 7958.2 8013.3 8021.0 8148.1 8276.6 10121.4 11278.5 11354.5 11385.7 11641.0 02:26:46 INFO - PROCESS | 12825 | 02:26:46 INFO - PROCESS | 12825 | [#3] mootools.html Cycles:180 Average:5355.65 Median:6285.28 stddev:2813.37 (44.8%) stddev-sans-first:2804.96 02:26:46 INFO - PROCESS | 12825 | Values: 1326.1 1448.0 1453.7 1633.7 1832.6 7470.9 7679.4 7686.5 7686.9 7696.2 7552.2 7714.7 7719.5 7719.9 7729.5 1935.7 1987.5 2195.0 2245.4 2254.9 2211.5 2216.6 2219.4 2220.8 2223.0 2192.7 2208.8 2282.3 2282.5 2284.1 2210.0 2247.4 2279.5 2281.9 2282.6 2172.2 2176.4 2190.1 2192.5 2193.4 7897.8 7947.2 7954.4 7959.9 7962.2 4586.4 4680.7 4716.6 4723.2 4726.6 2920.9 3043.1 3066.3 3075.2 3085.0 922.2 936.7 941.7 942.8 1001.6 10271.9 10299.4 10347.5 10351.4 10358.1 3939.7 4001.6 4048.5 4060.8 4079.5 8343.5 8485.8 8521.4 8532.7 8548.7 4551.0 4575.9 4618.5 4623.8 4635.7 3721.9 4181.6 4229.6 4291.9 4292.5 3434.7 3470.2 3486.7 3516.3 3517.4 1003.5 1005.5 1011.3 1012.6 1013.6 1266.1 1289.2 1302.0 1349.6 1372.9 7330.2 7445.9 7530.1 7535.3 7545.9 416.2 423.1 423.6 428.9 440.5 5851.8 5899.0 5902.4 5939.5 5947.6 8846.3 9007.1 9148.6 9293.6 9303.2 9310.1 9311.6 9333.5 9381.6 9387.6 7425.1 7494.0 7539.5 7547.0 7635.2 7417.7 7436.7 7448.9 7464.9 7479.3 7894.6 8077.6 8284.5 8315.1 8330.2 8268.8 8345.1 8353.4 8408.2 8410.4 6151.1 6472.1 6576.5 6603.8 6687.0 7419.5 7467.0 7489.4 7527.7 7531.1 6501.4 6670.8 6676.0 6750.6 6818.7 6760.4 6760.9 6795.9 6820.0 6910.6 6684.7 6717.3 6767.3 6792.6 6798.4 6202.7 6232.8 6252.9 6270.2 6300.3 6589.3 6603.7 6617.7 6621.1 6625.0 02:26:46 INFO - PROCESS | 12825 | 02:26:46 INFO - PROCESS | 12825 | [#4] prototype.html Cycles:180 Average:5225.85 Median:5954.82 stddev:1622.66 (27.2%) stddev-sans-first:1584.59 02:26:46 INFO - PROCESS | 12825 | Values: 303.6 304.3 306.1 308.1 310.8 5787.3 5880.1 5898.1 5908.6 5953.8 5902.2 5907.8 5942.0 5955.9 5976.4 4539.1 4543.9 4548.7 4549.2 4551.5 4310.8 4385.4 4504.6 4522.0 4526.0 4469.2 4474.5 4477.9 4484.6 4501.2 4476.0 4479.1 4489.5 4499.7 4502.0 3899.4 3903.1 3904.2 3909.4 3910.3 5649.6 5659.4 5661.1 5663.8 5666.2 4889.5 5207.1 5221.4 5227.8 5228.0 6212.9 6222.0 6246.6 6258.1 6258.4 4111.3 4112.3 4113.1 4115.0 4118.2 6377.1 6485.6 6580.8 6582.4 6583.5 4254.8 4282.5 4287.5 4290.4 4291.0 4324.7 4327.2 4327.7 4329.5 4331.1 5106.0 5110.6 5110.9 5113.6 5114.2 6042.8 6126.3 6284.8 6318.7 6328.2 1500.6 1509.9 1515.6 1515.9 1517.6 946.5 987.9 992.7 1001.4 1003.5 5996.2 5997.4 6001.9 6001.9 6006.8 6465.3 6470.3 6476.5 6478.3 6479.3 5914.8 5917.0 5919.3 5921.6 5929.2 3472.7 3509.3 3509.8 3511.3 3511.7 6659.1 6757.0 6777.4 6846.2 6881.4 6668.5 6695.7 6702.5 6705.4 6718.9 6845.8 6848.5 6915.2 6922.8 6924.8 6558.5 6559.6 6560.3 6565.4 6569.8 5873.5 6219.8 6301.7 6505.9 6506.5 6529.2 6737.6 6780.6 6790.1 6791.8 4161.0 4209.1 4219.1 4236.4 4240.8 6255.2 6382.6 6530.8 6549.0 6550.2 6341.9 6379.0 6381.5 6385.5 6391.4 6310.6 6364.8 6374.6 6379.7 6380.2 6237.6 6266.7 6270.3 6271.1 6275.9 6081.0 6405.9 6407.3 6412.7 6413.0 6055.3 6061.1 6107.4 6244.9 6256.9 02:26:46 INFO - PROCESS | 12825 | 02:26:46 INFO - PROCESS | 12825 | [#5] yui.html Cycles:180 Average:13117.72 Median:45753.66 stddev:14650.16 (32.0%) stddev-sans-first:14661.61 02:26:46 INFO - PROCESS | 12825 | Values: 708.6 755.6 785.4 800.1 848.0 13414.7 13729.9 13772.5 13783.0 13783.8 13001.3 13361.4 13440.5 13453.8 13471.7 694.3 818.0 824.5 839.6 844.5 827.1 837.9 838.3 839.1 839.7 869.5 877.1 877.9 878.2 878.5 707.3 870.1 879.8 881.0 881.0 645.4 647.4 649.0 650.0 650.7 13494.4 13553.8 13558.7 13595.8 13599.2 12341.0 12402.1 12405.0 12758.5 12953.5 10311.7 10365.7 10476.3 10598.8 11125.6 3600.9 3615.5 3648.0 3696.4 3716.4 45896.3 46373.1 46428.5 46557.8 46838.8 9071.6 9446.9 9627.9 9732.7 10021.4 17394.7 17783.6 17893.4 18016.0 18024.3 7832.7 7976.2 7982.4 8202.5 8359.4 4241.1 4330.5 4339.6 4380.8 4459.1 3144.8 3183.1 3183.5 3186.3 3187.2 548.3 551.8 560.6 583.3 594.5 524.2 557.0 613.8 637.2 640.7 7813.7 7884.9 7897.8 7939.5 8235.8 529.2 574.3 642.7 653.3 669.7 3685.4 3708.6 3733.9 3758.2 3809.5 50914.0 51076.7 51784.7 51860.5 52299.5 45632.3 45875.0 46047.0 46697.0 46813.8 41823.6 43115.6 43322.6 43539.6 43831.6 7460.1 7489.1 8148.6 8249.4 8508.8 32559.3 32950.5 33339.5 33614.7 34784.7 39679.4 40987.0 41258.0 41274.0 41487.4 10183.2 10465.9 10563.0 10579.7 10728.1 11795.4 11996.2 12114.8 12144.3 12304.0 8778.4 9024.0 9123.2 10783.4 10830.8 11327.2 11538.2 11826.4 11871.9 12056.3 10578.0 10612.5 10823.0 10873.6 10906.7 9610.9 9803.7 9973.6 10025.3 10229.6 8783.8 8985.2 9259.5 9344.0 9503.3 02:26:46 INFO - PROCESS | 12825 | -------- Summary: end -------- 02:26:46 INFO - PROCESS | 12825 | 02:26:46 INFO - TEST-INFO | 12825: exit 0 02:26:47 INFO - TEST-OK | dromaeo_css | took 1113148ms 02:26:47 INFO - TEST-START | kraken 02:26:47 INFO - operating with platform_type : linux_ 02:26:47 INFO - Initialising browser for kraken test... 02:26:47 INFO - TEST-INFO | started process 13009 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1RbQbJ/profile http://localhost:39030/getInfo.html) 02:26:51 INFO - PROCESS | 13009 | __metrics Screen width/height:1600/1200 02:26:51 INFO - PROCESS | 13009 | colorDepth:24 02:26:51 INFO - PROCESS | 13009 | Browser inner width/height: 1024/697 02:26:51 INFO - PROCESS | 13009 | __metrics 02:26:52 INFO - PROCESS | 13009 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:26:53 INFO - TEST-INFO | 13009: exit 0 02:26:53 INFO - Browser initialized. 02:26:53 INFO - Running cycle 1/1 for kraken test... 02:26:53 INFO - TEST-INFO | started process 13094 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1RbQbJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:05 INFO - PROCESS | 13094 | RSS: Main: 147689472 02:27:05 INFO - PROCESS | 13094 | 02:27:07 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39030/tests/kraken/driver.html?testName=audio-beat-detection) 02:27:08 INFO - PROCESS | 13094 | RSS: Main: 191787008 02:27:08 INFO - PROCESS | 13094 | 02:27:10 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39030/tests/kraken/driver.html?testName=audio-dft) 02:27:11 INFO - PROCESS | 13094 | RSS: Main: 183558144 02:27:11 INFO - PROCESS | 13094 | 02:27:14 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39030/tests/kraken/driver.html?testName=audio-fft) 02:27:14 INFO - PROCESS | 13094 | RSS: Main: 167854080 02:27:14 INFO - PROCESS | 13094 | 02:27:16 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39030/tests/kraken/driver.html?testName=audio-oscillator) 02:27:17 INFO - PROCESS | 13094 | RSS: Main: 167305216 02:27:17 INFO - PROCESS | 13094 | 02:27:19 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39030/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:27:20 INFO - PROCESS | 13094 | RSS: Main: 169537536 02:27:20 INFO - PROCESS | 13094 | 02:27:23 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39030/tests/kraken/driver.html?testName=imaging-darkroom) 02:27:23 INFO - PROCESS | 13094 | RSS: Main: 170569728 02:27:23 INFO - PROCESS | 13094 | 02:27:27 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39030/tests/kraken/driver.html?testName=imaging-desaturate) 02:27:27 INFO - PROCESS | 13094 | RSS: Main: 170938368 02:27:27 INFO - PROCESS | 13094 | 02:27:30 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39030/tests/kraken/driver.html?testName=json-parse-financial) 02:27:31 INFO - PROCESS | 13094 | RSS: Main: 172204032 02:27:31 INFO - PROCESS | 13094 | 02:27:32 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39030/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:27:33 INFO - PROCESS | 13094 | RSS: Main: 183754752 02:27:33 INFO - PROCESS | 13094 | 02:27:35 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39030/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:27:35 INFO - PROCESS | 13094 | RSS: Main: 180883456 02:27:35 INFO - PROCESS | 13094 | 02:27:37 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39030/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:27:38 INFO - PROCESS | 13094 | RSS: Main: 190386176 02:27:38 INFO - PROCESS | 13094 | 02:27:40 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:27:41 INFO - PROCESS | 13094 | RSS: Main: 198479872 02:27:41 INFO - PROCESS | 13094 | 02:27:43 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:27:44 INFO - PROCESS | 13094 | RSS: Main: 196239360 02:27:44 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | Cycle 1(1): loaded http://localhost:39030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39030/tests/kraken/driver.html?testName=ai-astar) 02:27:46 INFO - PROCESS | 13094 | RSS: Main: 257888256 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | __start_tp_report 02:27:46 INFO - PROCESS | 13094 | _x_x_mozilla_page_load 02:27:46 INFO - PROCESS | 13094 | _x_x_mozilla_page_load_details 02:27:46 INFO - PROCESS | 13094 | |i|pagename|runs| 02:27:46 INFO - PROCESS | 13094 | |0;ai-astar;112;112;107;112;112;112;102;110;110;111 02:27:46 INFO - PROCESS | 13094 | |1;audio-beat-detection;158;134;159;159;126;153;163;129;172;125 02:27:46 INFO - PROCESS | 13094 | |2;audio-dft;161;160;161;161;162;160;160;162;166;160 02:27:46 INFO - PROCESS | 13094 | |3;audio-fft;72;74;93;103;73;72;76;123;95;73 02:27:46 INFO - PROCESS | 13094 | |4;audio-oscillator;96;96;143;96;95;96;138;96;96;135 02:27:46 INFO - PROCESS | 13094 | |5;imaging-gaussian-blur;119;115;114;114;115;115;115;115;115;115 02:27:46 INFO - PROCESS | 13094 | |6;imaging-darkroom;145;145;146;146;146;146;145;147;145;145 02:27:46 INFO - PROCESS | 13094 | |7;imaging-desaturate;96;97;96;96;96;96;96;96;96;96 02:27:46 INFO - PROCESS | 13094 | |8;json-parse-financial;55;57;55;56;57;56;58;64;55;55 02:27:46 INFO - PROCESS | 13094 | |9;json-stringify-tinderbox;68;67;67;68;67;68;68;68;68;68 02:27:46 INFO - PROCESS | 13094 | |10;stanford-crypto-aes;81;82;84;83;83;83;82;82;83;83 02:27:46 INFO - PROCESS | 13094 | |11;stanford-crypto-ccm;113;116;114;121;120;117;114;117;124;114 02:27:46 INFO - PROCESS | 13094 | |12;stanford-crypto-pbkdf2;150;141;150;151;153;140;156;152;157;153 02:27:46 INFO - PROCESS | 13094 | |13;stanford-crypto-sha256-iterative;68;76;72;68;70;68;69;70;67;67 02:27:46 INFO - PROCESS | 13094 | __end_tp_report 02:27:46 INFO - PROCESS | 13094 | __start_cc_report 02:27:46 INFO - PROCESS | 13094 | _x_x_mozilla_cycle_collect,939 02:27:46 INFO - PROCESS | 13094 | __end_cc_report 02:27:46 INFO - PROCESS | 13094 | __startTimestamp1456223266434__endTimestamp 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | ------- Summary: start ------- 02:27:46 INFO - PROCESS | 13094 | Number of tests: 14 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#0] ai-astar Cycles:10 Average:110.00 Median:112.00 stddev:3.23 (2.9%) stddev-sans-first:3.35 02:27:46 INFO - PROCESS | 13094 | Values: 112.0 112.0 107.0 112.0 112.0 112.0 102.0 110.0 110.0 111.0 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:158.50 stddev:17.44 (11.0%) stddev-sans-first:18.10 02:27:46 INFO - PROCESS | 13094 | Values: 158.0 134.0 159.0 159.0 126.0 153.0 163.0 129.0 172.0 125.0 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.83 (1.1%) stddev-sans-first:1.94 02:27:46 INFO - PROCESS | 13094 | Values: 161.0 160.0 161.0 161.0 162.0 160.0 160.0 162.0 166.0 160.0 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#3] audio-fft Cycles:10 Average:85.40 Median:73.50 stddev:17.51 (23.8%) stddev-sans-first:17.88 02:27:46 INFO - PROCESS | 13094 | Values: 72.0 74.0 93.0 103.0 73.0 72.0 76.0 123.0 95.0 73.0 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:96.00 stddev:20.77 (21.6%) stddev-sans-first:21.51 02:27:46 INFO - PROCESS | 13094 | Values: 96.0 96.0 143.0 96.0 95.0 96.0 138.0 96.0 96.0 135.0 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.40 (1.2%) stddev-sans-first:0.44 02:27:46 INFO - PROCESS | 13094 | Values: 119.0 115.0 114.0 114.0 115.0 115.0 115.0 115.0 115.0 115.0 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 02:27:46 INFO - PROCESS | 13094 | Values: 145.0 145.0 146.0 146.0 146.0 146.0 145.0 147.0 145.0 145.0 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:27:46 INFO - PROCESS | 13094 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:2.74 (4.9%) stddev-sans-first:2.83 02:27:46 INFO - PROCESS | 13094 | Values: 55.0 57.0 55.0 56.0 57.0 56.0 58.0 64.0 55.0 55.0 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 02:27:46 INFO - PROCESS | 13094 | Values: 68.0 67.0 67.0 68.0 67.0 68.0 68.0 68.0 68.0 68.0 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.84 (1.0%) stddev-sans-first:0.67 02:27:46 INFO - PROCESS | 13094 | Values: 81.0 82.0 84.0 83.0 83.0 83.0 82.0 82.0 83.0 83.0 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:117.00 stddev:3.62 (3.1%) stddev-sans-first:3.54 02:27:46 INFO - PROCESS | 13094 | Values: 113.0 116.0 114.0 121.0 120.0 117.0 114.0 117.0 124.0 114.0 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:152.50 stddev:5.66 (3.7%) stddev-sans-first:6.00 02:27:46 INFO - PROCESS | 13094 | Values: 150.0 141.0 150.0 151.0 153.0 140.0 156.0 152.0 157.0 153.0 02:27:46 INFO - PROCESS | 13094 | 02:27:46 INFO - PROCESS | 13094 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:2.76 (4.0%) stddev-sans-first:2.87 02:27:46 INFO - PROCESS | 13094 | Values: 68.0 76.0 72.0 68.0 70.0 68.0 69.0 70.0 67.0 67.0 02:27:46 INFO - PROCESS | 13094 | -------- Summary: end -------- 02:27:46 INFO - PROCESS | 13094 | 02:27:47 INFO - TEST-INFO | 13094: exit 0 02:27:47 INFO - TEST-OK | kraken | took 60368ms 02:27:47 INFO - SUITE-END | took 1173s 02:27:47 INFO - Completed test suite (00:19:33) 02:27:47 INFO - Working with test: dromaeo_css 02:27:47 INFO - Generating results file: dromaeo_css 02:27:47 INFO - Working with test: kraken 02:27:47 INFO - Generating results file: kraken 02:27:47 INFO - javascript benchmark 02:27:47 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:27:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 02:27:47 INFO - process_Request line: dromaeo_css 6891.65 graph.html#tests=[[72,64,35]] 02:27:47 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:27:47 INFO - process_Request line: kraken 1514.00 graph.html#tests=[[232,64,35]] 02:27:47 INFO - RETURN: dromaeo_css: 6891.65 02:27:47 INFO - RETURN: kraken: 1514.00 02:27:47 INFO - javascript benchmark 02:27:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3125.2811853273747, 3173.349463360011, 3213.1003319070655, 3222.371637530681, 3241.189702574357, 5040.571551418125, 5138.768755406007, 5180.300659410974, 5183.559397451217, 5188.195829646402, 5116.1302578561645, 5159.226116082589, 5172.974135129319, 5175.741212939347, 5186.429492755794, 4671.696339737923, 4740.810367585293, 4783.28250762385, 4831.516848315158, 4878.902421951559, 4673.719576825401, 4720.079584481027, 4835.516448355172, 4836.782344794493, 4949.579285760715, 4757.738324392157, 4768.0463907218345, 4771.832985845496, 4771.856844294677, 4786.856394308176, 4751.904961900777, 4762.904741905177, 4764.737939413331, 4771.141194584973, 4779.378680771478, 4673.252279635242, 4701.036287561076, 4736.905261894777, 4765.142274390609, 4806.7836947337455, 4999.375078115236, 5000.849974500771, 5014.047331007134, 5035.974820125876, 5078.7460626968505, 5471.5896307776675, 5550.111982082847, 5553.888922221573, 5559.054960656698, 5559.861003474905, 5581.776728930838, 5596.6362186458155, 5612.466815652507, 5637.830865074055, 5686.402927692616, 5251.737413129366, 5309.41596424393, 5311.415744268089, 5311.787528498894, 5314.8937021260135, 5570.97214513933, 5693.089105743061, 5712.914306285409, 5737.196792449061, 5873.706314684248, 5643.830685079454, 5653.886922261532, 5672.347680016768, 5674.00704876645, 5678.545716342683, 5726.77092916287, 5747.3677895431465, 5756.539476841926, 5760.510356619734, 5762.9135562966585, 5479.150731636602, 5570.192322113352, 5582.553395728332, 5623.943760562342, 5656.575756818255, 5581.609287349846, 5608.439156084441, 5615.522680572116, 5617.494425501724, 5634.0, 4202.894927626834, 4320.373545835836, 4374.606285434263, 4375.47494300686, 4424.336349547593, 3872.4384964180035, 3888.4361767543546, 3893.824777885002, 3916.804159791999, 3918.804059796999, 5180.48195180479, 5201.947980520222, 5212.635115541876, 5214.817481388133, 5252.894942101137, 5490.780368785284, 5564.86087847799, 5593.937151941118, 5638.520725738358, 5695.03184458643, 5166.974165129151, 5170.250313704491, 5183.792648294101, 5199.350081239845, 5201.921971170435, 4683.180443422388, 4798.304245884327, 4821.9035619287415, 4828.806847726122, 4851.369321988119, 5763.164341170507, 5776.0, 5789.739461724233, 5839.036558967808, 5877.676727779927, 5515.558755299486, 5586.385497595343, 5592.972035139798, 5593.412691667317, 5597.692126933058, 5680.034394153086, 5794.0, 5814.895169917702, 5836.533077353716, 5848.385919478394, 5484.396716361117, 5490.423505531861, 5495.697736624524, 5498.5876059296515, 5504.0, 5563.248961390161, 5564.0, 5574.442555744393, 5583.581231407742, 5670.631408958569, 5339.7063161526485, 5424.267723857387, 5433.130699088127, 5449.128139497661, 5490.176473529003, 5425.403205647454, 5430.076886929152, 5432.728363581884, 5436.238926550207, 5436.53789427903, 5263.2631431600375, 5286.36563612369, 5290.920636190537, 5324.068288049653, 5382.03123437785, 5498.532624726943, 5511.972440137773, 5525.143602741581, 5540.279763630863, 5588.916166257591, 5281.867953301198, 5293.338332708411, 5360.517553420211, 5364.088105022078, 5372.570194384518], "unit": "score", "name": "dojo.html", "value": 5161.490787985452}, {"lowerIsBetter": false, "replicates": [524.6484855147052, 552.2268823646897, 573.8938296415163, 596.2457491273537, 600.4265926040632, 35998.0, 36581.45127823078, 36857.26285474289, 36861.26277474456, 36864.26271474569, 43108.35337469933, 44365.33451998223, 44378.77810610951, 44431.77784111075, 44449.11101777962, 8502.659893604265, 8630.05069442364, 8672.306215502776, 8678.696245631372, 8683.34874884383, 8585.570721463933, 8705.042445331008, 8707.651693932266, 8725.694600688978, 8731.476111433334, 8711.390202685814, 8777.385583009192, 8796.25231855293, 8798.208161265486, 8808.38341316105, 8636.481811091355, 8684.044755076937, 8736.912630873674, 8742.475451472868, 8750.3874728769, 8543.914560854375, 8665.870011949826, 8671.479711217347, 8673.0, 8673.956630216871, 39373.60626393728, 39731.20537589261, 39764.801175994224, 39789.20421591552, 39800.20399592021, 3336.099253201622, 3365.882194123194, 3763.7741735495956, 3903.3364328064013, 4033.556308806029, 30474.84762576195, 30707.692923070706, 30802.53796193059, 30865.537016944763, 31905.0, 3097.396007778484, 3180.3480286541435, 3216.372807302577, 3263.102646772133, 3505.964940350615, 264611.676941616, 266568.0, 268605.0, 269153.0, 269288.72468390927, 58110.7094464525, 58414.415855840896, 58522.12216816751, 58535.0, 58569.41430585725, 62495.0, 62716.0, 62731.37268627255, 62731.37268627347, 62788.68605657034, 15914.920425397799, 16003.919980400024, 16075.276612552463, 16082.919585401998, 16084.597885052968, 11173.497192626352, 11174.44127793607, 11180.440977951233, 11181.0, 11239.438028098562, 18669.713075369218, 20111.899440502704, 20252.291169808985, 20276.0, 20336.491587710425, 6366.490680745529, 7400.925990740024, 7623.542587444771, 7658.693652253847, 7734.497257678233, 930.6510058727977, 1034.6482196053378, 1044.3472829481575, 1089.2919602258596, 1165.5279611757253, 28594.28514287118, 28674.283142921595, 28745.71254287472, 29009.41981160365, 29301.26746831346, 1099.8405231241586, 1099.9065079468176, 1105.0993440346092, 1109.4508218431768, 1176.3294921894437, 14723.705525889636, 15109.233254629054, 15186.696266074616, 15228.390864365523, 15302.387904483696, 298733.0, 299432.0, 302091.0, 303394.0, 303838.0, 44748.0, 49532.75233623809, 52615.473845261826, 52941.47058529365, 52945.0, 1344.9125806822722, 1351.2703140304322, 1361.748076605831, 1363.3251540487522, 1363.638635761524, 25947.351316217246, 26159.607605885547, 26478.338041549116, 26604.467910642066, 26816.59775103336, 39807.40288895611, 39932.40101398539, 40019.3997090038, 40214.19571608493, 40230.798846005586, 188932.0, 190529.378824851, 190982.0, 191124.0, 191154.0, 27517.587236191073, 30672.539911900894, 31596.526052109697, 31781.205469862514, 31799.0, 36864.0, 37677.4348384769, 37972.0, 38075.23849523049, 38656.42015369715, 34743.305133896676, 35139.12152196113, 35407.82296088503, 35464.11339716425, 35527.0, 33923.3215335687, 35087.64912350844, 35405.0, 36028.45957310695, 36544.81727591345, 32230.677693222766, 32999.50500742443, 33096.33807323888, 33364.1658958528, 33426.49860252147, 29253.95222334416, 31982.200444989063, 32064.0, 32080.51879221767, 32338.83830580832, 25106.62340064864, 32482.187945301557, 32748.578941842545, 32906.835465822514, 33490.16274593155], "unit": "score", "name": "ext.html", "value": 18064.58382961167}, {"lowerIsBetter": false, "replicates": [352.940000199966, 356.21276977878887, 369.5583777386023, 374.16374403208823, 374.51874341471216, 14024.298785060731, 16602.91698541507, 16927.153642317895, 17309.567260818487, 18627.348042818503, 16234.675306493864, 16565.66868662626, 16678.0, 16742.83257167428, 16803.32786688534, 5266.52601265886, 5447.536959358439, 5476.069068258385, 5477.315335583052, 5487.286652735139, 3951.6443520083185, 4807.61539076873, 5823.272090988627, 6043.214382130317, 6046.39536046394, 5959.046552551593, 5980.222571065756, 5980.401959804029, 5984.611000284989, 6004.369541198177, 5959.731812068446, 6570.671466426684, 6777.2545020047755, 6818.795436136874, 6825.829354266133, 6445.903311450332, 6467.676616169219, 6473.28793832678, 6476.579022363579, 6478.611283323015, 22360.664590031163, 22504.887475562682, 23077.76922230773, 23184.304470865733, 23199.76800231993, 2362.6337917622623, 2404.302752201859, 2419.129113519132, 2606.27024433159, 2638.894444222248, 12902.290374029424, 13476.191428514321, 13960.511382101678, 14515.854841451555, 14723.190224537646, 1916.0, 2063.0716177720087, 2148.0, 2194.7476040255415, 2196.5936301784063, 68581.65709171472, 69482.65258673725, 71508.0, 72091.27908720898, 73284.6335768323, 15218.771718424232, 15308.0, 15858.207089645703, 15922.920385397998, 15971.760423593656, 24253.0, 24672.0, 24834.627480587806, 24896.626550601755, 24903.750962490507, 9222.44665320083, 9311.115444032806, 9323.953380233192, 9361.297902657328, 9389.483578403253, 8069.677212911418, 8115.3507719382305, 8134.755957321171, 8136.633851476698, 8200.343972482187, 7789.922100778919, 7912.129665736765, 7940.1265860755275, 7952.602369881482, 7957.283844454027, 1856.6843636581543, 1877.6244751049844, 1905.247427266222, 2239.1267405711787, 2942.735153836165, 899.7030979776658, 914.1726737302752, 974.9707508774748, 1009.6012075230243, 1013.2957594471918, 17266.68264046964, 17522.474325770247, 17524.561885952953, 17530.211140498708, 17600.559986000197, 945.4941606240628, 960.5101398286924, 969.3117886300805, 981.7349315684868, 1015.8019186258608, 8182.836343273101, 9689.515524223902, 9945.850812237823, 10001.649942251986, 10285.897141028643, 424463.0, 426528.0, 431107.0, 444798.0, 455256.0, 55330.72334638301, 76683.61658191674, 77219.0, 78394.0, 78563.60718196486, 1009.106940357774, 1032.2980373346197, 1042.7862288231047, 1044.4412239451856, 1048.7535429174138, 14929.925350373613, 15322.496014711942, 15525.922370388076, 15926.0, 16128.274227659549, 35121.297574047865, 35236.29527409489, 36085.81957090198, 36322.8183859079, 36404.0, 46434.53565464437, 46887.76556117334, 47315.52684473111, 47485.0, 47670.761646191546, 7779.72770953014, 7844.137144913941, 8032.317253033558, 8138.226868447488, 8169.591520424074, 10079.546420410952, 11200.21598488098, 11489.195756296978, 13169.868301316865, 13247.138935969131, 9869.358491698016, 10166.830814456136, 10761.139108871428, 10829.079528240189, 10937.835932460861, 9758.951205243928, 9944.801103977736, 11391.943040285078, 11669.59156429521, 11713.0, 10999.61501347481, 11086.22396432242, 11100.833487497855, 11319.0, 11445.084393248686, 7958.204179581995, 8013.318867896294, 8020.959895200486, 8148.144444833207, 8276.586170691562, 10121.392716437038, 11278.548858045586, 11354.489047993025, 11385.658430247106, 11641.0], "unit": "score", "name": "jquery.html", "value": 9277.066303953308}, {"lowerIsBetter": false, "replicates": [1326.0916272353434, 1448.0298200205862, 1453.7455945209585, 1633.730434478311, 1832.5693462036427, 7470.850582988343, 7679.385649148068, 7686.500377475467, 7686.9231307686905, 7696.191899850505, 7552.169261381244, 7714.652840622171, 7719.49823261489, 7719.92280077199, 7729.536227826335, 1935.680612698903, 1987.473319570315, 2194.9780502194935, 2245.382519807058, 2254.9323520294415, 2211.5466329402516, 2216.645336746121, 2219.4007617943225, 2220.822334213267, 2222.977770222293, 2192.7478339990867, 2208.845380823343, 2282.3038973113194, 2282.543491301738, 2284.097781376355, 2210.049678638185, 2247.381969958258, 2279.509905370345, 2281.8973146208377, 2282.6461898405773, 2172.1637169689625, 2176.4341271269427, 2190.1020581561484, 2192.48476607997, 2193.396815875631, 7897.842043159105, 7947.165547617475, 7954.363650907913, 7959.920400795976, 7962.203779622049, 4586.4266966629175, 4680.7191568506, 4716.622670186377, 4723.244280915072, 4726.582025392368, 2920.897768578111, 3043.1479185827784, 3066.294752207005, 3075.2311922019494, 3084.9691503084905, 922.2115091596655, 936.737713440231, 941.6657086734248, 942.8350038743192, 1001.6193846338417, 10271.948640256825, 10299.3820370778, 10347.4826258686, 10351.430671313075, 10358.119559837423, 3939.7242193046213, 4001.639852413297, 4048.4939382577177, 4060.817263223162, 4079.530853951774, 8343.54110523927, 8485.830283394422, 8521.36089793268, 8532.744017679479, 8548.700795472128, 4551.0215303709865, 4575.9084818303445, 4618.468876079227, 4623.838165664253, 4635.6523260755575, 3721.925561488755, 4181.623653871166, 4229.59818817218, 4291.892702682458, 4292.506361768436, 3434.742394320436, 3470.219200679827, 3486.6687664671817, 3516.2967406518796, 3517.402041652925, 1003.5484032185545, 1005.5424781724298, 1011.3375738891039, 1012.5645972232011, 1013.5945621751212, 1266.0820904843915, 1289.1813698301457, 1302.0039669652724, 1349.5748839115647, 1372.876441120304, 7330.230325815819, 7445.8883116753295, 7530.058742657168, 7535.284148005931, 7545.924540754632, 416.2112796251087, 423.14735807348217, 423.6208593309033, 428.86276391555026, 440.4978324709833, 5851.795187168429, 5899.026660601038, 5902.3507414184405, 5939.524838012949, 5947.613405128653, 8846.336524760669, 9007.05425930281, 9148.588313525906, 9293.628254869729, 9303.162715355515, 9310.115539023782, 9311.580978855967, 9333.486658233862, 9381.577828997712, 9387.62449502026, 7425.071866016748, 7493.962530187423, 7539.509931854522, 7546.962265188639, 7635.160132385433, 7417.666205020895, 7436.665350059152, 7448.92551074504, 7464.888026679496, 7479.252074792477, 7894.565798881116, 8077.596120193849, 8284.46151000183, 8315.126911674188, 8330.208630180123, 8268.83462330762, 8345.123762005145, 8353.37349698763, 8408.201220884006, 8410.369222308474, 6151.138840562236, 6472.126262954629, 6576.473882089325, 6603.80188594343, 6686.966565167143, 7419.517731347445, 7466.962665186639, 7489.400847932261, 7527.698892044257, 7531.058617672791, 6501.382368674968, 6670.799876003728, 6676.0, 6750.628715420699, 6818.693158807766, 6760.391564759196, 6760.864782704417, 6795.898061528982, 6819.965900170468, 6910.585364878123, 6684.699188536625, 6717.2946840581035, 6767.323267673193, 6792.592444453348, 6798.354156355138, 6202.72087756043, 6232.8130156095385, 6252.937470625236, 6270.216222972129, 6300.338464461165, 6589.27517973013, 6603.702833372606, 6617.66911654425, 6621.106150669598, 6625.0], "unit": "score", "name": "mootools.html", "value": 4293.475979285997}, {"lowerIsBetter": false, "replicates": [303.5916692049196, 304.34869379527817, 306.13364179372377, 308.10341905056276, 310.7684774842742, 5787.276590426197, 5880.147378630096, 5898.11797234103, 5908.615939963899, 5953.791617293396, 5902.173695682608, 5907.763689452428, 5942.0, 5955.851103722409, 5976.3724808895095, 4539.137563862863, 4543.931841022388, 4548.681592288541, 4549.1584056949405, 4551.522090180533, 4310.784460776964, 4385.429894113777, 4504.572065653774, 4522.0, 4526.0, 4469.217886869801, 4474.485434175062, 4477.932831007537, 4484.551544845522, 4501.189785838547, 4475.977620111911, 4479.126570318789, 4489.483709373431, 4499.707519011254, 4501.954980450187, 3899.415087736834, 3903.1022864740985, 3904.1996390739832, 3909.4135879618, 3910.257051160299, 5649.576281778883, 5659.377468478505, 5661.122526008476, 5663.773449062032, 5666.206731057614, 4889.462159162489, 5207.140821764404, 5221.425643179247, 5227.843164705065, 5227.999999999962, 6212.87574248517, 6221.96889015552, 6246.625202487865, 6258.123862659231, 6258.436740693314, 4111.301078816608, 4112.280350938604, 4113.053997580573, 4115.0, 4118.238125946709, 6377.139086223347, 6485.643289619069, 6580.835479113012, 6582.440492558138, 6583.506237032242, 4254.787260636956, 4282.486101667758, 4287.506936702257, 4290.442242508517, 4290.978545107317, 4324.718893271927, 4327.221100201931, 4327.675424343124, 4329.502107257706, 4331.068820203672, 5105.974470127626, 5110.565601923804, 5110.948890511122, 5113.616478764107, 5114.207297868762, 6042.788502402394, 6126.295476020315, 6284.780032698834, 6318.715657795318, 6328.240611126602, 1500.6023403798001, 1509.9396024158912, 1515.5756388211319, 1515.8787297016213, 1517.5750789778658, 946.4510583861344, 987.916027137687, 992.6724181020246, 1001.409168590535, 1003.4781913405135, 5996.190514280604, 5997.400259973968, 6001.879962400728, 6001.939980600138, 6006.849828754316, 6465.2564955030775, 6470.288268290485, 6476.5466417350335, 6478.255000674889, 6479.319671434431, 5914.822555323347, 5916.970415147896, 5919.289685237799, 5921.61509501881, 5929.229200204032, 3472.652734726558, 3509.280597477511, 3509.78941263525, 3511.297740451869, 3511.701505372021, 6659.101021362151, 6757.0, 6777.423918966844, 6846.212685541127, 6881.41507971828, 6668.466522678174, 6695.698693558801, 6702.497312701566, 6705.430038446689, 6718.899216511756, 6845.760398386033, 6848.520603557703, 6915.204751453647, 6922.7923162305215, 6924.792256232321, 6558.540902136805, 6559.6064236145985, 6560.3111673275525, 6565.409113179837, 6569.770058047945, 5873.500752436091, 6219.751209951552, 6301.747930082745, 6505.934940650533, 6506.544541882023, 6529.183852018497, 6737.562058466184, 6780.593164409954, 6790.117284752951, 6791.762288319885, 4160.958390416178, 4209.137126889042, 4219.07180420307, 4236.4492615959725, 4240.830366785294, 6255.24937007562, 6382.6170429774365, 6530.836729081621, 6548.967255163694, 6550.246721627074, 6341.8731625368155, 6378.968105159444, 6381.457576106083, 6385.45723613498, 6391.424771770563, 6310.5898116622275, 6364.809055728336, 6374.553781235454, 6379.681015949277, 6380.202474690664, 6237.625742455467, 6266.749330026748, 6270.278917924315, 6271.059341098689, 6275.937240627535, 6080.969595151996, 6405.871882562229, 6407.295197528361, 6412.711427985845, 6413.0, 6055.303640081447, 6061.090836374403, 6107.389261073857, 6244.907141250354, 6256.937430625636], "unit": "score", "name": "prototype.html", "value": 4683.435267901752}, {"lowerIsBetter": false, "replicates": [708.6138054760155, 755.5731011978236, 785.3834739729314, 800.0958916424439, 847.978186285526, 13414.66463338417, 13729.931350343235, 13772.517961871325, 13783.0, 13783.793243101336, 13001.349932503384, 13361.398737056832, 13440.462381504753, 13453.798193027113, 13471.730565388687, 694.2814187316129, 817.9836403271931, 824.5135370131607, 839.5760141128721, 844.501743971057, 827.1315119124924, 837.9329653627696, 838.3209600223807, 839.1147339556766, 839.689314953465, 869.543489667923, 877.0965905117707, 877.8727084572733, 878.2227728460294, 878.508035500122, 707.2573797512617, 870.1037930931119, 879.7976465412927, 880.9779755506131, 881.0440671871028, 645.4158986117571, 647.427027081032, 648.970796314167, 649.9837504062389, 650.6584043377264, 13494.392752326168, 13553.796693049611, 13558.728825423435, 13595.796063059062, 13599.184048957095, 12341.0, 12402.13185077045, 12405.0, 12758.489660413572, 12953.48186072556, 10311.690649280534, 10365.740856478573, 10476.26666133371, 10598.841017384746, 11125.610603628915, 3600.8559657613664, 3615.493830863681, 3648.0, 3696.4270538066644, 3716.368217403021, 45896.3115553267, 46373.07253854938, 46428.5357146431, 46557.76721116373, 46838.76580617075, 9071.591778369857, 9446.85829712555, 9627.90372096284, 9732.659356922615, 10021.39871607706, 17394.739078913826, 17783.55541111457, 17893.37373191932, 18016.0, 18024.2790288387, 7832.686692532349, 7976.202379762093, 7982.401319901031, 8202.548859812649, 8359.414840961075, 4241.088166044316, 4330.523642399334, 4339.587739164775, 4380.759058251763, 4459.10817836434, 3144.8427578620976, 3183.1246407238195, 3183.4906414973493, 3186.330870517217, 3187.2350635847693, 548.347466514846, 551.8427248234234, 560.5991715923135, 583.294214001055, 594.5065595555678, 524.2189138184078, 556.9526590239794, 613.7729040255134, 637.1939496536885, 640.711679744117, 7813.687452501837, 7884.921150788534, 7897.842043159105, 7939.523628582304, 8235.752927412188, 529.1850550152722, 574.2821473158551, 642.6779905138003, 653.3368630839701, 669.7321071571411, 3685.4103343464917, 3708.647678470541, 3733.9253214935547, 3758.1919887224376, 3809.466674665549, 50914.0, 51076.74461627742, 51784.74107629513, 51860.48139518557, 52299.47700522946, 45632.3155152673, 45875.0, 46047.0, 46697.0, 46813.765931170805, 41823.58176418258, 43115.56884431178, 43322.566774331855, 43539.56460435355, 43831.561684383385, 7460.142083660448, 7489.063867016623, 8148.592570371339, 8249.422540422112, 8508.787280318042, 32559.348813023134, 32950.50574241436, 33339.49990750092, 33614.663853361155, 34784.652153479154, 39679.40480892847, 40987.0, 41258.0, 41274.0, 41487.377689334084, 10183.236257280585, 10465.895341046493, 10563.0, 10579.682609521727, 10728.141748660244, 11795.41022948832, 11996.210261065213, 12114.757704845677, 12144.33206173669, 12304.0, 8778.385513014027, 9024.0, 9123.224525915371, 10783.406912619881, 10830.837537436788, 11327.15046371509, 11538.192326537397, 11826.408679565815, 11871.940640296743, 12056.276623402624, 10578.0, 10612.469376530988, 10823.0, 10873.565057397616, 10906.727331816768, 9610.855837162308, 9803.705888823346, 9973.60105595797, 10025.348352357074, 10229.641962531276, 8783.780405489659, 8985.236254918143, 9259.490728010023, 9343.953280233556, 9503.334766566273], "unit": "score", "name": "yui.html", "value": 6158.995052209916}], "name": "dromaeo_css", "value": 6891.647855507845}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 107.0, 112.0, 112.0, 112.0, 102.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [158.0, 134.0, 159.0, 159.0, 126.0, 153.0, 163.0, 129.0, 172.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 161.0, 162.0, 160.0, 160.0, 162.0, 166.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 93.0, 103.0, 73.0, 72.0, 76.0, 123.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 143.0, 96.0, 95.0, 96.0, 138.0, 96.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 114.0, 114.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 55.0, 56.0, 57.0, 56.0, 58.0, 64.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 84.0, 83.0, 83.0, 83.0, 82.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [113.0, 116.0, 114.0, 121.0, 120.0, 117.0, 114.0, 117.0, 124.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.0}, {"lowerIsBetter": true, "replicates": [150.0, 141.0, 150.0, 151.0, 153.0, 140.0, 156.0, 152.0, 157.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [68.0, 76.0, 72.0, 68.0, 70.0, 68.0, 69.0, 70.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1514.0}]} 02:27:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1514.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6891.65"}}} 02:27:47 INFO - Return code: 0 02:27:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:27:47 INFO - # TBPL SUCCESS # 02:27:47 INFO - Running post-action listener: _resource_record_post_action 02:27:47 INFO - Running post-run listener: _resource_record_post_run 02:27:48 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 61440; Write bytes: 537477120; Read time: 140; Write time: 399612 02:27:48 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 240410624; Read time: 60; Write time: 198368 02:27:48 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 57344; Write bytes: 297066496; Read time: 80; Write time: 201244 02:27:48 INFO - Running post-run listener: _upload_blobber_files 02:27:48 INFO - Blob upload gear active. 02:27:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:27:48 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:27:48 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:27:48 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:27:49 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:27:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:27:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:50 INFO - (blobuploader) - INFO - Done attempting. 02:27:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:27:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:27:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:50 INFO - (blobuploader) - INFO - Done attempting. 02:27:50 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:50 INFO - Return code: 0 02:27:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:27:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a302728bb40bda688467c31ee2e193adb2020db88aa8cc161d4c28d0d160eee85034ac39877cd722d3bbb88aa82976d59a81805f947bba33edfce2533210f92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b323a00d69615007ec344feabee8ea81ac19c6d0d1cd61225e9c44a11e3a5d8343808a2964da9afab09bba9cc109ae8ea9abf354025bf5fb519d01c57520874b"} 02:27:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:27:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:27:50 INFO - Contents: 02:27:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a302728bb40bda688467c31ee2e193adb2020db88aa8cc161d4c28d0d160eee85034ac39877cd722d3bbb88aa82976d59a81805f947bba33edfce2533210f92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b323a00d69615007ec344feabee8ea81ac19c6d0d1cd61225e9c44a11e3a5d8343808a2964da9afab09bba9cc109ae8ea9abf354025bf5fb519d01c57520874b"} 02:27:50 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:50 INFO - Copying logs to upload dir... 02:27:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:27:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.406543 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-23 02:27:50.838803) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 02:27:50.842527) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532 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/2a302728bb40bda688467c31ee2e193adb2020db88aa8cc161d4c28d0d160eee85034ac39877cd722d3bbb88aa82976d59a81805f947bba33edfce2533210f92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b323a00d69615007ec344feabee8ea81ac19c6d0d1cd61225e9c44a11e3a5d8343808a2964da9afab09bba9cc109ae8ea9abf354025bf5fb519d01c57520874b"} 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.011388 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/2a302728bb40bda688467c31ee2e193adb2020db88aa8cc161d4c28d0d160eee85034ac39877cd722d3bbb88aa82976d59a81805f947bba33edfce2533210f92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b323a00d69615007ec344feabee8ea81ac19c6d0d1cd61225e9c44a11e3a5d8343808a2964da9afab09bba9cc109ae8ea9abf354025bf5fb519d01c57520874b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 02:27:50.867382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 02:27:50.867736) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1456222034.815482-830132532 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 02:27:50.956557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 02:27:50.957288) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 02:27:50.957939) ========= ========= Total master_lag: 0.25 =========