builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1453134733.36 results: success (0) buildid: 20160118053004 builduid: a4d1ec62a19441afadeedb2e1677061b revision: 888e32f5c427e5840ca943dbb7ac6344aff59b38 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.360671) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.361185) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.361499) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006315 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.388740) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.389047) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.425441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.425748) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.477624) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.477925) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.478294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.478648) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-18 08:32:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 73.8M=0s 2016-01-18 08:32:13 (73.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158358 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.651065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.651415) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017402 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:13.701753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-18 08:32:13.702146) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 888e32f5c427e5840ca943dbb7ac6344aff59b38 --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 888e32f5c427e5840ca943dbb7ac6344aff59b38 --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=b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-18 08:32:13,961 truncating revision to first 12 chars 2016-01-18 08:32:13,961 Setting DEBUG logging. 2016-01-18 08:32:13,961 attempt 1/10 2016-01-18 08:32:13,961 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/888e32f5c427?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-18 08:32:15,319 unpacking tar archive at: fx-team-888e32f5c427/testing/mozharness/ program finished with exit code 0 elapsedTime=1.674253 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-18 08:32:15.389749) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:15.390126) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004765 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:15.439973) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:15.440324) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:15.451863) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:15.452320) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 08:32:15.452857) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-01-18 08:32:15.453189) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:32:15 INFO - MultiFileLogger online at 20160118 08:32:15 in /builds/slave/test-pgo 08:32:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:32:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:32:15 INFO - {'append_to_log': False, 08:32:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:32:15 INFO - 'blob_upload_branch': 'Fx-Team', 08:32:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:32:15 INFO - 'branch': 'Fx-Team', 08:32:15 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:15 INFO - 'config_files': ('talos/linux_config.py',), 08:32:15 INFO - 'default_actions': ('clobber', 08:32:15 INFO - 'read-buildbot-config', 08:32:15 INFO - 'download-and-extract', 08:32:15 INFO - 'populate-webroot', 08:32:15 INFO - 'create-virtualenv', 08:32:15 INFO - 'install', 08:32:15 INFO - 'run-tests'), 08:32:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:15 INFO - 'download_minidump_stackwalk': True, 08:32:15 INFO - 'download_symbols': 'ondemand', 08:32:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:15 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:15 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:15 INFO - 'installer_path': 'installer.exe', 08:32:15 INFO - 'log_level': 'info', 08:32:15 INFO - 'log_name': 'talos', 08:32:15 INFO - 'log_to_console': True, 08:32:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:32:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:32:15 INFO - 'opt_config_files': (), 08:32:15 INFO - 'pip_index': False, 08:32:15 INFO - 'sps_profile': False, 08:32:15 INFO - 'sps_profile_interval': 0, 08:32:15 INFO - 'suite': 'dromaeojs-e10s', 08:32:15 INFO - 'system_bits': '32', 08:32:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:15 INFO - 'title': 'talos-linux64-ix-007', 08:32:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:15 INFO - 'use_talos_json': True, 08:32:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:32:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:15 INFO - 'work_dir': 'build'} 08:32:15 INFO - ##### 08:32:15 INFO - ##### Running clobber step. 08:32:15 INFO - ##### 08:32:15 INFO - Running pre-action listener: _resource_record_pre_action 08:32:15 INFO - Running main action method: clobber 08:32:15 INFO - rmtree: /builds/slave/test-pgo/build 08:32:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:32:16 INFO - Running post-action listener: _resource_record_post_action 08:32:16 INFO - ##### 08:32:16 INFO - ##### Running read-buildbot-config step. 08:32:16 INFO - ##### 08:32:16 INFO - Running pre-action listener: _resource_record_pre_action 08:32:16 INFO - Running main action method: read_buildbot_config 08:32:16 INFO - Using buildbot properties: 08:32:16 INFO - { 08:32:16 INFO - "project": "", 08:32:16 INFO - "product": "firefox", 08:32:16 INFO - "script_repo_revision": "production", 08:32:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:32:16 INFO - "repository": "", 08:32:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:32:16 INFO - "buildid": "20160118053004", 08:32:16 INFO - "pgo_build": "True", 08:32:16 INFO - "basedir": "/builds/slave/test-pgo", 08:32:16 INFO - "buildnumber": 216, 08:32:16 INFO - "slavename": "talos-linux64-ix-007", 08:32:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:32:16 INFO - "platform": "ubuntu64_hw", 08:32:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:32:16 INFO - "branch": "fx-team", 08:32:16 INFO - "repo_path": "integration/fx-team", 08:32:16 INFO - "revision": "888e32f5c427e5840ca943dbb7ac6344aff59b38", 08:32:16 INFO - "stage_platform": "linux64-pgo", 08:32:16 INFO - "builduid": "a4d1ec62a19441afadeedb2e1677061b", 08:32:16 INFO - "slavebuilddir": "test" 08:32:16 INFO - } 08:32:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:32:16 INFO - Running post-action listener: _resource_record_post_action 08:32:16 INFO - ##### 08:32:16 INFO - ##### Running download-and-extract step. 08:32:16 INFO - ##### 08:32:16 INFO - Running pre-action listener: _resource_record_pre_action 08:32:16 INFO - Running main action method: download_and_extract 08:32:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:16 INFO - https://queue.taskcluster.net/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:32:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/test_packages.json 08:32:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/test_packages.json 08:32:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:32:21 INFO - Downloaded 1448 bytes. 08:32:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:32:21 INFO - Using the following test package requirements: 08:32:21 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:32:21 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:32:21 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:32:21 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:21 INFO - u'jsshell-linux-x86_64.zip'], 08:32:21 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:32:21 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:32:21 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:32:21 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:32:21 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:32:21 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:32:21 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:32:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:32:21 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:21 INFO - https://queue.taskcluster.net/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:32:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:32:33 INFO - Downloaded 22484310 bytes. 08:32:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:32:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:32:34 INFO - Return code: 0 08:32:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:32: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')]} 08:32:34 INFO - https://queue.taskcluster.net/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:32:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:32:40 INFO - Downloaded 22484310 bytes. 08:32:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:32:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:32:41 INFO - Return code: 0 08:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:41 INFO - https://queue.taskcluster.net/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:32:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:32:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:32:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:32:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:32:45 INFO - Downloaded 11132144 bytes. 08:32:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:32:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:32:45 INFO - Return code: 0 08:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:45 INFO - https://queue.taskcluster.net/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:32:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:32:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:32:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:32:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:32:48 INFO - Downloaded 55934210 bytes. 08:32:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:32:48 INFO - mkdir: /builds/slave/test-pgo/properties 08:32:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:32:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:32:48 INFO - Contents: 08:32:48 INFO - build_url:https://queue.taskcluster.net/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:32:48 INFO - Running post-action listener: _resource_record_post_action 08:32:48 INFO - Running post-action listener: set_extra_try_arguments 08:32:48 INFO - ##### 08:32:48 INFO - ##### Running populate-webroot step. 08:32:48 INFO - ##### 08:32:48 INFO - Running pre-action listener: _resource_record_pre_action 08:32:48 INFO - Running main action method: populate_webroot 08:32:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:32:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:32:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:32:48 INFO - '--tppagecycles', 08:32:48 INFO - '7'], 08:32:48 INFO - 'tests': ['tsvgm']}}, 08:32:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:32:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:32:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:32:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:32:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:32:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:48 INFO - 'talos_options': ['--e10s'], 08:32:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:48 INFO - 'tests': ['damp', 'tps']}, 08:32:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:48 INFO - 'talos_options': ['--e10s'], 08:32:48 INFO - 'tests': ['damp', 'tps']}, 08:32:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:32:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:48 INFO - 'other': {'tests': ['a11yr', 08:32:48 INFO - 'ts_paint', 08:32:48 INFO - 'tpaint', 08:32:48 INFO - 'sessionrestore', 08:32:48 INFO - 'sessionrestore_no_auto_restore']}, 08:32:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:32:48 INFO - 'tests': ['a11yr', 08:32:48 INFO - 'ts_paint', 08:32:48 INFO - 'tpaint', 08:32:48 INFO - 'sessionrestore', 08:32:48 INFO - 'sessionrestore_no_auto_restore']}, 08:32:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:32:48 INFO - 'tests': ['a11yr', 08:32:48 INFO - 'ts_paint', 08:32:48 INFO - 'tpaint', 08:32:48 INFO - 'sessionrestore', 08:32:48 INFO - 'sessionrestore_no_auto_restore']}, 08:32:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:32:48 INFO - 'tests': ['a11yr', 08:32:48 INFO - 'ts_paint', 08:32:48 INFO - 'tpaint', 08:32:48 INFO - 'sessionrestore', 08:32:48 INFO - 'sessionrestore_no_auto_restore']}, 08:32:48 INFO - 'other_l64': {'tests': ['a11yr', 08:32:48 INFO - 'ts_paint', 08:32:48 INFO - 'tpaint', 08:32:48 INFO - 'sessionrestore', 08:32:48 INFO - 'sessionrestore_no_auto_restore']}, 08:32:48 INFO - 'other_nol64': {'tests': ['a11yr', 08:32:48 INFO - 'ts_paint', 08:32:48 INFO - 'tpaint', 08:32:48 INFO - 'sessionrestore', 08:32:48 INFO - 'sessionrestore_no_auto_restore']}, 08:32:48 INFO - 'svgr': {'tests': ['tsvgx', 08:32:48 INFO - 'tsvgr_opacity', 08:32:48 INFO - 'tart', 08:32:48 INFO - 'tscrollx', 08:32:48 INFO - 'cart']}, 08:32:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:32:48 INFO - 'tests': ['tsvgx', 08:32:48 INFO - 'tsvgr_opacity', 08:32:48 INFO - 'tart', 08:32:48 INFO - 'tscrollx', 08:32:48 INFO - 'cart']}, 08:32:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:48 INFO - 'tests': ['tp5o']}, 08:32:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:48 INFO - 'talos_options': ['--e10s'], 08:32:48 INFO - 'tests': ['tp5o']}, 08:32:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:48 INFO - 'talos_options': ['--xperf_path', 08:32:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:48 INFO - 'tests': ['tp5n']}, 08:32:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:48 INFO - 'talos_options': ['--e10s', 08:32:48 INFO - '--xperf_path', 08:32:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:48 INFO - 'tests': ['tp5n']}}, 08:32:48 INFO - 'talos.zip': {'path': '', 08:32:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:32:48 INFO - Running post-action listener: _resource_record_post_action 08:32:48 INFO - ##### 08:32:48 INFO - ##### Running create-virtualenv step. 08:32:48 INFO - ##### 08:32:48 INFO - Running pre-action listener: _resource_record_pre_action 08:32:48 INFO - Running main action method: create_virtualenv 08:32:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:32:48 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 08:32:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:32:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:48 INFO - Using real prefix '/usr' 08:32:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:32:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:50 INFO - Installing pip.................done. 08:32:50 INFO - Return code: 0 08:32:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:32: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')]} 08:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32: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')]} 08:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdf655b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1840>, '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 0x1f3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', '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 08:32:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 08:32:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 08:32:50 INFO - Using env: {'DISPLAY': ':0', 08:32:50 INFO - 'HOME': '/home/cltbld', 08:32:50 INFO - 'LANG': 'en_US.UTF-8', 08:32:50 INFO - 'LANGUAGE': 'en_US:en', 08:32:50 INFO - 'LOGNAME': 'cltbld', 08:32:50 INFO - 'MAIL': '/var/mail/cltbld', 08:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:50 INFO - 'MOZ_NO_REMOTE': '1', 08:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:50 INFO - 'NO_EM_RESTART': '1', 08:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:32:50 INFO - 'PWD': '/builds/slave/test-pgo', 08:32:50 INFO - 'SHELL': '/bin/bash', 08:32:50 INFO - 'SHLVL': '1', 08:32:50 INFO - 'TERM': 'linux', 08:32:50 INFO - 'TMOUT': '86400', 08:32:50 INFO - 'USER': 'cltbld', 08:32:50 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', 08:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:50 INFO - '_': '/tools/buildbot/bin/python'} 08:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:51 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 08:32:51 INFO - Cleaning up... 08:32:51 INFO - Return code: 0 08:32:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdf655b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1840>, '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 0x1f3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', '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 08:32:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 08:32:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 08:32:51 INFO - Using env: {'DISPLAY': ':0', 08:32:51 INFO - 'HOME': '/home/cltbld', 08:32:51 INFO - 'LANG': 'en_US.UTF-8', 08:32:51 INFO - 'LANGUAGE': 'en_US:en', 08:32:51 INFO - 'LOGNAME': 'cltbld', 08:32:51 INFO - 'MAIL': '/var/mail/cltbld', 08:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:51 INFO - 'MOZ_NO_REMOTE': '1', 08:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:51 INFO - 'NO_EM_RESTART': '1', 08:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:32:51 INFO - 'PWD': '/builds/slave/test-pgo', 08:32:51 INFO - 'SHELL': '/bin/bash', 08:32:51 INFO - 'SHLVL': '1', 08:32:51 INFO - 'TERM': 'linux', 08:32:51 INFO - 'TMOUT': '86400', 08:32:51 INFO - 'USER': 'cltbld', 08:32:51 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', 08:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:51 INFO - '_': '/tools/buildbot/bin/python'} 08:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:51 INFO - Downloading/unpacking psutil>=0.7.1 08:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:32:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:32:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:32:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:53 INFO - Installing collected packages: psutil 08:32:53 INFO - Running setup.py install for psutil 08:32:53 INFO - building 'psutil._psutil_linux' extension 08:32:53 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 08:32:53 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 08:32:53 INFO - building 'psutil._psutil_posix' extension 08:32:53 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 08:32:53 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 08:32:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:53 INFO - Successfully installed psutil 08:32:53 INFO - Cleaning up... 08:32:53 INFO - Return code: 0 08:32:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdf655b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1840>, '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 0x1f3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', '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 08:32:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 08:32:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 08:32:53 INFO - Using env: {'DISPLAY': ':0', 08:32:53 INFO - 'HOME': '/home/cltbld', 08:32:53 INFO - 'LANG': 'en_US.UTF-8', 08:32:53 INFO - 'LANGUAGE': 'en_US:en', 08:32:53 INFO - 'LOGNAME': 'cltbld', 08:32:53 INFO - 'MAIL': '/var/mail/cltbld', 08:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:53 INFO - 'MOZ_NO_REMOTE': '1', 08:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:53 INFO - 'NO_EM_RESTART': '1', 08:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:32:53 INFO - 'PWD': '/builds/slave/test-pgo', 08:32:53 INFO - 'SHELL': '/bin/bash', 08:32:53 INFO - 'SHLVL': '1', 08:32:53 INFO - 'TERM': 'linux', 08:32:53 INFO - 'TMOUT': '86400', 08:32:53 INFO - 'USER': 'cltbld', 08:32:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', 08:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:53 INFO - '_': '/tools/buildbot/bin/python'} 08:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32: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 08:32:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:32:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:32:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:32:55 INFO - Installing collected packages: mozsystemmonitor 08:32:55 INFO - Running setup.py install for mozsystemmonitor 08:32:55 INFO - Successfully installed mozsystemmonitor 08:32:55 INFO - Cleaning up... 08:32:55 INFO - Return code: 0 08:32:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdf655b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1840>, '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 0x1f3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', '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 08:32:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 08:32:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 08:32:55 INFO - Using env: {'DISPLAY': ':0', 08:32:55 INFO - 'HOME': '/home/cltbld', 08:32:55 INFO - 'LANG': 'en_US.UTF-8', 08:32:55 INFO - 'LANGUAGE': 'en_US:en', 08:32:55 INFO - 'LOGNAME': 'cltbld', 08:32:55 INFO - 'MAIL': '/var/mail/cltbld', 08:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:55 INFO - 'MOZ_NO_REMOTE': '1', 08:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:55 INFO - 'NO_EM_RESTART': '1', 08:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:32:55 INFO - 'PWD': '/builds/slave/test-pgo', 08:32:55 INFO - 'SHELL': '/bin/bash', 08:32:55 INFO - 'SHLVL': '1', 08:32:55 INFO - 'TERM': 'linux', 08:32:55 INFO - 'TMOUT': '86400', 08:32:55 INFO - 'USER': 'cltbld', 08:32:55 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', 08:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:55 INFO - '_': '/tools/buildbot/bin/python'} 08:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:56 INFO - Downloading/unpacking blobuploader==1.2.4 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:57 INFO - Downloading blobuploader-1.2.4.tar.gz 08:32:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:32:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:32:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:32:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:32:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:32:58 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 08:32:58 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 08:32:58 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 08:32:58 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 08:32:58 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 08:32:58 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 08:32:58 INFO - Downloading docopt-0.6.1.tar.gz 08:32:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:32:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:32:58 INFO - Installing collected packages: blobuploader, requests, docopt 08:32:58 INFO - Running setup.py install for blobuploader 08:32:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:32:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:32:58 INFO - Running setup.py install for requests 08:32:58 INFO - Running setup.py install for docopt 08:32:59 INFO - Successfully installed blobuploader requests docopt 08:32:59 INFO - Cleaning up... 08:32:59 INFO - Return code: 0 08:32:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:32:59 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')]} 08:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:59 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')]} 08:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdf655b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1840>, '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 0x1f3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', '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 08:32:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 08:32:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 08:32:59 INFO - Using env: {'DISPLAY': ':0', 08:32:59 INFO - 'HOME': '/home/cltbld', 08:32:59 INFO - 'LANG': 'en_US.UTF-8', 08:32:59 INFO - 'LANGUAGE': 'en_US:en', 08:32:59 INFO - 'LOGNAME': 'cltbld', 08:32:59 INFO - 'MAIL': '/var/mail/cltbld', 08:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:59 INFO - 'MOZ_NO_REMOTE': '1', 08:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:59 INFO - 'NO_EM_RESTART': '1', 08:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:32:59 INFO - 'PWD': '/builds/slave/test-pgo', 08:32:59 INFO - 'SHELL': '/bin/bash', 08:32:59 INFO - 'SHLVL': '1', 08:32:59 INFO - 'TERM': 'linux', 08:32:59 INFO - 'TMOUT': '86400', 08:32:59 INFO - 'USER': 'cltbld', 08:32:59 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', 08:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:59 INFO - '_': '/tools/buildbot/bin/python'} 08:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:32:59 INFO - Running setup.py (path:/tmp/pip-j2kFAI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:32:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:32:59 INFO - Running setup.py (path:/tmp/pip-DMmgbb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:32:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:32:59 INFO - Running setup.py (path:/tmp/pip-vGgDoz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:32:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:32:59 INFO - Running setup.py (path:/tmp/pip-ZUN87d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:32:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:32:59 INFO - Running setup.py (path:/tmp/pip-fv_CU4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:32:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:32:59 INFO - Running setup.py (path:/tmp/pip-5ArAKJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:32:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:32:59 INFO - Running setup.py (path:/tmp/pip-iAbZi0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:32:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:32:59 INFO - Running setup.py (path:/tmp/pip-VqiIxE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:32:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:32:59 INFO - Running setup.py (path:/tmp/pip-iQ0hJ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:32:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:32:59 INFO - Running setup.py (path:/tmp/pip-QBCapV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:33:00 INFO - Running setup.py (path:/tmp/pip-LQAq0L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:33:00 INFO - Running setup.py (path:/tmp/pip-RWJQfQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:33:00 INFO - Running setup.py (path:/tmp/pip-L2wdqG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:33:00 INFO - Running setup.py (path:/tmp/pip-LJmXZl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:33:00 INFO - Running setup.py (path:/tmp/pip-lT8BUO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:33:00 INFO - Running setup.py (path:/tmp/pip-J_Y5m9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:33:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:33:00 INFO - Running setup.py (path:/tmp/pip-XTxDOD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:33:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:33:00 INFO - Running setup.py install for manifestparser 08:33:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:33:00 INFO - Running setup.py install for mozcrash 08:33:00 INFO - Running setup.py install for mozdebug 08:33:00 INFO - Running setup.py install for mozdevice 08:33:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:33:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:33:00 INFO - Running setup.py install for mozfile 08:33:01 INFO - Running setup.py install for mozhttpd 08:33:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:33:01 INFO - Running setup.py install for mozinfo 08:33:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:33:01 INFO - Running setup.py install for mozInstall 08:33:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:33:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:33:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:33:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:33:01 INFO - Running setup.py install for mozleak 08:33:01 INFO - Running setup.py install for mozlog 08:33:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:33:01 INFO - Running setup.py install for moznetwork 08:33:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:33:01 INFO - Running setup.py install for mozprocess 08:33:01 INFO - Running setup.py install for mozprofile 08:33:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:33:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:33:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:33:01 INFO - Running setup.py install for mozrunner 08:33:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:33:02 INFO - Running setup.py install for mozscreenshot 08:33:02 INFO - Running setup.py install for moztest 08:33:02 INFO - Running setup.py install for mozversion 08:33:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:33:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:33:02 INFO - Cleaning up... 08:33:02 INFO - Return code: 0 08:33:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:33:02 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')]} 08:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:02 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')]} 08:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdf655b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1840>, '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 0x1f3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', '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 08:33:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 08:33:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 08:33:02 INFO - Using env: {'DISPLAY': ':0', 08:33:02 INFO - 'HOME': '/home/cltbld', 08:33:02 INFO - 'LANG': 'en_US.UTF-8', 08:33:02 INFO - 'LANGUAGE': 'en_US:en', 08:33:02 INFO - 'LOGNAME': 'cltbld', 08:33:02 INFO - 'MAIL': '/var/mail/cltbld', 08:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:02 INFO - 'MOZ_NO_REMOTE': '1', 08:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:02 INFO - 'NO_EM_RESTART': '1', 08:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:02 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:02 INFO - 'SHELL': '/bin/bash', 08:33:02 INFO - 'SHLVL': '1', 08:33:02 INFO - 'TERM': 'linux', 08:33:02 INFO - 'TMOUT': '86400', 08:33:02 INFO - 'USER': 'cltbld', 08:33:02 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', 08:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:02 INFO - '_': '/tools/buildbot/bin/python'} 08:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:33:02 INFO - Running setup.py (path:/tmp/pip-RjaZ86-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:33:02 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)) 08:33:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:33:02 INFO - Running setup.py (path:/tmp/pip-fA4Exi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:33:02 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)) 08:33:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:33:02 INFO - Running setup.py (path:/tmp/pip-CecB0g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:33:02 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)) 08:33:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:33:02 INFO - Running setup.py (path:/tmp/pip-9JjFu_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:33:02 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)) 08:33:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:33:02 INFO - Running setup.py (path:/tmp/pip-gjbSGT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:33:02 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)) 08:33:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:33:02 INFO - Running setup.py (path:/tmp/pip-7iBB9D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:33:02 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)) 08:33:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:33:02 INFO - Running setup.py (path:/tmp/pip-UOyLTu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:33:03 INFO - Running setup.py (path:/tmp/pip-cmnFrv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:33:03 INFO - Running setup.py (path:/tmp/pip-yIt_5i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:33:03 INFO - Running setup.py (path:/tmp/pip-84iMNd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:33:03 INFO - Running setup.py (path:/tmp/pip-Kf6y8q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:33:03 INFO - Running setup.py (path:/tmp/pip-Ou6FWl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:33:03 INFO - Running setup.py (path:/tmp/pip-HElGi7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:33:03 INFO - Running setup.py (path:/tmp/pip-41XcqW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:33:03 INFO - Running setup.py (path:/tmp/pip-pwo1IG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:33:03 INFO - Running setup.py (path:/tmp/pip-dqk_mQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:33:03 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)) 08:33:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:33:03 INFO - Running setup.py (path:/tmp/pip-8JliE8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:33:03 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)) 08:33:03 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)) 08:33:03 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)) 08:33:03 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)) 08:33:03 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)) 08:33:03 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)) 08:33:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:05 INFO - Downloading blessings-1.5.1.tar.gz 08:33:05 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:33:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:33:05 INFO - Installing collected packages: blessings 08:33:05 INFO - Running setup.py install for blessings 08:33:05 INFO - Successfully installed blessings 08:33:05 INFO - Cleaning up... 08:33:05 INFO - Return code: 0 08:33:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:33:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:33:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:33:05 INFO - Reading from file tmpfile_stdout 08:33:05 INFO - Current package versions: 08:33:05 INFO - argparse == 1.2.1 08:33:05 INFO - blessings == 1.5.1 08:33:05 INFO - blobuploader == 1.2.4 08:33:05 INFO - docopt == 0.6.1 08:33:05 INFO - manifestparser == 1.1 08:33:05 INFO - mozInstall == 1.12 08:33:05 INFO - mozcrash == 0.16 08:33:05 INFO - mozdebug == 0.1 08:33:05 INFO - mozdevice == 0.48 08:33:05 INFO - mozfile == 1.2 08:33:05 INFO - mozhttpd == 0.7 08:33:05 INFO - mozinfo == 0.9 08:33:05 INFO - mozleak == 0.1 08:33:05 INFO - mozlog == 3.1 08:33:05 INFO - moznetwork == 0.27 08:33:05 INFO - mozprocess == 0.22 08:33:05 INFO - mozprofile == 0.28 08:33:05 INFO - mozrunner == 6.11 08:33:05 INFO - mozscreenshot == 0.1 08:33:05 INFO - mozsystemmonitor == 0.0 08:33:05 INFO - moztest == 0.7 08:33:05 INFO - mozversion == 1.4 08:33:05 INFO - psutil == 3.1.1 08:33:05 INFO - requests == 1.2.3 08:33:05 INFO - wsgiref == 0.1.2 08:33:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdf655b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1840>, '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 0x1f3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', '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 08:33:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 08:33:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 08:33:05 INFO - Using env: {'DISPLAY': ':0', 08:33:05 INFO - 'HOME': '/home/cltbld', 08:33:05 INFO - 'LANG': 'en_US.UTF-8', 08:33:05 INFO - 'LANGUAGE': 'en_US:en', 08:33:05 INFO - 'LOGNAME': 'cltbld', 08:33:05 INFO - 'MAIL': '/var/mail/cltbld', 08:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:05 INFO - 'MOZ_NO_REMOTE': '1', 08:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:05 INFO - 'NO_EM_RESTART': '1', 08:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:05 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:05 INFO - 'SHELL': '/bin/bash', 08:33:05 INFO - 'SHLVL': '1', 08:33:05 INFO - 'TERM': 'linux', 08:33:05 INFO - 'TMOUT': '86400', 08:33:05 INFO - 'USER': 'cltbld', 08:33:05 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', 08:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:05 INFO - '_': '/tools/buildbot/bin/python'} 08:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:06 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)) 08:33:06 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)) 08:33:06 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)) 08:33:06 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)) 08:33:06 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)) 08:33:06 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)) 08:33:06 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)) 08:33:06 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)) 08:33:06 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)) 08:33:06 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)) 08:33:06 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)) 08:33:06 INFO - Cleaning up... 08:33:06 INFO - Return code: 0 08:33:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:33:06 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')]} 08:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:06 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')]} 08:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdf655b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1840>, '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 0x1f3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', '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 08:33:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 08:33:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 08:33:06 INFO - Using env: {'DISPLAY': ':0', 08:33:06 INFO - 'HOME': '/home/cltbld', 08:33:06 INFO - 'LANG': 'en_US.UTF-8', 08:33:06 INFO - 'LANGUAGE': 'en_US:en', 08:33:06 INFO - 'LOGNAME': 'cltbld', 08:33:06 INFO - 'MAIL': '/var/mail/cltbld', 08:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:06 INFO - 'MOZ_NO_REMOTE': '1', 08:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:06 INFO - 'NO_EM_RESTART': '1', 08:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:06 INFO - 'SHELL': '/bin/bash', 08:33:06 INFO - 'SHLVL': '1', 08:33:06 INFO - 'TERM': 'linux', 08:33:06 INFO - 'TMOUT': '86400', 08:33:06 INFO - 'USER': 'cltbld', 08:33:06 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', 08:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:06 INFO - '_': '/tools/buildbot/bin/python'} 08:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:06 INFO - Downloading/unpacking jsonschema 08:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:33:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:33:08 INFO - Downloading/unpacking functools32 (from jsonschema) 08:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:08 INFO - Downloading functools32-3.2.3-2.tar.gz 08:33:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:33:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:33:08 INFO - warning: no files found matching '*.txt' 08:33:08 INFO - no previously-included directories found matching 'build' 08:33:08 INFO - no previously-included directories found matching 'dist' 08:33:08 INFO - no previously-included directories found matching '.git*' 08:33:08 INFO - Installing collected packages: jsonschema, functools32 08:33:08 INFO - Running setup.py install for functools32 08:33:08 INFO - warning: no files found matching '*.txt' 08:33:08 INFO - no previously-included directories found matching 'build' 08:33:08 INFO - no previously-included directories found matching 'dist' 08:33:08 INFO - no previously-included directories found matching '.git*' 08:33:08 INFO - Successfully installed jsonschema functools32 08:33:08 INFO - Cleaning up... 08:33:08 INFO - Return code: 0 08:33:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdf655b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd1840>, '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 0x1f3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', '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 08:33:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 08:33:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 08:33:08 INFO - Using env: {'DISPLAY': ':0', 08:33:08 INFO - 'HOME': '/home/cltbld', 08:33:08 INFO - 'LANG': 'en_US.UTF-8', 08:33:08 INFO - 'LANGUAGE': 'en_US:en', 08:33:08 INFO - 'LOGNAME': 'cltbld', 08:33:08 INFO - 'MAIL': '/var/mail/cltbld', 08:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:08 INFO - 'MOZ_NO_REMOTE': '1', 08:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:08 INFO - 'NO_EM_RESTART': '1', 08:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:08 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:08 INFO - 'SHELL': '/bin/bash', 08:33:08 INFO - 'SHLVL': '1', 08:33:08 INFO - 'TERM': 'linux', 08:33:08 INFO - 'TMOUT': '86400', 08:33:08 INFO - 'USER': 'cltbld', 08:33:08 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', 08:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:08 INFO - '_': '/tools/buildbot/bin/python'} 08:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:08 INFO - Downloading/unpacking flake8 08:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:33:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:33:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:33:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:33:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:33:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:33:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:33:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:33:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:33:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:33:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:33:11 INFO - no previously-included directories found matching 'docs/_build' 08:33:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:33:11 INFO - Running setup.py install for pep8 08:33:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:33:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:33:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:33:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:33:11 INFO - no previously-included directories found matching 'docs/_build' 08:33:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:33:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:33:11 INFO - Cleaning up... 08:33:11 INFO - Return code: 0 08:33:11 INFO - Running post-action listener: _resource_record_post_action 08:33:11 INFO - Running post-action listener: _start_resource_monitoring 08:33:11 INFO - Starting resource monitoring. 08:33:11 INFO - ##### 08:33:11 INFO - ##### Running install step. 08:33:11 INFO - ##### 08:33:11 INFO - Running pre-action listener: _resource_record_pre_action 08:33:11 INFO - Running main action method: install 08:33:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:33:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:33:11 INFO - Reading from file tmpfile_stdout 08:33:11 INFO - Detecting whether we're running mozinstall >=1.0... 08:33:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:33:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:33:11 INFO - Reading from file tmpfile_stdout 08:33:11 INFO - Output received: 08:33:11 INFO - Usage: mozinstall [options] installer 08:33:11 INFO - Options: 08:33:11 INFO - -h, --help show this help message and exit 08:33:11 INFO - -d DEST, --destination=DEST 08:33:11 INFO - Directory to install application into. [default: 08:33:11 INFO - "/builds/slave/test-pgo"] 08:33:11 INFO - --app=APP Application being installed. [default: firefox] 08:33:11 INFO - mkdir: /builds/slave/test-pgo/build/application 08:33:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:33:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:33:27 INFO - Reading from file tmpfile_stdout 08:33:27 INFO - Output received: 08:33:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:33:27 INFO - Running post-action listener: _resource_record_post_action 08:33:27 INFO - ##### 08:33:27 INFO - ##### Running run-tests step. 08:33:27 INFO - ##### 08:33:27 INFO - Running pre-action listener: _resource_record_pre_action 08:33:27 INFO - Running main action method: run_tests 08:33:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:33:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:33:27 INFO - Python 2.7.3 08:33:27 INFO - Return code: 0 08:33:27 INFO - grabbing minidump binary from tooltool 08:33:27 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')]} 08:33:27 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 0x1fd1840>, '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 0x1f3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f3eb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:33:27 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 08:33:27 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 08:33:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:27 INFO - Return code: 0 08:33:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:33:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:33:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:33:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:33:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:33:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:33:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:33:28 INFO - Return code: 0 08:33:28 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 08:33:28 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:33:28 INFO - Using env: {'DISPLAY': ':0', 08:33:28 INFO - 'HOME': '/home/cltbld', 08:33:28 INFO - 'LANG': 'en_US.UTF-8', 08:33:28 INFO - 'LANGUAGE': 'en_US:en', 08:33:28 INFO - 'LOGNAME': 'cltbld', 08:33:28 INFO - 'MAIL': '/var/mail/cltbld', 08:33:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:33:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:28 INFO - 'MOZ_NO_REMOTE': '1', 08:33:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:28 INFO - 'NO_EM_RESTART': '1', 08:33:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:28 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:33:28 INFO - 'SHELL': '/bin/bash', 08:33:28 INFO - 'SHLVL': '1', 08:33:28 INFO - 'TERM': 'linux', 08:33:28 INFO - 'TMOUT': '86400', 08:33:28 INFO - 'USER': 'cltbld', 08:33:28 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018', 08:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:28 INFO - '_': '/tools/buildbot/bin/python'} 08:33:28 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:33:28 INFO - mozversion application_buildid: 20160118053004 08:33:28 INFO - mozversion application_changeset: 888e32f5c427e5840ca943dbb7ac6344aff59b38 08:33:28 INFO - mozversion application_display_name: Nightly 08:33:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:28 INFO - mozversion application_name: Firefox 08:33:28 INFO - mozversion application_remotingname: firefox 08:33:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:33:28 INFO - mozversion application_vendor: Mozilla 08:33:28 INFO - mozversion application_version: 46.0a1 08:33:28 INFO - mozversion platform_buildid: 20160118053004 08:33:28 INFO - mozversion platform_changeset: 888e32f5c427e5840ca943dbb7ac6344aff59b38 08:33:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:33:28 INFO - mozversion platform_version: 46.0a1 08:33:28 INFO - using testdate: 1453134808 08:33:28 INFO - actual date: 1453134808 08:33:28 INFO - starting webserver on 'localhost:52192' 08:33:28 INFO - SUITE-START | Running 3 tests 08:33:28 INFO - TEST-START | dromaeo_css 08:33:28 INFO - operating with platform_type : linux_ 08:33:28 INFO - Initialising browser for dromaeo_css test... 08:33:28 INFO - TEST-INFO | started process 17812 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGMc5rW/profile http://localhost:52192/getInfo.html) 08:33:33 INFO - PROCESS | 17812 | 08:33:33 INFO - PROCESS | 17812 | (process:17897): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:33:34 INFO - PROCESS | 17812 | __metrics Screen width/height:1600/1200 08:33:34 INFO - PROCESS | 17812 | colorDepth:24 08:33:34 INFO - PROCESS | 17812 | Browser inner width/height: 1024/697 08:33:34 INFO - PROCESS | 17812 | __metrics 08:33:34 INFO - PROCESS | 17812 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:33:35 INFO - TEST-INFO | 17812: exit 0 08:33:35 INFO - Browser initialized. 08:33:35 INFO - Running cycle 1/1 for dromaeo_css test... 08:33:35 INFO - TEST-INFO | started process 17945 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGMc5rW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:35 INFO - PROCESS | 17945 | -- checkerboarding starts below -- 08:33:35 INFO - PROCESS | 17945 | RENDERTRACE 0.085662 rect red 0 0 10 10 // viewport 08:33:35 INFO - PROCESS | 17945 | RENDERTRACE 4.87408 rect red 0 0 10 10 // viewport 08:33:35 INFO - PROCESS | 17945 | RENDERTRACE 29.0888 rect brown 0 0 10 10 // page 08:33:35 INFO - PROCESS | 17945 | RENDERTRACE 29.1189 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 08:33:35 INFO - PROCESS | 17945 | Checkerboarded for 2 frames (29.2119 ms), 100 peak, 486 severity. 08:33:36 INFO - PROCESS | 17945 | 08:33:36 INFO - PROCESS | 17945 | (process:18001): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:33:47 INFO - PROCESS | 17945 | RSS: Main: 148852736 08:33:47 INFO - PROCESS | 17945 | 08:34:36 INFO - PROCESS | 17945 | 1453134876635 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] 08:36:45 INFO - PROCESS | 17945 | Cycle 1(1): loaded http://localhost:52192/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52192/tests/dromaeo/cssquery-ext.html) 08:36:46 INFO - PROCESS | 17945 | RSS: Main: 155725824 08:36:46 INFO - PROCESS | 17945 | 08:39:48 INFO - PROCESS | 17945 | Cycle 1(1): loaded http://localhost:52192/tests/dromaeo/cssquery-ext.html (next: http://localhost:52192/tests/dromaeo/cssquery-jquery.html) 08:39:49 INFO - PROCESS | 17945 | RSS: Main: 150568960 08:39:49 INFO - PROCESS | 17945 | 08:42:51 INFO - PROCESS | 17945 | Cycle 1(1): loaded http://localhost:52192/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52192/tests/dromaeo/cssquery-mootools.html) 08:42:51 INFO - PROCESS | 17945 | RSS: Main: 151093248 08:42:51 INFO - PROCESS | 17945 | 08:45:53 INFO - PROCESS | 17945 | Cycle 1(1): loaded http://localhost:52192/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52192/tests/dromaeo/cssquery-prototype.html) 08:45:54 INFO - PROCESS | 17945 | RSS: Main: 149401600 08:45:54 INFO - PROCESS | 17945 | 08:48:56 INFO - PROCESS | 17945 | Cycle 1(1): loaded http://localhost:52192/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52192/tests/dromaeo/cssquery-yui.html) 08:48:57 INFO - PROCESS | 17945 | RSS: Main: 150233088 08:48:57 INFO - PROCESS | 17945 | 08:51:59 INFO - PROCESS | 17945 | Cycle 1(1): loaded http://localhost:52192/tests/dromaeo/cssquery-yui.html (next: http://localhost:52192/tests/dromaeo/cssquery-dojo.html) 08:51:59 INFO - PROCESS | 17945 | RSS: Main: 152674304 08:51:59 INFO - PROCESS | 17945 | 08:51:59 INFO - PROCESS | 17945 | __start_tp_report 08:51:59 INFO - PROCESS | 17945 | _x_x_mozilla_page_load 08:51:59 INFO - PROCESS | 17945 | _x_x_mozilla_page_load_details 08:51:59 INFO - PROCESS | 17945 | |i|pagename|runs| 08:51:59 INFO - PROCESS | 17945 | |0;dojo.html;3169.9999999999986;3170.1440611035023;3208.534762459445;3219.388316219918;3224.048905572856;5180.507851754077;5246.501582349671;5258.684478931267;5277.604179686525;5306.177542480917;5240.266362709223;5261.8947621047555;5328.92006619901;5349.8127565535215;5350.0904846176145;4778.737169455679;4793.9280910786365;4880.048390563841;4982.352294201749;5004.774785134659;4887.486813884544;4891;4906.165951788204;4958.528939750736;4961.131801934665;4728.739919304437;4797.928031079537;4810.711357318537;4892.437369702494;4894.5105489451125;4797.256425254056;4826.251930950708;4839.564439200489;4846.36997190363;4868.148074087056;4664.416947881515;4777.498362671939;4837.879053023703;4863.319135321058;4898.926516102261;5046.4701206373165;5116.51393117657;5132.5124113209185;5146.279520867081;5159.071367153911;5656.349519805234;5690.687012214326;5710.457506536873;5736.483716465496;5744.798932037401;5541.418151094117;5675.574331925122;5703.857403564944;5748.425157484218;5758.3665796762325;5369.81205657804;5380.757865896044;5403.432639572867;5403.83788486346;5408.161734931092;5765.711714414262;5781.364049954502;5783.942160578425;5785.334686511021;5788.913166302509;5447.237386765856;5547.8890422192135;5549.5837812164245;5595.356533998643;5597.328320601472;5711.286089238845;5738.397468265855;5754.223179870748;5756.856078597984;5783.595148339576;5670.603057785998;5673.120666296731;5681.488666019995;5693.345265294544;5710.857228569319;5588.580856435784;5612.522935550524;5612.831615051555;5694;5698.1737648041635;4410.07388448423;4410.117976404732;4413.073254616503;4423.668224883147;4423.955760442419;3911.2568611963634;3925.175713100281;3937.9606203938165;3942.6845852331744;3944.980275098606;5239.161734122522;5337.706426146599;5386.084365657847;5429.049916264638;5436.075867102602;5690.4025077367105;5726.2555867737765;5728.312602487728;5741.598088133874;5758.049921762862;5110.872228194325;5303.15149576066;5325.733713314319;5354.812581559627;5390.9191362129595;4798.928016079762;4820.807167713322;4828.734419606955;4830.589399901048;4834.154023045953;5760.36635970043;5815.41845815415;5822.388649191858;5827.562932779973;5833.795817146464;5697.23087383198;5714.942850571441;5744.511716504144;5756.7409466574945;5783.595148339744;5786.652800831964;5789.218455508452;5789.594728368974;5828.213191219301;5832.883342333214;5537.529310008695;5564.860878478071;5571.3592936811165;5585.357683866408;5626.24045753818;5654.547636189177;5666.405027472056;5710.914336285042;5715.114157305624;5758.222639943554;5534.308211473566;5566.332040155207;5573.693446860461;5579.916301255404;5602.439756024528;5498.230247765236;5559.471850174227;5588.580856435702;5594.356648985418;5600.747966341443;5462.8907421850545;5496.065668836228;5501.119820828648;5503.752331145028;5543.501084902378;5543.972280138573;5558.777648893999;5579.386267510652;5584.609077364708;5615.438456154352;5393.029254734185;5406.567474601944;5469.2616496772425;5470.699111548903;5527 08:51:59 INFO - PROCESS | 17945 | |1;ext.html;515.7395515264791;518.1140250172206;542.6771071212628;562.6286650810466;594.0406243916074;35582.644173558256;36467.817660911656;36499.452508212395;36541.63458365419;36614.45078323827;39086.80456597713;39705.40441893374;39714.404283935764;39869.202615947666;39948;8296.502209867413;8435.95782021089;8482.957585212096;8483.915160848373;8502.872456913152;8211.096779354266;8261.215184557457;8333.250007499324;8336.499810011419;8346.165383461635;8472.15278472151;8520.446170998895;8616.612252448655;8639.352048596349;8645.69740059098;8502.107278735737;8550.786230344229;8564.272036876873;8569.614367353484;8579.485230886105;8555.48667079971;8679.609417576161;8697.739067827975;8700.521471319074;8701.738947831574;41027;41325.346986120516;41539;41559.792201039105;41628.79185604083;2805.9719402805913;3243.383757086146;3294.390537750524;3315.93368132636;3638.308721342936;27131.864340678367;27251;27345.31636709078;27462.313442163904;27634.447311053867;3864;3945.3884647879627;3951.8221680024467;4022.6178513041214;4121.010957370239;184598;186362;186399.06800466045;186602;186703;54160.45839541633;55270;57019.71490142523;57473;62088;56097.43902561004;56185.7190714052;56380;56534;56672.716636417375;13448.663783405298;13665.248411337472;13700.65748356299;13737.656558585915;13750.518731844337;9126.45241285525;9154.81690366189;9203.125703058198;9203.263738900872;9222.723318300461;20348.28780992688;20813.895930520554;20853;20936.37190884276;20954;7312.378447831994;7497.962510187524;7536.623168841536;7545.132309784335;7580.128285247157;872.5549969515592;918.875951746519;980.7106903463496;1078.191356482638;1105.0772604874858;29224.269393264913;29630.259243519085;30519.0107713571;30711.38577228443;32931.176720582174;1003.6988903328972;1028.927975041755;1034.043509753475;1061.7451811565322;1094.6497120921229;13886.513972011133;14389.568312950629;14398.42406303736;14453.927730361282;14594.708105837824;336222;336705;338577;340345;341758;53555.73222133942;53579.46420535745;53823.73088134534;53825;53904.73047634815;1350.081944277881;1356.0778670503955;1365.112676760094;1367.924764137982;1375.195510626295;26337.868310658323;27320.453590928468;27337.179884603494;27544;27792;45127.32309015302;45243.32135017912;45318.54681453143;45352.31971520364;45663.31505027361;312965;313012;314417;315042;315253;32004;32221.838890805397;32543.674563255012;32711.18222044468;32717.836410817792;38823;38885.8055709731;39743.80128099341;39943.400848986705;40354;33361.16597084995;36200.27599447944;37342.253154937294;37423;37799.62200378071;33352.66647333495;33471.16322091967;33492;33526.497102543966;35122.82438587791;32652.183695407806;33058.33883322272;33161.83419082889;33167;33203.50194747129;29567.112986610435;29784.404311914073;32153.678463215067;32411.837940810146;32726.181845453102;25114.62328065117;25252.969643642882;25420.49159016846;25605;25606 08:51:59 INFO - PROCESS | 17945 | |2;jquery.html;363.3350967729055;364.92519033598114;365.3733846453332;366.3405869435017;367.8951498822836;15667.60830979226;15978.440754573578;16695.91652041738;16733.916330418346;17547;11084.61203857865;11280.887191128086;16199.1090490023;16210.594735131628;16348.673026539493;4815.085133824571;5378.8924221515545;5404.405515393303;5442.591805614575;5453.182022696607;5269.051570717269;5360.303160589118;5441.156620723794;5476.972615136919;5481.040817856879;5162.328897243353;5342.385625653042;5414.242006119146;5430.239766432703;5441.047816632094;5263.605229607776;5267.920981185285;5271.209318602221;5291.550218231455;5345.118055520835;5336.866578335573;5382.6232163748555;5384.569234461273;5392.730363481849;5406.053940560386;12491;12669.429875655618;12936.805947910789;12948.935255323662;12958.157719748186;2062.0823733438624;2118.7139736135578;2191.41927389242;2202.828530837119;2286.588414085464;9359.344845860793;9526.190273826733;9598.520073996273;9754.46350450725;9770.90229097707;1851.1484717030048;1954.9609007819763;2012.537116463207;2016.485796121994;2032.3801240621603;50449;51053.23420148664;51188.488115118744;52276.21585676218;52336.21495677568;9914.107730304308;9943.45311007887;9952.253580981456;9991.300608957448;10023.548940297704;12956.28740419286;13018.349082546025;13041.673958151123;13067.869321306665;13090.476380944847;6801.081853949752;6827.453803695693;6950.443964482829;6980.371766540934;7036.296370362923;6541.803745887631;6603.7688680895935;6608.074869518271;6614.768483103068;6621.139251897319;4299.634531064832;4382.517923028464;4385.912281754411;4405.7797110144365;4421.53573874745;1743.2678275124479;1843.5022543913337;1854.5270955906158;1860.8976506292283;1863.3664554051688;790.5765654060756;885.6767279942775;887.8091210389669;907.6324088744069;916.2990312411011;16238.025718456931;16318.75521867173;16659.916700416663;16930.153492325335;17073.146342682816;890.4301247201796;911.3574929674563;954.9713508594754;987.4766373821886;1032.1330082730542;9214.677486287948;9309.953450232706;9356.391834530734;9365.157135857806;9425.2931030173;529250;538905;541698;554634;555764;71233.64383178052;74052.25947740562;75553.62223188848;75850.62074689592;77719.22280777233;1139.3733446604335;1151.4703236511132;1158.5192145259791;1160.1356989043218;1162.3607016141257;14112.435502580192;14429.134251944497;14449.205293708526;14465.132092074089;14720.043197192148;32106.83946580252;32222.35555288928;33092.83453582717;33389;33507.49738753872;45605.31592026056;47129.293060603435;47413.525864740914;47447;50606;7226.313500217471;7286.672099755418;7451.068616422947;7535.623218838927;7553.206913274247;9701.369410988264;9717.951410242904;10329.225308102074;10698.41158736277;11333.943330283295;6836.418904393182;7796.4932279401655;8442.873356899529;9375.812483750151;9382.577783999874;9451.50541710724;9682.806343873224;9823.263255256028;10048.849267261143;10467.738306542398;9105.7268281949;9445.763855903657;9680.5643746033;9747.122758951728;9778.23435248112;7009.649517524205;7101.076860008373;7435.776926692208;7442.590657513889;7556.055493063367;9022.864657030019;9489.952550237205;9552.417544034563;9649.083337082966;9814 08:51:59 INFO - PROCESS | 17945 | |3;mootools.html;1415.4126037694357;1484.7030593881227;1630.5760502269407;1770.3449723602268;1773.3704534890114;7696;7719.575423351714;7849.921500784991;7902.84194316114;7978.162292959236;7763.4177436692335;7827.412944029206;7832.765017049498;7907.920920790791;7920.128785833554;2315.270689732737;2342.203650758742;2344.8475849069755;2345.3901985483726;2347;2282.9543409131807;2310.6187479065934;2311.04091801902;2323.337848713117;2323.732770731362;2282.3837563857746;2282.4065742906882;2298.321995011476;2339.5671800716923;2341.4731685370825;2277.81777457803;2288.794008539231;2304.0783686525356;2306.4695120122465;2341.2039906431896;2349.988250058756;2355.3758254062686;2356.9410764730846;2357.0807385119815;2357.846739961897;7677.270659287359;7801.531908085533;7850.528968261922;7850.764477065697;7851.332636725885;4768.260919557474;4781.832635857763;4836.298736683197;4851.684640498356;4859.198232291667;3065.7853950223493;3086.675899030592;3196.7762256642045;3205.759568032407;3218.2758879252215;1004.4475538453894;1014.9644762433279;1030.68048904839;1063.648995831374;1088.9891101088967;10732.73168170802;10739.677809665722;10756.677299680943;10800.51397687106;10855.620053298175;4291.6566674665955;4443.400140980991;4456.264716321835;4467.419235499365;4533.433320834895;9400.482973436527;9410.106039926197;9410.95294523523;9419.811603768023;9426.151646351862;4865.343178670905;4870.269459581091;4879.731614761151;4881.8535443936735;4884.7069175849565;4367.737935723867;4396.120775844844;4400.69195156336;4404.889877753082;4408.58118478744;3647.2340808430527;3699.1122130688977;3722;3723.3670276053135;3740.6446387593137;1121.6354684727496;1153.8096214124744;1154.9942250288864;1155.439611788282;1189.5182451107316;1265.4621785741024;1272.8154417609394;1286.5497076023316;1327.4424741608548;1330.6340756291904;7354.080739907512;7372.115346158495;7429.442791790637;7455.925440745632;7459.813504662427;1131.4003578103454;1132.6318946342308;1143.8512993310983;1154.2843437068902;1159.2406973432414;5626.634268772516;5739.7704091836695;5742.339630942495;5794.478496935296;5801.854953626109;8957;9164.358494905426;9173.816523669622;9234.676786312446;9354.625814967461;8922.063183365783;8987.505687187268;9075.092490751003;9109.863352049724;9173.81652366949;7102.792525270716;7152.213256541776;7261.491695581364;7270.63646817657;7300.744473943387;7291.8177045572165;7297.744578939712;7378.520396174232;7390.371818395497;7406.555606663617;8083.434159608771;8274.420790544846;8280.627371768165;8302.211289927447;8533.701320453754;8483.575821209039;8756.168164024408;8805.16350946659;8821.161989610977;8846.734597962071;7002.894956575554;7114.893276600752;7137.321954414322;7148.821279468055;7152.606606636685;7459.888101678371;7483.738069167553;7487.625618718933;7530.698772049276;7560.319571238615;6847.520673552804;6934.826629334307;6974.093367862146;7008.439324854102;7337.59643219628;6893.724251029903;6942.548734332252;6983.546069505466;7030.437564994686;7035.929640703732;7021.824454388681;7072.257412971564;7079.362857342864;7111.608861512666;7115.893261600977;6359.17330747;6545.5090868184125;6547.9672601636685;6549.083128362128;6555.410013098844;6558.80323590293;6566.704498297492;6576.8355791105605;6580.078788969644;6630.734770609121 08:51:59 INFO - PROCESS | 17945 | |4;prototype.html;341.7453996772404;341.83250207398385;349.78138663335415;350.7719982011692;352.8182985762333;6251.312355640882;6281.214848143982;6309.211348581427;6344.3338449462835;6485.416312531871;6266.436020758131;6273.843153921154;6292.496600271978;6298.055291706235;6310.085037669547;4689.88275293117;4720.362751028619;4747.430308362993;4751.667383283171;4753.0493901219725;4735.83424580138;4765.499622539635;4769.332293478916;4775.689580177294;4780.37855078841;4648.116857797025;4705.55297246761;4722.881927951811;4735.621150307984;4740.905181896377;4689.765511724418;4702.200625893589;4719.740414277213;4724.291356296583;4727.456342520602;4097.733647312915;4102.0360215349365;4109.301418758818;4118.588141185887;4120.320147175712;5953.493953013999;5981.641101533922;5989.341172471025;5990.490808281258;6000.939990600082;5423.2949716537;5476.342838859323;5526.917096243559;5533.889322213573;5536.916946245809;6646.003099535108;6648.767293144717;6651.76718814844;6658.034584985198;6666.333366663343;4557.020240648243;4575.885602859955;4584.839530616412;4586.54134586542;4601.378813860119;6773.796786096375;6875.518713690044;6953.096097507342;6971.895421568681;6974.232834388214;4620.168369693488;4622.537746225351;4626.560476754703;4638.907221855611;4646.8141274348645;4704.95295047052;4714.976425117852;4715.976420117946;4717.740524271129;4719.9292010619865;5451.155070964007;5457.2905522282645;5462.126059830488;5464.23500709901;5473.480019398151;6597.175353080865;6618.205815302098;6683.198016237985;6683.532152749358;6722.697478613474;1614.6286354138615;1643.030611938938;1648.8433598808094;1651.6283836136772;1657.8590819780213;1096.5668560918393;1105.4362275239525;1114.9777004460027;1117.0728295514702;1127.5827943660897;6174.845628859224;6220.937790622126;6224.502039836802;6241.906371404432;6242.282137554149;6720;6767.289434609295;6770.390664840188;6776.9322306777285;6790.898136527956;6105.908411373833;6189.659568723763;6206.317305096436;6207.96896015517;6213.937860621426;3669.7798132111625;3688.299223147647;3689.9631003690156;3692.095436617992;3693.519842420468;6925.792226233221;6941.652917354112;6941.965290173517;6969.372756451842;7100.644967751592;6787.219469760942;6938.375546200866;6947.548409353376;6948.756793512202;6955.860882782316;6999.475039372068;7080.114985626797;7081.82295442618;7082.114735658043;7102.715891364288;6716.932830671826;6730.596164230162;6768;6776.356246156607;6777.254502004874;6577.3422657733845;6677.899831502435;6697.933020669731;6722.865542689216;6734.393904548614;7063.470239732143;7083.5041547091205;7094.822629434099;7096.53872498286;7104.609246491493;4639.48965613789;4661.86014419568;4663.580277775017;4674.485806561343;4679.532046795293;6703.463722902254;6773.593584384953;6797.660116994031;6804.625745583842;7027.402670773042;6793.082933803873;6795.28649491816;6808.285130061272;6818;6821.249662537018;6774.390304872585;6782.253952065367;6797.014432907102;6798;6817.488688348294;6539.574927629689;6611.471082313499;6633.800985970429;6668.466522678271;6672.399484046459;6730.057791909235;6804.591724496546;6814.386705196556;6822.3859852613505;6841.042254084333;6627.105340779126;6633.336666333328;6646.4350530205475;6670.332966703485;6675.666216689049 08:51:59 INFO - PROCESS | 17945 | |5;yui.html;713.5148099292479;728.2790037862518;824.5671022713076;845.6955496021433;848.0417128644631;13306.401211945462;13318.267495287755;13380.330983450825;13462.124961877484;13467.528636497724;12914;12978.286194259312;12994.935025324883;13004.54484093057;13005.349732513383;815.8123631564744;822.6750433578733;831.8669012957928;837.1670188162786;840.5797101449275;832.6128350317101;833.4624167412015;836.3184005035906;838.266516797802;838.6603425612636;866.8179682266732;868.9217970382664;870.7387783664907;870.9346798990069;871.9084496127911;866.0733015673201;866.3415803988951;866.536403024382;866.8829707989436;868.9435186712907;636.3318515558645;637.687533108778;637.9617222966637;638.2564312575844;638.7253481003166;13001.15492492985;13216.14095083826;13223.603291901161;13228.140170888957;13404.664883377896;12480.875191248153;12577.434015469325;12738.426770795337;12770.169938953939;12840.515539652415;10401.84397234042;10489.318194317346;10504.054635082803;10524.631637892637;10597.523111459926;3537.557805274341;3592.6048134705425;3609.1338078861145;3635.1275693833554;3723.553173619156;47278.05443891172;47914;48014.759926200495;48293.275600865665;48673.51326486725;9657.855132173023;10092.04125608066;10154.339967902062;10185.541650625739;10239.539220735085;18051.819481805276;18081.7287740684;18202.362917297833;18205.81794182068;18238.635227295646;7316.780496585111;7392.74125405619;7461.626918654154;7525.58609276495;7638.465307428538;4209.936850947238;4264.381664658669;4269.252880745857;4292.227399068198;4316.762578058174;3165.5568220449154;3175.825329606894;3185.8725650974166;3189.6331921829287;3191.8404079796383;586.0447470622858;592.0704493944465;592.6532978207711;597.6444015810673;599.2299894635372;476.349782546828;491.6411019955452;507.2948601443996;600.0279547133584;659.3439527669999;8745;8781.297496200288;8831;9042.638294468148;9074.546272686339;533.2401328107431;540.2436588775745;583.988320233593;625.140431906129;657.0899304463353;4182.121754431603;4249.787510624456;4263.701540892108;4301.91396172081;4323.891902702395;54816.72591637016;55462;55494.722526387915;55534.444655553736;55865.441345586834;48573.75713121482;49074;49491.75254123707;50941;51542;45848.54151458442;46335.768321158175;46803;47208.76395618;47254.5274547257;8380.874286885824;8440.873386899078;8537.18896704812;8549.615267313111;8569.719924250074;34273;34539;34888;34991.30017399689;35266;40952.79523602363;44020.11959760723;44270;44656.77671611621;44829.77585112184;10023.498825058863;10114.342567733074;10122.79754404893;10124.13944814699;10252.23108266868;10924.180686448708;11006.834897476385;11058.723531911766;11209.495572699085;11210.66368008961;10165.186785057325;10421.791564168825;10546.736331591772;10629.309094908805;10639.468026598794;9529.475878826732;9694.272929530454;9909.65316213929;9927.205823534245;9938.552765125442;11017.669469915594;11661.008814250883;11711.472983715583;11726.237794543327;12124.757504849676;8710.869336959824;8839.16027977341;9208.861867072133;9380.81238375215;9450.43297402158;9006.842338022556;9198.49408282551;9328.626854925727;9685.564149613425;9697.175740062174 08:51:59 INFO - PROCESS | 17945 | __end_tp_report 08:51:59 INFO - PROCESS | 17945 | __start_cc_report 08:51:59 INFO - PROCESS | 17945 | _x_x_mozilla_cycle_collect,309 08:51:59 INFO - PROCESS | 17945 | __end_cc_report 08:51:59 INFO - PROCESS | 17945 | __startTimestamp1453135919809__endTimestamp 08:51:59 INFO - PROCESS | 17945 | 08:51:59 INFO - PROCESS | 17945 | ------- Summary: start ------- 08:51:59 INFO - PROCESS | 17945 | Number of tests: 6 08:51:59 INFO - PROCESS | 17945 | 08:51:59 INFO - PROCESS | 17945 | [#0] dojo.html Cycles:165 Average:5279.26 Median:5498.23 stddev:576.05 (10.5%) stddev-sans-first:553.54 08:51:59 INFO - PROCESS | 17945 | Values: 3170.0 3170.1 3208.5 3219.4 3224.0 5180.5 5246.5 5258.7 5277.6 5306.2 5240.3 5261.9 5328.9 5349.8 5350.1 4778.7 4793.9 4880.0 4982.4 5004.8 4887.5 4891.0 4906.2 4958.5 4961.1 4728.7 4797.9 4810.7 4892.4 4894.5 4797.3 4826.3 4839.6 4846.4 4868.1 4664.4 4777.5 4837.9 4863.3 4898.9 5046.5 5116.5 5132.5 5146.3 5159.1 5656.3 5690.7 5710.5 5736.5 5744.8 5541.4 5675.6 5703.9 5748.4 5758.4 5369.8 5380.8 5403.4 5403.8 5408.2 5765.7 5781.4 5783.9 5785.3 5788.9 5447.2 5547.9 5549.6 5595.4 5597.3 5711.3 5738.4 5754.2 5756.9 5783.6 5670.6 5673.1 5681.5 5693.3 5710.9 5588.6 5612.5 5612.8 5694.0 5698.2 4410.1 4410.1 4413.1 4423.7 4424.0 3911.3 3925.2 3938.0 3942.7 3945.0 5239.2 5337.7 5386.1 5429.0 5436.1 5690.4 5726.3 5728.3 5741.6 5758.0 5110.9 5303.2 5325.7 5354.8 5390.9 4798.9 4820.8 4828.7 4830.6 4834.2 5760.4 5815.4 5822.4 5827.6 5833.8 5697.2 5714.9 5744.5 5756.7 5783.6 5786.7 5789.2 5789.6 5828.2 5832.9 5537.5 5564.9 5571.4 5585.4 5626.2 5654.5 5666.4 5710.9 5715.1 5758.2 5534.3 5566.3 5573.7 5579.9 5602.4 5498.2 5559.5 5588.6 5594.4 5600.7 5462.9 5496.1 5501.1 5503.8 5543.5 5544.0 5558.8 5579.4 5584.6 5615.4 5393.0 5406.6 5469.3 5470.7 5527.0 08:51:59 INFO - PROCESS | 17945 | 08:51:59 INFO - PROCESS | 17945 | [#1] ext.html Cycles:180 Average:44596.51 Median:36483.64 stddev:75501.37 (206.9%) stddev-sans-first:75640.62 08:51:59 INFO - PROCESS | 17945 | Values: 515.7 518.1 542.7 562.6 594.0 35582.6 36467.8 36499.5 36541.6 36614.5 39086.8 39705.4 39714.4 39869.2 39948.0 8296.5 8436.0 8483.0 8483.9 8502.9 8211.1 8261.2 8333.3 8336.5 8346.2 8472.2 8520.4 8616.6 8639.4 8645.7 8502.1 8550.8 8564.3 8569.6 8579.5 8555.5 8679.6 8697.7 8700.5 8701.7 41027.0 41325.3 41539.0 41559.8 41628.8 2806.0 3243.4 3294.4 3315.9 3638.3 27131.9 27251.0 27345.3 27462.3 27634.4 3864.0 3945.4 3951.8 4022.6 4121.0 184598.0 186362.0 186399.1 186602.0 186703.0 54160.5 55270.0 57019.7 57473.0 62088.0 56097.4 56185.7 56380.0 56534.0 56672.7 13448.7 13665.2 13700.7 13737.7 13750.5 9126.5 9154.8 9203.1 9203.3 9222.7 20348.3 20813.9 20853.0 20936.4 20954.0 7312.4 7498.0 7536.6 7545.1 7580.1 872.6 918.9 980.7 1078.2 1105.1 29224.3 29630.3 30519.0 30711.4 32931.2 1003.7 1028.9 1034.0 1061.7 1094.6 13886.5 14389.6 14398.4 14453.9 14594.7 336222.0 336705.0 338577.0 340345.0 341758.0 53555.7 53579.5 53823.7 53825.0 53904.7 1350.1 1356.1 1365.1 1367.9 1375.2 26337.9 27320.5 27337.2 27544.0 27792.0 45127.3 45243.3 45318.5 45352.3 45663.3 312965.0 313012.0 314417.0 315042.0 315253.0 32004.0 32221.8 32543.7 32711.2 32717.8 38823.0 38885.8 39743.8 39943.4 40354.0 33361.2 36200.3 37342.3 37423.0 37799.6 33352.7 33471.2 33492.0 33526.5 35122.8 32652.2 33058.3 33161.8 33167.0 33203.5 29567.1 29784.4 32153.7 32411.8 32726.2 25114.6 25253.0 25420.5 25605.0 25606.0 08:51:59 INFO - PROCESS | 17945 | 08:51:59 INFO - PROCESS | 17945 | [#2] jquery.html Cycles:180 Average:27328.21 Median:5339.63 stddev:88946.91 (1665.8%) stddev-sans-first:89173.38 08:51:59 INFO - PROCESS | 17945 | Values: 363.3 364.9 365.4 366.3 367.9 15667.6 15978.4 16695.9 16733.9 17547.0 11084.6 11280.9 16199.1 16210.6 16348.7 4815.1 5378.9 5404.4 5442.6 5453.2 5269.1 5360.3 5441.2 5477.0 5481.0 5162.3 5342.4 5414.2 5430.2 5441.0 5263.6 5267.9 5271.2 5291.6 5345.1 5336.9 5382.6 5384.6 5392.7 5406.1 12491.0 12669.4 12936.8 12948.9 12958.2 2062.1 2118.7 2191.4 2202.8 2286.6 9359.3 9526.2 9598.5 9754.5 9770.9 1851.1 1955.0 2012.5 2016.5 2032.4 50449.0 51053.2 51188.5 52276.2 52336.2 9914.1 9943.5 9952.3 9991.3 10023.5 12956.3 13018.3 13041.7 13067.9 13090.5 6801.1 6827.5 6950.4 6980.4 7036.3 6541.8 6603.8 6608.1 6614.8 6621.1 4299.6 4382.5 4385.9 4405.8 4421.5 1743.3 1843.5 1854.5 1860.9 1863.4 790.6 885.7 887.8 907.6 916.3 16238.0 16318.8 16659.9 16930.2 17073.1 890.4 911.4 955.0 987.5 1032.1 9214.7 9310.0 9356.4 9365.2 9425.3 529250.0 538905.0 541698.0 554634.0 555764.0 71233.6 74052.3 75553.6 75850.6 77719.2 1139.4 1151.5 1158.5 1160.1 1162.4 14112.4 14429.1 14449.2 14465.1 14720.0 32106.8 32222.4 33092.8 33389.0 33507.5 45605.3 47129.3 47413.5 47447.0 50606.0 7226.3 7286.7 7451.1 7535.6 7553.2 9701.4 9718.0 10329.2 10698.4 11333.9 6836.4 7796.5 8442.9 9375.8 9382.6 9451.5 9682.8 9823.3 10048.8 10467.7 9105.7 9445.8 9680.6 9747.1 9778.2 7009.6 7101.1 7435.8 7442.6 7556.1 9022.9 9490.0 9552.4 9649.1 9814.0 08:51:59 INFO - PROCESS | 17945 | 08:51:59 INFO - PROCESS | 17945 | [#3] mootools.html Cycles:180 Average:5519.94 Median:6452.34 stddev:2810.83 (43.6%) stddev-sans-first:2801.78 08:51:59 INFO - PROCESS | 17945 | Values: 1415.4 1484.7 1630.6 1770.3 1773.4 7696.0 7719.6 7849.9 7902.8 7978.2 7763.4 7827.4 7832.8 7907.9 7920.1 2315.3 2342.2 2344.8 2345.4 2347.0 2283.0 2310.6 2311.0 2323.3 2323.7 2282.4 2282.4 2298.3 2339.6 2341.5 2277.8 2288.8 2304.1 2306.5 2341.2 2350.0 2355.4 2356.9 2357.1 2357.8 7677.3 7801.5 7850.5 7850.8 7851.3 4768.3 4781.8 4836.3 4851.7 4859.2 3065.8 3086.7 3196.8 3205.8 3218.3 1004.4 1015.0 1030.7 1063.6 1089.0 10732.7 10739.7 10756.7 10800.5 10855.6 4291.7 4443.4 4456.3 4467.4 4533.4 9400.5 9410.1 9411.0 9419.8 9426.2 4865.3 4870.3 4879.7 4881.9 4884.7 4367.7 4396.1 4400.7 4404.9 4408.6 3647.2 3699.1 3722.0 3723.4 3740.6 1121.6 1153.8 1155.0 1155.4 1189.5 1265.5 1272.8 1286.5 1327.4 1330.6 7354.1 7372.1 7429.4 7455.9 7459.8 1131.4 1132.6 1143.9 1154.3 1159.2 5626.6 5739.8 5742.3 5794.5 5801.9 8957.0 9164.4 9173.8 9234.7 9354.6 8922.1 8987.5 9075.1 9109.9 9173.8 7102.8 7152.2 7261.5 7270.6 7300.7 7291.8 7297.7 7378.5 7390.4 7406.6 8083.4 8274.4 8280.6 8302.2 8533.7 8483.6 8756.2 8805.2 8821.2 8846.7 7002.9 7114.9 7137.3 7148.8 7152.6 7459.9 7483.7 7487.6 7530.7 7560.3 6847.5 6934.8 6974.1 7008.4 7337.6 6893.7 6942.5 6983.5 7030.4 7035.9 7021.8 7072.3 7079.4 7111.6 7115.9 6359.2 6545.5 6548.0 6549.1 6555.4 6558.8 6566.7 6576.8 6580.1 6630.7 08:51:59 INFO - PROCESS | 17945 | 08:51:59 INFO - PROCESS | 17945 | [#4] prototype.html Cycles:180 Average:5537.75 Median:6258.87 stddev:1684.20 (26.9%) stddev-sans-first:1643.15 08:51:59 INFO - PROCESS | 17945 | Values: 341.7 341.8 349.8 350.8 352.8 6251.3 6281.2 6309.2 6344.3 6485.4 6266.4 6273.8 6292.5 6298.1 6310.1 4689.9 4720.4 4747.4 4751.7 4753.0 4735.8 4765.5 4769.3 4775.7 4780.4 4648.1 4705.6 4722.9 4735.6 4740.9 4689.8 4702.2 4719.7 4724.3 4727.5 4097.7 4102.0 4109.3 4118.6 4120.3 5953.5 5981.6 5989.3 5990.5 6000.9 5423.3 5476.3 5526.9 5533.9 5536.9 6646.0 6648.8 6651.8 6658.0 6666.3 4557.0 4575.9 4584.8 4586.5 4601.4 6773.8 6875.5 6953.1 6971.9 6974.2 4620.2 4622.5 4626.6 4638.9 4646.8 4705.0 4715.0 4716.0 4717.7 4719.9 5451.2 5457.3 5462.1 5464.2 5473.5 6597.2 6618.2 6683.2 6683.5 6722.7 1614.6 1643.0 1648.8 1651.6 1657.9 1096.6 1105.4 1115.0 1117.1 1127.6 6174.8 6220.9 6224.5 6241.9 6242.3 6720.0 6767.3 6770.4 6776.9 6790.9 6105.9 6189.7 6206.3 6208.0 6213.9 3669.8 3688.3 3690.0 3692.1 3693.5 6925.8 6941.7 6942.0 6969.4 7100.6 6787.2 6938.4 6947.5 6948.8 6955.9 6999.5 7080.1 7081.8 7082.1 7102.7 6716.9 6730.6 6768.0 6776.4 6777.3 6577.3 6677.9 6697.9 6722.9 6734.4 7063.5 7083.5 7094.8 7096.5 7104.6 4639.5 4661.9 4663.6 4674.5 4679.5 6703.5 6773.6 6797.7 6804.6 7027.4 6793.1 6795.3 6808.3 6818.0 6821.2 6774.4 6782.3 6797.0 6798.0 6817.5 6539.6 6611.5 6633.8 6668.5 6672.4 6730.1 6804.6 6814.4 6822.4 6841.0 6627.1 6633.3 6646.4 6670.3 6675.7 08:51:59 INFO - PROCESS | 17945 | 08:51:59 INFO - PROCESS | 17945 | [#5] yui.html Cycles:180 Average:13555.64 Median:24195.17 stddev:15678.71 (64.8%) stddev-sans-first:15693.04 08:51:59 INFO - PROCESS | 17945 | Values: 713.5 728.3 824.6 845.7 848.0 13306.4 13318.3 13380.3 13462.1 13467.5 12914.0 12978.3 12994.9 13004.5 13005.3 815.8 822.7 831.9 837.2 840.6 832.6 833.5 836.3 838.3 838.7 866.8 868.9 870.7 870.9 871.9 866.1 866.3 866.5 866.9 868.9 636.3 637.7 638.0 638.3 638.7 13001.2 13216.1 13223.6 13228.1 13404.7 12480.9 12577.4 12738.4 12770.2 12840.5 10401.8 10489.3 10504.1 10524.6 10597.5 3537.6 3592.6 3609.1 3635.1 3723.6 47278.1 47914.0 48014.8 48293.3 48673.5 9657.9 10092.0 10154.3 10185.5 10239.5 18051.8 18081.7 18202.4 18205.8 18238.6 7316.8 7392.7 7461.6 7525.6 7638.5 4209.9 4264.4 4269.3 4292.2 4316.8 3165.6 3175.8 3185.9 3189.6 3191.8 586.0 592.1 592.7 597.6 599.2 476.3 491.6 507.3 600.0 659.3 8745.0 8781.3 8831.0 9042.6 9074.5 533.2 540.2 584.0 625.1 657.1 4182.1 4249.8 4263.7 4301.9 4323.9 54816.7 55462.0 55494.7 55534.4 55865.4 48573.8 49074.0 49491.8 50941.0 51542.0 45848.5 46335.8 46803.0 47208.8 47254.5 8380.9 8440.9 8537.2 8549.6 8569.7 34273.0 34539.0 34888.0 34991.3 35266.0 40952.8 44020.1 44270.0 44656.8 44829.8 10023.5 10114.3 10122.8 10124.1 10252.2 10924.2 11006.8 11058.7 11209.5 11210.7 10165.2 10421.8 10546.7 10629.3 10639.5 9529.5 9694.3 9909.7 9927.2 9938.6 11017.7 11661.0 11711.5 11726.2 12124.8 8710.9 8839.2 9208.9 9380.8 9450.4 9006.8 9198.5 9328.6 9685.6 9697.2 08:51:59 INFO - PROCESS | 17945 | -------- Summary: end -------- 08:51:59 INFO - PROCESS | 17945 | 08:52:00 INFO - TEST-INFO | 17945: exit 0 08:52:00 INFO - TEST-OK | dromaeo_css | took 1111541ms 08:52:00 INFO - TEST-START | kraken 08:52:00 INFO - operating with platform_type : linux_ 08:52:00 INFO - Initialising browser for kraken test... 08:52:00 INFO - TEST-INFO | started process 18183 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpR_E0QQ/profile http://localhost:52192/getInfo.html) 08:52:04 INFO - PROCESS | 18183 | 08:52:04 INFO - PROCESS | 18183 | (process:18252): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:52:05 INFO - PROCESS | 18183 | __metrics Screen width/height:1600/1200 08:52:05 INFO - PROCESS | 18183 | colorDepth:24 08:52:05 INFO - PROCESS | 18183 | Browser inner width/height: 1024/697 08:52:05 INFO - PROCESS | 18183 | __metrics 08:52:05 INFO - PROCESS | 18183 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:52:06 INFO - TEST-INFO | 18183: exit 0 08:52:06 INFO - Browser initialized. 08:52:06 INFO - Running cycle 1/1 for kraken test... 08:52:06 INFO - TEST-INFO | started process 18300 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpR_E0QQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:06 INFO - PROCESS | 18300 | -- checkerboarding starts below -- 08:52:06 INFO - PROCESS | 18300 | RENDERTRACE 0.073935 rect red 0 0 10 10 // viewport 08:52:06 INFO - PROCESS | 18300 | RENDERTRACE 33.7312 rect brown 0 0 10 10 // page 08:52:06 INFO - PROCESS | 18300 | RENDERTRACE 33.7542 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 08:52:06 INFO - PROCESS | 18300 | Checkerboarded for 1 frames (34.8069 ms), 100 peak, 1 severity. 08:52:07 INFO - PROCESS | 18300 | 08:52:07 INFO - PROCESS | 18300 | (process:18359): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:52:18 INFO - PROCESS | 18300 | RSS: Main: 149987328 08:52:18 INFO - PROCESS | 18300 | 08:52:20 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52192/tests/kraken/driver.html?testName=audio-beat-detection) 08:52:21 INFO - PROCESS | 18300 | RSS: Main: 150654976 08:52:21 INFO - PROCESS | 18300 | 08:52:23 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52192/tests/kraken/driver.html?testName=audio-dft) 08:52:24 INFO - PROCESS | 18300 | RSS: Main: 154578944 08:52:24 INFO - PROCESS | 18300 | 08:52:27 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52192/tests/kraken/driver.html?testName=audio-fft) 08:52:27 INFO - PROCESS | 18300 | RSS: Main: 147148800 08:52:27 INFO - PROCESS | 18300 | 08:52:29 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52192/tests/kraken/driver.html?testName=audio-oscillator) 08:52:30 INFO - PROCESS | 18300 | RSS: Main: 148381696 08:52:30 INFO - PROCESS | 18300 | 08:52:32 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52192/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:52:33 INFO - PROCESS | 18300 | RSS: Main: 149229568 08:52:33 INFO - PROCESS | 18300 | 08:52:36 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52192/tests/kraken/driver.html?testName=imaging-darkroom) 08:52:36 INFO - PROCESS | 18300 | RSS: Main: 148742144 08:52:36 INFO - PROCESS | 18300 | 08:52:40 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52192/tests/kraken/driver.html?testName=imaging-desaturate) 08:52:40 INFO - PROCESS | 18300 | RSS: Main: 148963328 08:52:40 INFO - PROCESS | 18300 | 08:52:43 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52192/tests/kraken/driver.html?testName=json-parse-financial) 08:52:44 INFO - PROCESS | 18300 | RSS: Main: 149053440 08:52:44 INFO - PROCESS | 18300 | 08:52:45 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52192/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:52:46 INFO - PROCESS | 18300 | RSS: Main: 149692416 08:52:46 INFO - PROCESS | 18300 | 08:52:48 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52192/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:52:48 INFO - PROCESS | 18300 | RSS: Main: 149483520 08:52:48 INFO - PROCESS | 18300 | 08:52:50 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52192/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:52:51 INFO - PROCESS | 18300 | RSS: Main: 149389312 08:52:51 INFO - PROCESS | 18300 | 08:52:53 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:52:54 INFO - PROCESS | 18300 | RSS: Main: 149700608 08:52:54 INFO - PROCESS | 18300 | 08:52:56 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:52:57 INFO - PROCESS | 18300 | RSS: Main: 150102016 08:52:57 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | Cycle 1(1): loaded http://localhost:52192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52192/tests/kraken/driver.html?testName=ai-astar) 08:52:59 INFO - PROCESS | 18300 | RSS: Main: 149114880 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | __start_tp_report 08:52:59 INFO - PROCESS | 18300 | _x_x_mozilla_page_load 08:52:59 INFO - PROCESS | 18300 | _x_x_mozilla_page_load_details 08:52:59 INFO - PROCESS | 18300 | |i|pagename|runs| 08:52:59 INFO - PROCESS | 18300 | |0;ai-astar;111;106;113;112;113;122;112;111;110;110 08:52:59 INFO - PROCESS | 18300 | |1;audio-beat-detection;156;126;154;165;127;149;169;124;169;128 08:52:59 INFO - PROCESS | 18300 | |2;audio-dft;164;162;162;162;161;160;161;164;166;164 08:52:59 INFO - PROCESS | 18300 | |3;audio-fft;80;72;71;76;72;73;151;72;71;71 08:52:59 INFO - PROCESS | 18300 | |4;audio-oscillator;97;96;149;97;96;97;142;97;97;141 08:52:59 INFO - PROCESS | 18300 | |5;imaging-gaussian-blur;109;111;109;109;111;110;110;110;110;112 08:52:59 INFO - PROCESS | 18300 | |6;imaging-darkroom;148;147;146;148;148;146;148;147;147;146 08:52:59 INFO - PROCESS | 18300 | |7;imaging-desaturate;96;98;97;95;96;98;97;96;97;97 08:52:59 INFO - PROCESS | 18300 | |8;json-parse-financial;57;59;57;57;60;59;62;61;66;56 08:52:59 INFO - PROCESS | 18300 | |9;json-stringify-tinderbox;68;67;68;68;69;69;68;68;68;68 08:52:59 INFO - PROCESS | 18300 | |10;stanford-crypto-aes;85;81;82;83;92;82;82;83;83;91 08:52:59 INFO - PROCESS | 18300 | |11;stanford-crypto-ccm;118;119;121;118;130;120;121;112;117;126 08:52:59 INFO - PROCESS | 18300 | |12;stanford-crypto-pbkdf2;136;145;148;145;152;135;148;147;145;149 08:52:59 INFO - PROCESS | 18300 | |13;stanford-crypto-sha256-iterative;67;66;69;66;70;67;66;67;66;66 08:52:59 INFO - PROCESS | 18300 | __end_tp_report 08:52:59 INFO - PROCESS | 18300 | __start_cc_report 08:52:59 INFO - PROCESS | 18300 | _x_x_mozilla_cycle_collect,746 08:52:59 INFO - PROCESS | 18300 | __end_cc_report 08:52:59 INFO - PROCESS | 18300 | __startTimestamp1453135979430__endTimestamp 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | ------- Summary: start ------- 08:52:59 INFO - PROCESS | 18300 | Number of tests: 14 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:4.06 (3.6%) stddev-sans-first:4.28 08:52:59 INFO - PROCESS | 18300 | Values: 111.0 106.0 113.0 112.0 113.0 122.0 112.0 111.0 110.0 110.0 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:155.00 stddev:18.73 (12.1%) stddev-sans-first:19.56 08:52:59 INFO - PROCESS | 18300 | Values: 156.0 126.0 154.0 165.0 127.0 149.0 169.0 124.0 169.0 128.0 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.84 (1.1%) stddev-sans-first:1.88 08:52:59 INFO - PROCESS | 18300 | Values: 164.0 162.0 162.0 162.0 161.0 160.0 161.0 164.0 166.0 164.0 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#3] audio-fft Cycles:10 Average:80.90 Median:72.00 stddev:24.79 (34.4%) stddev-sans-first:26.30 08:52:59 INFO - PROCESS | 18300 | Values: 80.0 72.0 71.0 76.0 72.0 73.0 151.0 72.0 71.0 71.0 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:97.00 stddev:22.94 (23.6%) stddev-sans-first:23.77 08:52:59 INFO - PROCESS | 18300 | Values: 97.0 96.0 149.0 97.0 96.0 97.0 142.0 97.0 97.0 141.0 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.99 (0.9%) stddev-sans-first:0.97 08:52:59 INFO - PROCESS | 18300 | Values: 109.0 111.0 109.0 109.0 111.0 110.0 110.0 110.0 110.0 112.0 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.88 (0.6%) stddev-sans-first:0.87 08:52:59 INFO - PROCESS | 18300 | Values: 148.0 147.0 146.0 148.0 148.0 146.0 148.0 147.0 147.0 146.0 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 08:52:59 INFO - PROCESS | 18300 | Values: 96.0 98.0 97.0 95.0 96.0 98.0 97.0 96.0 97.0 97.0 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:59.50 stddev:3.03 (5.1%) stddev-sans-first:3.08 08:52:59 INFO - PROCESS | 18300 | Values: 57.0 59.0 57.0 57.0 60.0 59.0 62.0 61.0 66.0 56.0 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 08:52:59 INFO - PROCESS | 18300 | Values: 68.0 67.0 68.0 68.0 69.0 69.0 68.0 68.0 68.0 68.0 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:83.00 stddev:3.89 (4.7%) stddev-sans-first:4.12 08:52:59 INFO - PROCESS | 18300 | Values: 85.0 81.0 82.0 83.0 92.0 82.0 82.0 83.0 83.0 91.0 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:120.50 stddev:4.94 (4.1%) stddev-sans-first:5.17 08:52:59 INFO - PROCESS | 18300 | Values: 118.0 119.0 121.0 118.0 130.0 120.0 121.0 112.0 117.0 126.0 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:147.50 stddev:5.46 (3.7%) stddev-sans-first:4.72 08:52:59 INFO - PROCESS | 18300 | Values: 136.0 145.0 148.0 145.0 152.0 135.0 148.0 147.0 145.0 149.0 08:52:59 INFO - PROCESS | 18300 | 08:52:59 INFO - PROCESS | 18300 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.41 (2.1%) stddev-sans-first:1.50 08:52:59 INFO - PROCESS | 18300 | Values: 67.0 66.0 69.0 66.0 70.0 67.0 66.0 67.0 66.0 66.0 08:52:59 INFO - PROCESS | 18300 | -------- Summary: end -------- 08:52:59 INFO - PROCESS | 18300 | 08:53:00 INFO - TEST-INFO | 18300: exit 0 08:53:00 INFO - TEST-OK | kraken | took 59971ms 08:53:00 INFO - TEST-START | v8_7 08:53:00 INFO - operating with platform_type : linux_ 08:53:00 INFO - Initialising browser for v8_7 test... 08:53:00 INFO - TEST-INFO | started process 18586 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfq9NWA/profile http://localhost:52192/getInfo.html) 08:53:04 INFO - PROCESS | 18586 | 08:53:04 INFO - PROCESS | 18586 | (process:18658): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:53:05 INFO - PROCESS | 18586 | __metrics Screen width/height:1600/1200 08:53:05 INFO - PROCESS | 18586 | colorDepth:24 08:53:05 INFO - PROCESS | 18586 | Browser inner width/height: 1024/697 08:53:05 INFO - PROCESS | 18586 | __metrics 08:53:05 INFO - PROCESS | 18586 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:53:05 INFO - PROCESS | 18586 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 08:53:06 INFO - TEST-INFO | 18586: exit 0 08:53:06 INFO - Browser initialized. 08:53:06 INFO - Running cycle 1/1 for v8_7 test... 08:53:06 INFO - TEST-INFO | started process 18706 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfq9NWA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:53:06 INFO - PROCESS | 18706 | -- checkerboarding starts below -- 08:53:06 INFO - PROCESS | 18706 | RENDERTRACE 0.053073 rect red 0 0 10 10 // viewport 08:53:06 INFO - PROCESS | 18706 | RENDERTRACE 2.90611 rect red 0 0 10 10 // viewport 08:53:06 INFO - PROCESS | 18706 | RENDERTRACE 52.8513 rect brown 0 0 10 10 // page 08:53:06 INFO - PROCESS | 18706 | RENDERTRACE 52.8781 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 08:53:06 INFO - PROCESS | 18706 | Checkerboarded for 2 frames (55.6881 ms), 100 peak, 289 severity. 08:53:07 INFO - PROCESS | 18706 | 08:53:07 INFO - PROCESS | 18706 | (process:18764): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:53:17 INFO - PROCESS | 18706 | RSS: Main: 150118400 08:53:17 INFO - PROCESS | 18706 | 08:53:40 INFO - PROCESS | 18706 | Cycle 1(1): loaded http://localhost:52192/tests/v8_7/run.html (next: http://localhost:52192/tests/v8_7/run.html) 08:53:40 INFO - PROCESS | 18706 | RSS: Main: 146354176 08:53:40 INFO - PROCESS | 18706 | 08:53:40 INFO - PROCESS | 18706 | __start_tp_report 08:53:40 INFO - PROCESS | 18706 | _x_x_mozilla_page_load 08:53:40 INFO - PROCESS | 18706 | _x_x_mozilla_page_load_details 08:53:40 INFO - PROCESS | 18706 | |i|pagename|runs| 08:53:40 INFO - PROCESS | 18706 | |0;Richards;167.3080140538732 08:53:40 INFO - PROCESS | 18706 | |1;DeltaBlue;188.32391713747646 08:53:40 INFO - PROCESS | 18706 | |2;Encrypt;279.4076557697681 08:53:40 INFO - PROCESS | 18706 | |3;Decrypt;5186.5284974093265 08:53:40 INFO - PROCESS | 18706 | |4;RayTrace;1071.8113612004288 08:53:40 INFO - PROCESS | 18706 | |5;Earley;723.589001447178 08:53:40 INFO - PROCESS | 18706 | |6;Boyer;12370.37037037037 08:53:40 INFO - PROCESS | 18706 | |7;RegExp;41183.67346938775 08:53:40 INFO - PROCESS | 18706 | |8;Splay;588.8235294117648 08:53:40 INFO - PROCESS | 18706 | |9;NavierStokes;4854.368932038835 08:53:40 INFO - PROCESS | 18706 | __end_tp_report 08:53:40 INFO - PROCESS | 18706 | __startTimestamp1453136020642__endTimestamp 08:53:40 INFO - PROCESS | 18706 | 08:53:40 INFO - PROCESS | 18706 | ------- Summary: start ------- 08:53:40 INFO - PROCESS | 18706 | Number of tests: 10 08:53:40 INFO - PROCESS | 18706 | 08:53:40 INFO - PROCESS | 18706 | [#0] Richards Cycles:1 Average:167.31 Median:167.31 stddev:0.00 (0.0%) 08:53:40 INFO - PROCESS | 18706 | Values: 167.3 08:53:40 INFO - PROCESS | 18706 | 08:53:40 INFO - PROCESS | 18706 | [#1] DeltaBlue Cycles:1 Average:188.32 Median:188.32 stddev:0.00 (0.0%) 08:53:40 INFO - PROCESS | 18706 | Values: 188.3 08:53:40 INFO - PROCESS | 18706 | 08:53:40 INFO - PROCESS | 18706 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 08:53:40 INFO - PROCESS | 18706 | Values: 279.4 08:53:40 INFO - PROCESS | 18706 | 08:53:40 INFO - PROCESS | 18706 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 08:53:40 INFO - PROCESS | 18706 | Values: 5186.5 08:53:40 INFO - PROCESS | 18706 | 08:53:40 INFO - PROCESS | 18706 | [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 08:53:40 INFO - PROCESS | 18706 | Values: 1071.8 08:53:40 INFO - PROCESS | 18706 | 08:53:40 INFO - PROCESS | 18706 | [#5] Earley Cycles:1 Average:723.59 Median:723.59 stddev:0.00 (0.0%) 08:53:40 INFO - PROCESS | 18706 | Values: 723.6 08:53:40 INFO - PROCESS | 18706 | 08:53:40 INFO - PROCESS | 18706 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 08:53:40 INFO - PROCESS | 18706 | Values: 12370.4 08:53:40 INFO - PROCESS | 18706 | 08:53:40 INFO - PROCESS | 18706 | [#7] RegExp Cycles:1 Average:41183.67 Median:41183.67 stddev:0.00 (0.0%) 08:53:40 INFO - PROCESS | 18706 | Values: 41183.7 08:53:40 INFO - PROCESS | 18706 | 08:53:40 INFO - PROCESS | 18706 | [#8] Splay Cycles:1 Average:588.82 Median:588.82 stddev:0.00 (0.0%) 08:53:40 INFO - PROCESS | 18706 | Values: 588.8 08:53:40 INFO - PROCESS | 18706 | 08:53:40 INFO - PROCESS | 18706 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 08:53:40 INFO - PROCESS | 18706 | Values: 4854.4 08:53:40 INFO - PROCESS | 18706 | -------- Summary: end -------- 08:53:40 INFO - PROCESS | 18706 | 08:53:41 INFO - TEST-INFO | 18706: exit 0 08:53:41 INFO - TEST-OK | v8_7 | took 41032ms 08:53:41 INFO - SUITE-END | took 1212s 08:53:41 INFO - Completed test suite (00:20:12) 08:53:41 INFO - Working with test: dromaeo_css 08:53:41 INFO - Generating results file: dromaeo_css 08:53:41 INFO - Working with test: kraken 08:53:41 INFO - Generating results file: kraken 08:53:41 INFO - javascript benchmark 08:53:41 INFO - Working with test: v8_7 08:53:41 INFO - Generating results file: v8_7 08:53:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 08:53:41 INFO - process_Request line: dromaeo_css 6873.36 graph.html#tests=[[72,64,43]] 08:53:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:41 INFO - process_Request line: kraken 1511.10 graph.html#tests=[[232,64,43]] 08:53:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:41 INFO - process_Request line: v8_7 20363.94 graph.html#tests=[[230,64,43]] 08:53:41 INFO - RETURN: dromaeo_css: 6873.36 08:53:41 INFO - RETURN: kraken: 1511.10 08:53:41 INFO - RETURN: v8_7: 20363.94 08:53:41 INFO - javascript benchmark 08:53:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3169.9999999999986, 3170.1440611035023, 3208.534762459445, 3219.388316219918, 3224.048905572856, 5180.507851754077, 5246.501582349671, 5258.684478931267, 5277.604179686525, 5306.177542480917, 5240.266362709223, 5261.8947621047555, 5328.92006619901, 5349.8127565535215, 5350.0904846176145, 4778.737169455679, 4793.9280910786365, 4880.048390563841, 4982.352294201749, 5004.774785134659, 4887.486813884544, 4891.0, 4906.165951788204, 4958.528939750736, 4961.131801934665, 4728.739919304437, 4797.928031079537, 4810.711357318537, 4892.437369702494, 4894.5105489451125, 4797.256425254056, 4826.251930950708, 4839.564439200489, 4846.36997190363, 4868.148074087056, 4664.416947881515, 4777.498362671939, 4837.879053023703, 4863.319135321058, 4898.926516102261, 5046.4701206373165, 5116.51393117657, 5132.5124113209185, 5146.279520867081, 5159.071367153911, 5656.349519805234, 5690.687012214326, 5710.457506536873, 5736.483716465496, 5744.798932037401, 5541.418151094117, 5675.574331925122, 5703.857403564944, 5748.425157484218, 5758.3665796762325, 5369.81205657804, 5380.757865896044, 5403.432639572867, 5403.83788486346, 5408.161734931092, 5765.711714414262, 5781.364049954502, 5783.942160578425, 5785.334686511021, 5788.913166302509, 5447.237386765856, 5547.8890422192135, 5549.5837812164245, 5595.356533998643, 5597.328320601472, 5711.286089238845, 5738.397468265855, 5754.223179870748, 5756.856078597984, 5783.595148339576, 5670.603057785998, 5673.120666296731, 5681.488666019995, 5693.345265294544, 5710.857228569319, 5588.580856435784, 5612.522935550524, 5612.831615051555, 5694.0, 5698.1737648041635, 4410.07388448423, 4410.117976404732, 4413.073254616503, 4423.668224883147, 4423.955760442419, 3911.2568611963634, 3925.175713100281, 3937.9606203938165, 3942.6845852331744, 3944.980275098606, 5239.161734122522, 5337.706426146599, 5386.084365657847, 5429.049916264638, 5436.075867102602, 5690.4025077367105, 5726.2555867737765, 5728.312602487728, 5741.598088133874, 5758.049921762862, 5110.872228194325, 5303.15149576066, 5325.733713314319, 5354.812581559627, 5390.9191362129595, 4798.928016079762, 4820.807167713322, 4828.734419606955, 4830.589399901048, 4834.154023045953, 5760.36635970043, 5815.41845815415, 5822.388649191858, 5827.562932779973, 5833.795817146464, 5697.23087383198, 5714.942850571441, 5744.511716504144, 5756.7409466574945, 5783.595148339744, 5786.652800831964, 5789.218455508452, 5789.594728368974, 5828.213191219301, 5832.883342333214, 5537.529310008695, 5564.860878478071, 5571.3592936811165, 5585.357683866408, 5626.24045753818, 5654.547636189177, 5666.405027472056, 5710.914336285042, 5715.114157305624, 5758.222639943554, 5534.308211473566, 5566.332040155207, 5573.693446860461, 5579.916301255404, 5602.439756024528, 5498.230247765236, 5559.471850174227, 5588.580856435702, 5594.356648985418, 5600.747966341443, 5462.8907421850545, 5496.065668836228, 5501.119820828648, 5503.752331145028, 5543.501084902378, 5543.972280138573, 5558.777648893999, 5579.386267510652, 5584.609077364708, 5615.438456154352, 5393.029254734185, 5406.567474601944, 5469.2616496772425, 5470.699111548903, 5527.0], "unit": "score", "name": "dojo.html", "value": 5242.516914427128}, {"lowerIsBetter": false, "replicates": [515.7395515264791, 518.1140250172206, 542.6771071212628, 562.6286650810466, 594.0406243916074, 35582.644173558256, 36467.817660911656, 36499.452508212395, 36541.63458365419, 36614.45078323827, 39086.80456597713, 39705.40441893374, 39714.404283935764, 39869.202615947666, 39948.0, 8296.502209867413, 8435.95782021089, 8482.957585212096, 8483.915160848373, 8502.872456913152, 8211.096779354266, 8261.215184557457, 8333.250007499324, 8336.499810011419, 8346.165383461635, 8472.15278472151, 8520.446170998895, 8616.612252448655, 8639.352048596349, 8645.69740059098, 8502.107278735737, 8550.786230344229, 8564.272036876873, 8569.614367353484, 8579.485230886105, 8555.48667079971, 8679.609417576161, 8697.739067827975, 8700.521471319074, 8701.738947831574, 41027.0, 41325.346986120516, 41539.0, 41559.792201039105, 41628.79185604083, 2805.9719402805913, 3243.383757086146, 3294.390537750524, 3315.93368132636, 3638.308721342936, 27131.864340678367, 27251.0, 27345.31636709078, 27462.313442163904, 27634.447311053867, 3864.0, 3945.3884647879627, 3951.8221680024467, 4022.6178513041214, 4121.010957370239, 184598.0, 186362.0, 186399.06800466045, 186602.0, 186703.0, 54160.45839541633, 55270.0, 57019.71490142523, 57473.0, 62088.0, 56097.43902561004, 56185.7190714052, 56380.0, 56534.0, 56672.716636417375, 13448.663783405298, 13665.248411337472, 13700.65748356299, 13737.656558585915, 13750.518731844337, 9126.45241285525, 9154.81690366189, 9203.125703058198, 9203.263738900872, 9222.723318300461, 20348.28780992688, 20813.895930520554, 20853.0, 20936.37190884276, 20954.0, 7312.378447831994, 7497.962510187524, 7536.623168841536, 7545.132309784335, 7580.128285247157, 872.5549969515592, 918.875951746519, 980.7106903463496, 1078.191356482638, 1105.0772604874858, 29224.269393264913, 29630.259243519085, 30519.0107713571, 30711.38577228443, 32931.176720582174, 1003.6988903328972, 1028.927975041755, 1034.043509753475, 1061.7451811565322, 1094.6497120921229, 13886.513972011133, 14389.568312950629, 14398.42406303736, 14453.927730361282, 14594.708105837824, 336222.0, 336705.0, 338577.0, 340345.0, 341758.0, 53555.73222133942, 53579.46420535745, 53823.73088134534, 53825.0, 53904.73047634815, 1350.081944277881, 1356.0778670503955, 1365.112676760094, 1367.924764137982, 1375.195510626295, 26337.868310658323, 27320.453590928468, 27337.179884603494, 27544.0, 27792.0, 45127.32309015302, 45243.32135017912, 45318.54681453143, 45352.31971520364, 45663.31505027361, 312965.0, 313012.0, 314417.0, 315042.0, 315253.0, 32004.0, 32221.838890805397, 32543.674563255012, 32711.18222044468, 32717.836410817792, 38823.0, 38885.8055709731, 39743.80128099341, 39943.400848986705, 40354.0, 33361.16597084995, 36200.27599447944, 37342.253154937294, 37423.0, 37799.62200378071, 33352.66647333495, 33471.16322091967, 33492.0, 33526.497102543966, 35122.82438587791, 32652.183695407806, 33058.33883322272, 33161.83419082889, 33167.0, 33203.50194747129, 29567.112986610435, 29784.404311914073, 32153.678463215067, 32411.837940810146, 32726.181845453102, 25114.62328065117, 25252.969643642882, 25420.49159016846, 25605.0, 25606.0], "unit": "score", "name": "ext.html", "value": 17832.459669917793}, {"lowerIsBetter": false, "replicates": [363.3350967729055, 364.92519033598114, 365.3733846453332, 366.3405869435017, 367.8951498822836, 15667.60830979226, 15978.440754573578, 16695.91652041738, 16733.916330418346, 17547.0, 11084.61203857865, 11280.887191128086, 16199.1090490023, 16210.594735131628, 16348.673026539493, 4815.085133824571, 5378.8924221515545, 5404.405515393303, 5442.591805614575, 5453.182022696607, 5269.051570717269, 5360.303160589118, 5441.156620723794, 5476.972615136919, 5481.040817856879, 5162.328897243353, 5342.385625653042, 5414.242006119146, 5430.239766432703, 5441.047816632094, 5263.605229607776, 5267.920981185285, 5271.209318602221, 5291.550218231455, 5345.118055520835, 5336.866578335573, 5382.6232163748555, 5384.569234461273, 5392.730363481849, 5406.053940560386, 12491.0, 12669.429875655618, 12936.805947910789, 12948.935255323662, 12958.157719748186, 2062.0823733438624, 2118.7139736135578, 2191.41927389242, 2202.828530837119, 2286.588414085464, 9359.344845860793, 9526.190273826733, 9598.520073996273, 9754.46350450725, 9770.90229097707, 1851.1484717030048, 1954.9609007819763, 2012.537116463207, 2016.485796121994, 2032.3801240621603, 50449.0, 51053.23420148664, 51188.488115118744, 52276.21585676218, 52336.21495677568, 9914.107730304308, 9943.45311007887, 9952.253580981456, 9991.300608957448, 10023.548940297704, 12956.28740419286, 13018.349082546025, 13041.673958151123, 13067.869321306665, 13090.476380944847, 6801.081853949752, 6827.453803695693, 6950.443964482829, 6980.371766540934, 7036.296370362923, 6541.803745887631, 6603.7688680895935, 6608.074869518271, 6614.768483103068, 6621.139251897319, 4299.634531064832, 4382.517923028464, 4385.912281754411, 4405.7797110144365, 4421.53573874745, 1743.2678275124479, 1843.5022543913337, 1854.5270955906158, 1860.8976506292283, 1863.3664554051688, 790.5765654060756, 885.6767279942775, 887.8091210389669, 907.6324088744069, 916.2990312411011, 16238.025718456931, 16318.75521867173, 16659.916700416663, 16930.153492325335, 17073.146342682816, 890.4301247201796, 911.3574929674563, 954.9713508594754, 987.4766373821886, 1032.1330082730542, 9214.677486287948, 9309.953450232706, 9356.391834530734, 9365.157135857806, 9425.2931030173, 529250.0, 538905.0, 541698.0, 554634.0, 555764.0, 71233.64383178052, 74052.25947740562, 75553.62223188848, 75850.62074689592, 77719.22280777233, 1139.3733446604335, 1151.4703236511132, 1158.5192145259791, 1160.1356989043218, 1162.3607016141257, 14112.435502580192, 14429.134251944497, 14449.205293708526, 14465.132092074089, 14720.043197192148, 32106.83946580252, 32222.35555288928, 33092.83453582717, 33389.0, 33507.49738753872, 45605.31592026056, 47129.293060603435, 47413.525864740914, 47447.0, 50606.0, 7226.313500217471, 7286.672099755418, 7451.068616422947, 7535.623218838927, 7553.206913274247, 9701.369410988264, 9717.951410242904, 10329.225308102074, 10698.41158736277, 11333.943330283295, 6836.418904393182, 7796.4932279401655, 8442.873356899529, 9375.812483750151, 9382.577783999874, 9451.50541710724, 9682.806343873224, 9823.263255256028, 10048.849267261143, 10467.738306542398, 9105.7268281949, 9445.763855903657, 9680.5643746033, 9747.122758951728, 9778.23435248112, 7009.649517524205, 7101.076860008373, 7435.776926692208, 7442.590657513889, 7556.055493063367, 9022.864657030019, 9489.952550237205, 9552.417544034563, 9649.083337082966, 9814.0], "unit": "score", "name": "jquery.html", "value": 7970.692573621145}, {"lowerIsBetter": false, "replicates": [1415.4126037694357, 1484.7030593881227, 1630.5760502269407, 1770.3449723602268, 1773.3704534890114, 7696.0, 7719.575423351714, 7849.921500784991, 7902.84194316114, 7978.162292959236, 7763.4177436692335, 7827.412944029206, 7832.765017049498, 7907.920920790791, 7920.128785833554, 2315.270689732737, 2342.203650758742, 2344.8475849069755, 2345.3901985483726, 2347.0, 2282.9543409131807, 2310.6187479065934, 2311.04091801902, 2323.337848713117, 2323.732770731362, 2282.3837563857746, 2282.4065742906882, 2298.321995011476, 2339.5671800716923, 2341.4731685370825, 2277.81777457803, 2288.794008539231, 2304.0783686525356, 2306.4695120122465, 2341.2039906431896, 2349.988250058756, 2355.3758254062686, 2356.9410764730846, 2357.0807385119815, 2357.846739961897, 7677.270659287359, 7801.531908085533, 7850.528968261922, 7850.764477065697, 7851.332636725885, 4768.260919557474, 4781.832635857763, 4836.298736683197, 4851.684640498356, 4859.198232291667, 3065.7853950223493, 3086.675899030592, 3196.7762256642045, 3205.759568032407, 3218.2758879252215, 1004.4475538453894, 1014.9644762433279, 1030.68048904839, 1063.648995831374, 1088.9891101088967, 10732.73168170802, 10739.677809665722, 10756.677299680943, 10800.51397687106, 10855.620053298175, 4291.6566674665955, 4443.400140980991, 4456.264716321835, 4467.419235499365, 4533.433320834895, 9400.482973436527, 9410.106039926197, 9410.95294523523, 9419.811603768023, 9426.151646351862, 4865.343178670905, 4870.269459581091, 4879.731614761151, 4881.8535443936735, 4884.7069175849565, 4367.737935723867, 4396.120775844844, 4400.69195156336, 4404.889877753082, 4408.58118478744, 3647.2340808430527, 3699.1122130688977, 3722.0, 3723.3670276053135, 3740.6446387593137, 1121.6354684727496, 1153.8096214124744, 1154.9942250288864, 1155.439611788282, 1189.5182451107316, 1265.4621785741024, 1272.8154417609394, 1286.5497076023316, 1327.4424741608548, 1330.6340756291904, 7354.080739907512, 7372.115346158495, 7429.442791790637, 7455.925440745632, 7459.813504662427, 1131.4003578103454, 1132.6318946342308, 1143.8512993310983, 1154.2843437068902, 1159.2406973432414, 5626.634268772516, 5739.7704091836695, 5742.339630942495, 5794.478496935296, 5801.854953626109, 8957.0, 9164.358494905426, 9173.816523669622, 9234.676786312446, 9354.625814967461, 8922.063183365783, 8987.505687187268, 9075.092490751003, 9109.863352049724, 9173.81652366949, 7102.792525270716, 7152.213256541776, 7261.491695581364, 7270.63646817657, 7300.744473943387, 7291.8177045572165, 7297.744578939712, 7378.520396174232, 7390.371818395497, 7406.555606663617, 8083.434159608771, 8274.420790544846, 8280.627371768165, 8302.211289927447, 8533.701320453754, 8483.575821209039, 8756.168164024408, 8805.16350946659, 8821.161989610977, 8846.734597962071, 7002.894956575554, 7114.893276600752, 7137.321954414322, 7148.821279468055, 7152.606606636685, 7459.888101678371, 7483.738069167553, 7487.625618718933, 7530.698772049276, 7560.319571238615, 6847.520673552804, 6934.826629334307, 6974.093367862146, 7008.439324854102, 7337.59643219628, 6893.724251029903, 6942.548734332252, 6983.546069505466, 7030.437564994686, 7035.929640703732, 7021.824454388681, 7072.257412971564, 7079.362857342864, 7111.608861512666, 7115.893261600977, 6359.17330747, 6545.5090868184125, 6547.9672601636685, 6549.083128362128, 6555.410013098844, 6558.80323590293, 6566.704498297492, 6576.8355791105605, 6580.078788969644, 6630.734770609121], "unit": "score", "name": "mootools.html", "value": 4565.292637285255}, {"lowerIsBetter": false, "replicates": [341.7453996772404, 341.83250207398385, 349.78138663335415, 350.7719982011692, 352.8182985762333, 6251.312355640882, 6281.214848143982, 6309.211348581427, 6344.3338449462835, 6485.416312531871, 6266.436020758131, 6273.843153921154, 6292.496600271978, 6298.055291706235, 6310.085037669547, 4689.88275293117, 4720.362751028619, 4747.430308362993, 4751.667383283171, 4753.0493901219725, 4735.83424580138, 4765.499622539635, 4769.332293478916, 4775.689580177294, 4780.37855078841, 4648.116857797025, 4705.55297246761, 4722.881927951811, 4735.621150307984, 4740.905181896377, 4689.765511724418, 4702.200625893589, 4719.740414277213, 4724.291356296583, 4727.456342520602, 4097.733647312915, 4102.0360215349365, 4109.301418758818, 4118.588141185887, 4120.320147175712, 5953.493953013999, 5981.641101533922, 5989.341172471025, 5990.490808281258, 6000.939990600082, 5423.2949716537, 5476.342838859323, 5526.917096243559, 5533.889322213573, 5536.916946245809, 6646.003099535108, 6648.767293144717, 6651.76718814844, 6658.034584985198, 6666.333366663343, 4557.020240648243, 4575.885602859955, 4584.839530616412, 4586.54134586542, 4601.378813860119, 6773.796786096375, 6875.518713690044, 6953.096097507342, 6971.895421568681, 6974.232834388214, 4620.168369693488, 4622.537746225351, 4626.560476754703, 4638.907221855611, 4646.8141274348645, 4704.95295047052, 4714.976425117852, 4715.976420117946, 4717.740524271129, 4719.9292010619865, 5451.155070964007, 5457.2905522282645, 5462.126059830488, 5464.23500709901, 5473.480019398151, 6597.175353080865, 6618.205815302098, 6683.198016237985, 6683.532152749358, 6722.697478613474, 1614.6286354138615, 1643.030611938938, 1648.8433598808094, 1651.6283836136772, 1657.8590819780213, 1096.5668560918393, 1105.4362275239525, 1114.9777004460027, 1117.0728295514702, 1127.5827943660897, 6174.845628859224, 6220.937790622126, 6224.502039836802, 6241.906371404432, 6242.282137554149, 6720.0, 6767.289434609295, 6770.390664840188, 6776.9322306777285, 6790.898136527956, 6105.908411373833, 6189.659568723763, 6206.317305096436, 6207.96896015517, 6213.937860621426, 3669.7798132111625, 3688.299223147647, 3689.9631003690156, 3692.095436617992, 3693.519842420468, 6925.792226233221, 6941.652917354112, 6941.965290173517, 6969.372756451842, 7100.644967751592, 6787.219469760942, 6938.375546200866, 6947.548409353376, 6948.756793512202, 6955.860882782316, 6999.475039372068, 7080.114985626797, 7081.82295442618, 7082.114735658043, 7102.715891364288, 6716.932830671826, 6730.596164230162, 6768.0, 6776.356246156607, 6777.254502004874, 6577.3422657733845, 6677.899831502435, 6697.933020669731, 6722.865542689216, 6734.393904548614, 7063.470239732143, 7083.5041547091205, 7094.822629434099, 7096.53872498286, 7104.609246491493, 4639.48965613789, 4661.86014419568, 4663.580277775017, 4674.485806561343, 4679.532046795293, 6703.463722902254, 6773.593584384953, 6797.660116994031, 6804.625745583842, 7027.402670773042, 6793.082933803873, 6795.28649491816, 6808.285130061272, 6818.0, 6821.249662537018, 6774.390304872585, 6782.253952065367, 6797.014432907102, 6798.0, 6817.488688348294, 6539.574927629689, 6611.471082313499, 6633.800985970429, 6668.466522678271, 6672.399484046459, 6730.057791909235, 6804.591724496546, 6814.386705196556, 6822.3859852613505, 6841.042254084333, 6627.105340779126, 6633.336666333328, 6646.4350530205475, 6670.332966703485, 6675.666216689049], "unit": "score", "name": "prototype.html", "value": 4987.138835140291}, {"lowerIsBetter": false, "replicates": [713.5148099292479, 728.2790037862518, 824.5671022713076, 845.6955496021433, 848.0417128644631, 13306.401211945462, 13318.267495287755, 13380.330983450825, 13462.124961877484, 13467.528636497724, 12914.0, 12978.286194259312, 12994.935025324883, 13004.54484093057, 13005.349732513383, 815.8123631564744, 822.6750433578733, 831.8669012957928, 837.1670188162786, 840.5797101449275, 832.6128350317101, 833.4624167412015, 836.3184005035906, 838.266516797802, 838.6603425612636, 866.8179682266732, 868.9217970382664, 870.7387783664907, 870.9346798990069, 871.9084496127911, 866.0733015673201, 866.3415803988951, 866.536403024382, 866.8829707989436, 868.9435186712907, 636.3318515558645, 637.687533108778, 637.9617222966637, 638.2564312575844, 638.7253481003166, 13001.15492492985, 13216.14095083826, 13223.603291901161, 13228.140170888957, 13404.664883377896, 12480.875191248153, 12577.434015469325, 12738.426770795337, 12770.169938953939, 12840.515539652415, 10401.84397234042, 10489.318194317346, 10504.054635082803, 10524.631637892637, 10597.523111459926, 3537.557805274341, 3592.6048134705425, 3609.1338078861145, 3635.1275693833554, 3723.553173619156, 47278.05443891172, 47914.0, 48014.759926200495, 48293.275600865665, 48673.51326486725, 9657.855132173023, 10092.04125608066, 10154.339967902062, 10185.541650625739, 10239.539220735085, 18051.819481805276, 18081.7287740684, 18202.362917297833, 18205.81794182068, 18238.635227295646, 7316.780496585111, 7392.74125405619, 7461.626918654154, 7525.58609276495, 7638.465307428538, 4209.936850947238, 4264.381664658669, 4269.252880745857, 4292.227399068198, 4316.762578058174, 3165.5568220449154, 3175.825329606894, 3185.8725650974166, 3189.6331921829287, 3191.8404079796383, 586.0447470622858, 592.0704493944465, 592.6532978207711, 597.6444015810673, 599.2299894635372, 476.349782546828, 491.6411019955452, 507.2948601443996, 600.0279547133584, 659.3439527669999, 8745.0, 8781.297496200288, 8831.0, 9042.638294468148, 9074.546272686339, 533.2401328107431, 540.2436588775745, 583.988320233593, 625.140431906129, 657.0899304463353, 4182.121754431603, 4249.787510624456, 4263.701540892108, 4301.91396172081, 4323.891902702395, 54816.72591637016, 55462.0, 55494.722526387915, 55534.444655553736, 55865.441345586834, 48573.75713121482, 49074.0, 49491.75254123707, 50941.0, 51542.0, 45848.54151458442, 46335.768321158175, 46803.0, 47208.76395618, 47254.5274547257, 8380.874286885824, 8440.873386899078, 8537.18896704812, 8549.615267313111, 8569.719924250074, 34273.0, 34539.0, 34888.0, 34991.30017399689, 35266.0, 40952.79523602363, 44020.11959760723, 44270.0, 44656.77671611621, 44829.77585112184, 10023.498825058863, 10114.342567733074, 10122.79754404893, 10124.13944814699, 10252.23108266868, 10924.180686448708, 11006.834897476385, 11058.723531911766, 11209.495572699085, 11210.66368008961, 10165.186785057325, 10421.791564168825, 10546.736331591772, 10629.309094908805, 10639.468026598794, 9529.475878826732, 9694.272929530454, 9909.65316213929, 9927.205823534245, 9938.552765125442, 11017.669469915594, 11661.008814250883, 11711.472983715583, 11726.237794543327, 12124.757504849676, 8710.869336959824, 8839.16027977341, 9208.861867072133, 9380.81238375215, 9450.43297402158, 9006.842338022556, 9198.49408282551, 9328.626854925727, 9685.564149613425, 9697.175740062174], "unit": "score", "name": "yui.html", "value": 6214.589580209569}], "name": "dromaeo_css", "value": 6873.3594505312685}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 113.0, 112.0, 113.0, 122.0, 112.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [156.0, 126.0, 154.0, 165.0, 127.0, 149.0, 169.0, 124.0, 169.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 162.0, 162.0, 161.0, 160.0, 161.0, 164.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [80.0, 72.0, 71.0, 76.0, 72.0, 73.0, 151.0, 72.0, 71.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 149.0, 97.0, 96.0, 97.0, 142.0, 97.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 109.0, 109.0, 111.0, 110.0, 110.0, 110.0, 110.0, 112.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 148.0, 148.0, 146.0, 148.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 97.0, 95.0, 96.0, 98.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 57.0, 57.0, 60.0, 59.0, 62.0, 61.0, 66.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [85.0, 81.0, 82.0, 83.0, 92.0, 82.0, 82.0, 83.0, 83.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 121.0, 118.0, 130.0, 120.0, 121.0, 112.0, 117.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.2}, {"lowerIsBetter": true, "replicates": [136.0, 145.0, 148.0, 145.0, 152.0, 135.0, 148.0, 147.0, 145.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 69.0, 66.0, 70.0, 67.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1511.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.3080140538732], "unit": "score", "name": "Richards", "value": 211.00005399999995}, {"lowerIsBetter": false, "replicates": [188.32391713747646], "unit": "score", "name": "DeltaBlue", "value": 351.08658000000014}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [723.589001447178], "unit": "score", "name": "Earley", "value": 921.051866}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [41183.67346938775], "unit": "score", "name": "RegExp", "value": 22.120052031714565}, {"lowerIsBetter": false, "replicates": [588.8235294117648], "unit": "score", "name": "Splay", "value": 138.39630369630362}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 20363.93637690823}]} 08:53:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20363.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1511.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6873.36"}}} 08:53:41 INFO - Return code: 0 08:53:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:53:41 INFO - # TBPL SUCCESS # 08:53:41 INFO - Running post-action listener: _resource_record_post_action 08:53:41 INFO - Running post-run listener: _resource_record_post_run 08:53:43 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 12288; Write bytes: 552480768; Read time: 344; Write time: 401184 08:53:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 237428736; Read time: 172; Write time: 174092 08:53:43 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8192; Write bytes: 315052032; Read time: 172; Write time: 227092 08:53:43 INFO - Running post-run listener: _upload_blobber_files 08:53:43 INFO - Blob upload gear active. 08:53:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:53:43 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 08:53:43 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'] 08:53:43 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 08:53:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:53:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:53:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:53:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:44 INFO - (blobuploader) - INFO - Done attempting. 08:53:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:53:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:53:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:45 INFO - (blobuploader) - INFO - Done attempting. 08:53:45 INFO - (blobuploader) - INFO - Iteration through files over. 08:53:45 INFO - Return code: 0 08:53:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:53:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:53:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a6551ae5169a7fa7454d8f477b7e880fc75b56b8d8eed62feb9ea8a70bcde1274d3d96a8ca363a5fb4723132074b1dc25a46edc2e857b66c8755fb4284fd3d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7755706f0f3f2edf0daa8fcdf489f5ab33adb0d8c1104d01eb16d63f2d21ea9fd8ff999f7808e2e9de2f488fbe87a41d609fb91e52fc33dbe1dbb670becaa49a"} 08:53:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:53:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:53:45 INFO - Contents: 08:53:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a6551ae5169a7fa7454d8f477b7e880fc75b56b8d8eed62feb9ea8a70bcde1274d3d96a8ca363a5fb4723132074b1dc25a46edc2e857b66c8755fb4284fd3d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7755706f0f3f2edf0daa8fcdf489f5ab33adb0d8c1104d01eb16d63f2d21ea9fd8ff999f7808e2e9de2f488fbe87a41d609fb91e52fc33dbe1dbb670becaa49a"} 08:53:45 INFO - Running post-run listener: copy_logs_to_upload_dir 08:53:45 INFO - Copying logs to upload dir... 08:53:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:53:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.511009 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-01-18 08:53:45.002062) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 08:53:45.007205) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a6551ae5169a7fa7454d8f477b7e880fc75b56b8d8eed62feb9ea8a70bcde1274d3d96a8ca363a5fb4723132074b1dc25a46edc2e857b66c8755fb4284fd3d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7755706f0f3f2edf0daa8fcdf489f5ab33adb0d8c1104d01eb16d63f2d21ea9fd8ff999f7808e2e9de2f488fbe87a41d609fb91e52fc33dbe1dbb670becaa49a"} build_url:https://queue.taskcluster.net/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/dryP0qWiTm-JPqPZS1XA1Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a6551ae5169a7fa7454d8f477b7e880fc75b56b8d8eed62feb9ea8a70bcde1274d3d96a8ca363a5fb4723132074b1dc25a46edc2e857b66c8755fb4284fd3d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7755706f0f3f2edf0daa8fcdf489f5ab33adb0d8c1104d01eb16d63f2d21ea9fd8ff999f7808e2e9de2f488fbe87a41d609fb91e52fc33dbe1dbb670becaa49a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 08:53:45.040688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 08:53:45.041217) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453134253.200552-1083563018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004646 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 08:53:45.126157) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 08:53:45.126604) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 08:53:45.127004) ========= ========= Total master_lag: 0.31 =========