builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1453219699.69 results: success (0) buildid: 20160119053006 builduid: 1d9cc65bde6b4ca5aca8967644b9d0b5 revision: 491b1c69b3ed6e54de98f21b06d741e0981b0535 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.695037) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.695498) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.695783) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006475 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.719192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.719487) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.760559) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.760935) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022080 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.820821) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.821123) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.821551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:19.821858) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 08:08:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.9M=0s 2016-01-19 08:08:20 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191480 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.028669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.029190) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.029235 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:20.082340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-19 08:08:20.082808) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 491b1c69b3ed6e54de98f21b06d741e0981b0535 --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 491b1c69b3ed6e54de98f21b06d741e0981b0535 --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=6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 08:08:20,345 truncating revision to first 12 chars 2016-01-19 08:08:20,345 Setting DEBUG logging. 2016-01-19 08:08:20,345 attempt 1/10 2016-01-19 08:08:20,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/491b1c69b3ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 08:08:21,374 unpacking tar archive at: fx-team-491b1c69b3ed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.359414 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-19 08:08:21.457561) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:21.457881) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003929 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:21.506974) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:21.507303) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:21.517593) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:21.517952) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 08:08:21.518405) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-19 08:08:21.518706) ========= /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=6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:08:21 INFO - MultiFileLogger online at 20160119 08:08:21 in /builds/slave/test-pgo 08:08:21 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:08:21 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:08:21 INFO - {'append_to_log': False, 08:08:21 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:08:21 INFO - 'blob_upload_branch': 'Fx-Team', 08:08:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:08:21 INFO - 'branch': 'Fx-Team', 08:08:21 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:21 INFO - 'config_files': ('talos/linux_config.py',), 08:08:21 INFO - 'default_actions': ('clobber', 08:08:21 INFO - 'read-buildbot-config', 08:08:21 INFO - 'download-and-extract', 08:08:21 INFO - 'populate-webroot', 08:08:21 INFO - 'create-virtualenv', 08:08:21 INFO - 'install', 08:08:21 INFO - 'run-tests'), 08:08:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:21 INFO - 'download_minidump_stackwalk': True, 08:08:21 INFO - 'download_symbols': 'ondemand', 08:08:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:21 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:21 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:21 INFO - 'installer_path': 'installer.exe', 08:08:21 INFO - 'log_level': 'info', 08:08:21 INFO - 'log_name': 'talos', 08:08:21 INFO - 'log_to_console': True, 08:08:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:08:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:08:21 INFO - 'opt_config_files': (), 08:08:21 INFO - 'pip_index': False, 08:08:21 INFO - 'sps_profile': False, 08:08:21 INFO - 'sps_profile_interval': 0, 08:08:21 INFO - 'suite': 'dromaeojs-e10s', 08:08:21 INFO - 'system_bits': '32', 08:08:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:21 INFO - 'title': 'talos-linux64-ix-023', 08:08:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:21 INFO - 'use_talos_json': True, 08:08:21 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:08:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:21 INFO - 'work_dir': 'build'} 08:08:21 INFO - ##### 08:08:21 INFO - ##### Running clobber step. 08:08:21 INFO - ##### 08:08:21 INFO - Running pre-action listener: _resource_record_pre_action 08:08:21 INFO - Running main action method: clobber 08:08:21 INFO - rmtree: /builds/slave/test-pgo/build 08:08:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:08:23 INFO - Running post-action listener: _resource_record_post_action 08:08:23 INFO - ##### 08:08:23 INFO - ##### Running read-buildbot-config step. 08:08:23 INFO - ##### 08:08:23 INFO - Running pre-action listener: _resource_record_pre_action 08:08:23 INFO - Running main action method: read_buildbot_config 08:08:23 INFO - Using buildbot properties: 08:08:23 INFO - { 08:08:23 INFO - "project": "", 08:08:23 INFO - "product": "firefox", 08:08:23 INFO - "script_repo_revision": "production", 08:08:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:08:23 INFO - "repository": "", 08:08:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:08:23 INFO - "buildid": "20160119053006", 08:08:23 INFO - "pgo_build": "True", 08:08:23 INFO - "basedir": "/builds/slave/test-pgo", 08:08:23 INFO - "buildnumber": 219, 08:08:23 INFO - "slavename": "talos-linux64-ix-023", 08:08:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:08:23 INFO - "platform": "ubuntu64_hw", 08:08:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:08:23 INFO - "branch": "fx-team", 08:08:23 INFO - "repo_path": "integration/fx-team", 08:08:23 INFO - "revision": "491b1c69b3ed6e54de98f21b06d741e0981b0535", 08:08:23 INFO - "stage_platform": "linux64-pgo", 08:08:23 INFO - "builduid": "1d9cc65bde6b4ca5aca8967644b9d0b5", 08:08:23 INFO - "slavebuilddir": "test" 08:08:23 INFO - } 08:08:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:08:23 INFO - Running post-action listener: _resource_record_post_action 08:08:23 INFO - ##### 08:08:23 INFO - ##### Running download-and-extract step. 08:08:23 INFO - ##### 08:08:23 INFO - Running pre-action listener: _resource_record_pre_action 08:08:23 INFO - Running main action method: download_and_extract 08:08:23 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:23 INFO - https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:08:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/test_packages.json 08:08:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/test_packages.json 08:08:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:08:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:08:27 INFO - Downloaded 1448 bytes. 08:08:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:08:27 INFO - Using the following test package requirements: 08:08:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:08:27 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:08:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:27 INFO - u'jsshell-linux-x86_64.zip'], 08:08:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:08:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:08:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:08:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:08:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:08:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:08: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:08:27 INFO - https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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:08:36 INFO - Downloaded 22484778 bytes. 08:08:36 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:08:36 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:08:37 INFO - Return code: 0 08:08:37 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:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:37 INFO - https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:08:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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:08:39 INFO - Downloaded 22484778 bytes. 08:08:39 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:08:39 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:08:40 INFO - Return code: 0 08:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:40 INFO - https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:08:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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:08:42 INFO - Downloaded 11132144 bytes. 08:08:42 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:08:42 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:08:42 INFO - Return code: 0 08:08:42 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:08:42 INFO - https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtY4yORURVyE2x1VMYXZxA/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:08:43 INFO - Downloaded 55942533 bytes. 08:08:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:43 INFO - mkdir: /builds/slave/test-pgo/properties 08:08:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:08:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:08:43 INFO - Contents: 08:08:43 INFO - build_url:https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:08:43 INFO - Running post-action listener: _resource_record_post_action 08:08:43 INFO - Running post-action listener: set_extra_try_arguments 08:08:43 INFO - ##### 08:08:43 INFO - ##### Running populate-webroot step. 08:08:43 INFO - ##### 08:08:43 INFO - Running pre-action listener: _resource_record_pre_action 08:08:43 INFO - Running main action method: populate_webroot 08:08:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:08:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:08:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:08:43 INFO - '--tppagecycles', 08:08:43 INFO - '7'], 08:08:43 INFO - 'tests': ['tsvgm']}}, 08:08:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:08:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:08:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:08:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:08:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:08:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:08:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:43 INFO - 'talos_options': ['--e10s'], 08:08:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:43 INFO - 'tests': ['damp', 'tps']}, 08:08:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:43 INFO - 'talos_options': ['--e10s'], 08:08:43 INFO - 'tests': ['damp', 'tps']}, 08:08:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:08:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:08:43 INFO - 'other': {'tests': ['a11yr', 08:08:43 INFO - 'ts_paint', 08:08:43 INFO - 'tpaint', 08:08:43 INFO - 'sessionrestore', 08:08:43 INFO - 'sessionrestore_no_auto_restore']}, 08:08:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:08:43 INFO - 'tests': ['a11yr', 08:08:43 INFO - 'ts_paint', 08:08:43 INFO - 'tpaint', 08:08:43 INFO - 'sessionrestore', 08:08:43 INFO - 'sessionrestore_no_auto_restore']}, 08:08:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:08:43 INFO - 'tests': ['a11yr', 08:08:43 INFO - 'ts_paint', 08:08:43 INFO - 'tpaint', 08:08:43 INFO - 'sessionrestore', 08:08:43 INFO - 'sessionrestore_no_auto_restore']}, 08:08:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:08:43 INFO - 'tests': ['a11yr', 08:08:43 INFO - 'ts_paint', 08:08:43 INFO - 'tpaint', 08:08:43 INFO - 'sessionrestore', 08:08:43 INFO - 'sessionrestore_no_auto_restore']}, 08:08:43 INFO - 'other_l64': {'tests': ['a11yr', 08:08:43 INFO - 'ts_paint', 08:08:43 INFO - 'tpaint', 08:08:43 INFO - 'sessionrestore', 08:08:43 INFO - 'sessionrestore_no_auto_restore']}, 08:08:43 INFO - 'other_nol64': {'tests': ['a11yr', 08:08:43 INFO - 'ts_paint', 08:08:43 INFO - 'tpaint', 08:08:43 INFO - 'sessionrestore', 08:08:43 INFO - 'sessionrestore_no_auto_restore']}, 08:08:43 INFO - 'svgr': {'tests': ['tsvgx', 08:08:43 INFO - 'tsvgr_opacity', 08:08:43 INFO - 'tart', 08:08:43 INFO - 'tscrollx', 08:08:43 INFO - 'cart']}, 08:08:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:08:43 INFO - 'tests': ['tsvgx', 08:08:43 INFO - 'tsvgr_opacity', 08:08:43 INFO - 'tart', 08:08:43 INFO - 'tscrollx', 08:08:43 INFO - 'cart']}, 08:08:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:43 INFO - 'tests': ['tp5o']}, 08:08:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:43 INFO - 'talos_options': ['--e10s'], 08:08:43 INFO - 'tests': ['tp5o']}, 08:08:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:43 INFO - 'talos_options': ['--xperf_path', 08:08:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:43 INFO - 'tests': ['tp5n']}, 08:08:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:43 INFO - 'talos_options': ['--e10s', 08:08:43 INFO - '--xperf_path', 08:08:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:43 INFO - 'tests': ['tp5n']}}, 08:08:43 INFO - 'talos.zip': {'path': '', 08:08:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:08:43 INFO - Running post-action listener: _resource_record_post_action 08:08:43 INFO - ##### 08:08:43 INFO - ##### Running create-virtualenv step. 08:08:43 INFO - ##### 08:08:43 INFO - Running pre-action listener: _resource_record_pre_action 08:08:43 INFO - Running main action method: create_virtualenv 08:08:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:08:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 08:08:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:08:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:08:43 INFO - Using real prefix '/usr' 08:08:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:08:44 INFO - Installing distribute.............................................................................................................................................................................................done. 08:08:46 INFO - Installing pip.................done. 08:08:46 INFO - Return code: 0 08:08:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:46 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 0x7f3d119aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152a840>, '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 0x14976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1497b60>, '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': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', '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:08:46 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:08:46 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:08:46 INFO - Using env: {'DISPLAY': ':0', 08:08:46 INFO - 'HOME': '/home/cltbld', 08:08:46 INFO - 'LANG': 'en_US.UTF-8', 08:08:46 INFO - 'LANGUAGE': 'en_US:en', 08:08:46 INFO - 'LOGNAME': 'cltbld', 08:08:46 INFO - 'MAIL': '/var/mail/cltbld', 08:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:46 INFO - 'MOZ_NO_REMOTE': '1', 08:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:46 INFO - 'NO_EM_RESTART': '1', 08:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:46 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:46 INFO - 'SHELL': '/bin/bash', 08:08:46 INFO - 'SHLVL': '1', 08:08:46 INFO - 'TERM': 'linux', 08:08:46 INFO - 'TMOUT': '86400', 08:08:46 INFO - 'USER': 'cltbld', 08:08:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', 08:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:46 INFO - '_': '/tools/buildbot/bin/python'} 08:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:08:46 INFO - Cleaning up... 08:08:46 INFO - Return code: 0 08:08:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:46 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 0x7f3d119aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152a840>, '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 0x14976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1497b60>, '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': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', '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:08:46 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:08:46 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:08:46 INFO - Using env: {'DISPLAY': ':0', 08:08:46 INFO - 'HOME': '/home/cltbld', 08:08:46 INFO - 'LANG': 'en_US.UTF-8', 08:08:46 INFO - 'LANGUAGE': 'en_US:en', 08:08:46 INFO - 'LOGNAME': 'cltbld', 08:08:46 INFO - 'MAIL': '/var/mail/cltbld', 08:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:46 INFO - 'MOZ_NO_REMOTE': '1', 08:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:46 INFO - 'NO_EM_RESTART': '1', 08:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:46 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:46 INFO - 'SHELL': '/bin/bash', 08:08:46 INFO - 'SHLVL': '1', 08:08:46 INFO - 'TERM': 'linux', 08:08:46 INFO - 'TMOUT': '86400', 08:08:46 INFO - 'USER': 'cltbld', 08:08:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', 08:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:46 INFO - '_': '/tools/buildbot/bin/python'} 08:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:46 INFO - Downloading/unpacking psutil>=0.7.1 08:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:48 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:08:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:08:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:48 INFO - Installing collected packages: psutil 08:08:48 INFO - Running setup.py install for psutil 08:08:48 INFO - building 'psutil._psutil_linux' extension 08:08:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:08:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:08:48 INFO - building 'psutil._psutil_posix' extension 08:08:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:08:49 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:08:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:49 INFO - Successfully installed psutil 08:08:49 INFO - Cleaning up... 08:08:49 INFO - Return code: 0 08:08:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:08:49 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:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:49 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:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:49 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 0x7f3d119aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152a840>, '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 0x14976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1497b60>, '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': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', '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:08:49 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:08:49 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:08:49 INFO - Using env: {'DISPLAY': ':0', 08:08:49 INFO - 'HOME': '/home/cltbld', 08:08:49 INFO - 'LANG': 'en_US.UTF-8', 08:08:49 INFO - 'LANGUAGE': 'en_US:en', 08:08:49 INFO - 'LOGNAME': 'cltbld', 08:08:49 INFO - 'MAIL': '/var/mail/cltbld', 08:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:49 INFO - 'MOZ_NO_REMOTE': '1', 08:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:49 INFO - 'NO_EM_RESTART': '1', 08:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:49 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:49 INFO - 'SHELL': '/bin/bash', 08:08:49 INFO - 'SHLVL': '1', 08:08:49 INFO - 'TERM': 'linux', 08:08:49 INFO - 'TMOUT': '86400', 08:08:49 INFO - 'USER': 'cltbld', 08:08:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', 08:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:49 INFO - '_': '/tools/buildbot/bin/python'} 08:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:08:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:08:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:51 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:08:51 INFO - Installing collected packages: mozsystemmonitor 08:08:51 INFO - Running setup.py install for mozsystemmonitor 08:08:51 INFO - Successfully installed mozsystemmonitor 08:08:51 INFO - Cleaning up... 08:08:51 INFO - Return code: 0 08:08:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:08: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:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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', '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 0x7f3d119aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152a840>, '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 0x14976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1497b60>, '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': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', '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:08: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:08: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 blobuploader==1.2.4 08:08:51 INFO - Using env: {'DISPLAY': ':0', 08:08:51 INFO - 'HOME': '/home/cltbld', 08:08:51 INFO - 'LANG': 'en_US.UTF-8', 08:08:51 INFO - 'LANGUAGE': 'en_US:en', 08:08:51 INFO - 'LOGNAME': 'cltbld', 08:08:51 INFO - 'MAIL': '/var/mail/cltbld', 08:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:51 INFO - 'MOZ_NO_REMOTE': '1', 08:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:51 INFO - 'NO_EM_RESTART': '1', 08:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:51 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:51 INFO - 'SHELL': '/bin/bash', 08:08:51 INFO - 'SHLVL': '1', 08:08:51 INFO - 'TERM': 'linux', 08:08:51 INFO - 'TMOUT': '86400', 08:08:51 INFO - 'USER': 'cltbld', 08:08:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', 08:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:51 INFO - '_': '/tools/buildbot/bin/python'} 08:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:08: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:08: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:08: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:08: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:08: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:08: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:08:53 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:08:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08: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:08: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:08: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:08: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:08: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:08: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:08:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:08:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:08:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08: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:08: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:08: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:08: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:08: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:08: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:08:53 INFO - Downloading docopt-0.6.1.tar.gz 08:08:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:08:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:54 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:54 INFO - Running setup.py install for blobuploader 08:08:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:08:54 INFO - Running setup.py install for requests 08:08:54 INFO - Running setup.py install for docopt 08:08:54 INFO - Successfully installed blobuploader requests docopt 08:08:54 INFO - Cleaning up... 08:08:54 INFO - Return code: 0 08:08:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:54 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 0x7f3d119aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152a840>, '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 0x14976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1497b60>, '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': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', '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:08:54 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:08:54 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:08:54 INFO - Using env: {'DISPLAY': ':0', 08:08:54 INFO - 'HOME': '/home/cltbld', 08:08:54 INFO - 'LANG': 'en_US.UTF-8', 08:08:54 INFO - 'LANGUAGE': 'en_US:en', 08:08:54 INFO - 'LOGNAME': 'cltbld', 08:08:54 INFO - 'MAIL': '/var/mail/cltbld', 08:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:54 INFO - 'MOZ_NO_REMOTE': '1', 08:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:54 INFO - 'NO_EM_RESTART': '1', 08:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:54 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:54 INFO - 'SHELL': '/bin/bash', 08:08:54 INFO - 'SHLVL': '1', 08:08:54 INFO - 'TERM': 'linux', 08:08:54 INFO - 'TMOUT': '86400', 08:08:54 INFO - 'USER': 'cltbld', 08:08:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', 08:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:54 INFO - '_': '/tools/buildbot/bin/python'} 08:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:54 INFO - Running setup.py (path:/tmp/pip-hQcFlh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:54 INFO - Running setup.py (path:/tmp/pip-rRA5AT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:55 INFO - Running setup.py (path:/tmp/pip-3vXnzP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:55 INFO - Running setup.py (path:/tmp/pip-cEFYGO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:55 INFO - Running setup.py (path:/tmp/pip-SHS3IG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:55 INFO - Running setup.py (path:/tmp/pip-PA_caS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:55 INFO - Running setup.py (path:/tmp/pip-zYvqM0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:55 INFO - Running setup.py (path:/tmp/pip-UxfqgT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:55 INFO - Running setup.py (path:/tmp/pip-u3oTQE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:55 INFO - Running setup.py (path:/tmp/pip-J_aDcV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:55 INFO - Running setup.py (path:/tmp/pip-qdMOck-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:55 INFO - Running setup.py (path:/tmp/pip-FEOiHf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:55 INFO - Running setup.py (path:/tmp/pip-kTlAv1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:55 INFO - Running setup.py (path:/tmp/pip-srrpYD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:55 INFO - Running setup.py (path:/tmp/pip-KVPO8A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:55 INFO - Running setup.py (path:/tmp/pip-Ds_Utw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:56 INFO - Running setup.py (path:/tmp/pip-DrmKMQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:08:56 INFO - Running setup.py install for manifestparser 08:08:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:08:56 INFO - Running setup.py install for mozcrash 08:08:56 INFO - Running setup.py install for mozdebug 08:08:56 INFO - Running setup.py install for mozdevice 08:08:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:08:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:08:56 INFO - Running setup.py install for mozfile 08:08:56 INFO - Running setup.py install for mozhttpd 08:08:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:08:56 INFO - Running setup.py install for mozinfo 08:08:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:08:56 INFO - Running setup.py install for mozInstall 08:08:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:08:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:08:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:08:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:08:56 INFO - Running setup.py install for mozleak 08:08:56 INFO - Running setup.py install for mozlog 08:08:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:08:57 INFO - Running setup.py install for moznetwork 08:08:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:08:57 INFO - Running setup.py install for mozprocess 08:08:57 INFO - Running setup.py install for mozprofile 08:08:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:08:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:08:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:08:57 INFO - Running setup.py install for mozrunner 08:08:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:08:57 INFO - Running setup.py install for mozscreenshot 08:08:57 INFO - Running setup.py install for moztest 08:08:57 INFO - Running setup.py install for mozversion 08:08:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:08:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:57 INFO - Cleaning up... 08:08:57 INFO - Return code: 0 08:08:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:57 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 0x7f3d119aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152a840>, '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 0x14976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1497b60>, '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': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', '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:08:57 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:08:57 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:08:57 INFO - Using env: {'DISPLAY': ':0', 08:08:57 INFO - 'HOME': '/home/cltbld', 08:08:57 INFO - 'LANG': 'en_US.UTF-8', 08:08:57 INFO - 'LANGUAGE': 'en_US:en', 08:08:57 INFO - 'LOGNAME': 'cltbld', 08:08:57 INFO - 'MAIL': '/var/mail/cltbld', 08:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:57 INFO - 'MOZ_NO_REMOTE': '1', 08:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:57 INFO - 'NO_EM_RESTART': '1', 08:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:57 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:57 INFO - 'SHELL': '/bin/bash', 08:08:57 INFO - 'SHLVL': '1', 08:08:57 INFO - 'TERM': 'linux', 08:08:57 INFO - 'TMOUT': '86400', 08:08:57 INFO - 'USER': 'cltbld', 08:08:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', 08:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:57 INFO - '_': '/tools/buildbot/bin/python'} 08:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:58 INFO - Running setup.py (path:/tmp/pip-hkYdcr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:58 INFO - Running setup.py (path:/tmp/pip-unOR2V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:58 INFO - Running setup.py (path:/tmp/pip-W1GYDk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:58 INFO - Running setup.py (path:/tmp/pip-FbJPfH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:58 INFO - Running setup.py (path:/tmp/pip-JG_Xc9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:58 INFO - Running setup.py (path:/tmp/pip-vDUY7l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:58 INFO - Running setup.py (path:/tmp/pip-6KWLLE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:58 INFO - Running setup.py (path:/tmp/pip-wUPIJk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:58 INFO - Running setup.py (path:/tmp/pip-XY4w6x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:58 INFO - Running setup.py (path:/tmp/pip-lMDp9V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:58 INFO - Running setup.py (path:/tmp/pip-durs8e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:58 INFO - Running setup.py (path:/tmp/pip-RGcpD6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 08:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:58 INFO - Running setup.py (path:/tmp/pip-NnX5ry-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:59 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:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:59 INFO - Running setup.py (path:/tmp/pip-AkeN5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:59 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:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:59 INFO - Running setup.py (path:/tmp/pip-J3pRs1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 08:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:59 INFO - Running setup.py (path:/tmp/pip-eYiQ1R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 08:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:59 INFO - Running setup.py (path:/tmp/pip-5M8YaV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 08:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 08:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:08:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:01 INFO - Downloading blessings-1.5.1.tar.gz 08:09:01 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:09:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:01 INFO - Installing collected packages: blessings 08:09:01 INFO - Running setup.py install for blessings 08:09:01 INFO - Successfully installed blessings 08:09:01 INFO - Cleaning up... 08:09:01 INFO - Return code: 0 08:09:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:09:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:09:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:09:01 INFO - Reading from file tmpfile_stdout 08:09:01 INFO - Current package versions: 08:09:01 INFO - argparse == 1.2.1 08:09:01 INFO - blessings == 1.5.1 08:09:01 INFO - blobuploader == 1.2.4 08:09:01 INFO - docopt == 0.6.1 08:09:01 INFO - manifestparser == 1.1 08:09:01 INFO - mozInstall == 1.12 08:09:01 INFO - mozcrash == 0.16 08:09:01 INFO - mozdebug == 0.1 08:09:01 INFO - mozdevice == 0.48 08:09:01 INFO - mozfile == 1.2 08:09:01 INFO - mozhttpd == 0.7 08:09:01 INFO - mozinfo == 0.9 08:09:01 INFO - mozleak == 0.1 08:09:01 INFO - mozlog == 3.1 08:09:01 INFO - moznetwork == 0.27 08:09:01 INFO - mozprocess == 0.22 08:09:01 INFO - mozprofile == 0.28 08:09:01 INFO - mozrunner == 6.11 08:09:01 INFO - mozscreenshot == 0.1 08:09:01 INFO - mozsystemmonitor == 0.0 08:09:01 INFO - moztest == 0.7 08:09:01 INFO - mozversion == 1.4 08:09:01 INFO - psutil == 3.1.1 08:09:01 INFO - requests == 1.2.3 08:09:01 INFO - wsgiref == 0.1.2 08:09:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:01 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 0x7f3d119aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152a840>, '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 0x14976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1497b60>, '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': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', '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:09:01 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:09:01 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:09:01 INFO - Using env: {'DISPLAY': ':0', 08:09:01 INFO - 'HOME': '/home/cltbld', 08:09:01 INFO - 'LANG': 'en_US.UTF-8', 08:09:01 INFO - 'LANGUAGE': 'en_US:en', 08:09:01 INFO - 'LOGNAME': 'cltbld', 08:09:01 INFO - 'MAIL': '/var/mail/cltbld', 08:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:01 INFO - 'MOZ_NO_REMOTE': '1', 08:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:01 INFO - 'NO_EM_RESTART': '1', 08:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:01 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:01 INFO - 'SHELL': '/bin/bash', 08:09:01 INFO - 'SHLVL': '1', 08:09:01 INFO - 'TERM': 'linux', 08:09:01 INFO - 'TMOUT': '86400', 08:09:01 INFO - 'USER': 'cltbld', 08:09:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', 08:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:01 INFO - '_': '/tools/buildbot/bin/python'} 08:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 08:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 08:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 08:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 08:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 08:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 08:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 08:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:09:01 INFO - Cleaning up... 08:09:01 INFO - Return code: 0 08:09:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:01 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 0x7f3d119aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152a840>, '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 0x14976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1497b60>, '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': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', '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:09:01 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:09:01 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:09:01 INFO - Using env: {'DISPLAY': ':0', 08:09:01 INFO - 'HOME': '/home/cltbld', 08:09:01 INFO - 'LANG': 'en_US.UTF-8', 08:09:01 INFO - 'LANGUAGE': 'en_US:en', 08:09:01 INFO - 'LOGNAME': 'cltbld', 08:09:01 INFO - 'MAIL': '/var/mail/cltbld', 08:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:01 INFO - 'MOZ_NO_REMOTE': '1', 08:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:01 INFO - 'NO_EM_RESTART': '1', 08:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:01 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:01 INFO - 'SHELL': '/bin/bash', 08:09:01 INFO - 'SHLVL': '1', 08:09:01 INFO - 'TERM': 'linux', 08:09:01 INFO - 'TMOUT': '86400', 08:09:01 INFO - 'USER': 'cltbld', 08:09:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', 08:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:01 INFO - '_': '/tools/buildbot/bin/python'} 08:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:01 INFO - Downloading/unpacking jsonschema 08:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:03 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:09:03 INFO - Downloading/unpacking functools32 (from jsonschema) 08:09: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:09: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:09: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:09: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:09: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:09: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:09:03 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:03 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:09:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:03 INFO - warning: no files found matching '*.txt' 08:09:03 INFO - no previously-included directories found matching 'build' 08:09:03 INFO - no previously-included directories found matching 'dist' 08:09:03 INFO - no previously-included directories found matching '.git*' 08:09:03 INFO - Installing collected packages: jsonschema, functools32 08:09:03 INFO - Running setup.py install for functools32 08:09:04 INFO - warning: no files found matching '*.txt' 08:09:04 INFO - no previously-included directories found matching 'build' 08:09:04 INFO - no previously-included directories found matching 'dist' 08:09:04 INFO - no previously-included directories found matching '.git*' 08:09:04 INFO - Successfully installed jsonschema functools32 08:09:04 INFO - Cleaning up... 08:09:04 INFO - Return code: 0 08:09:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:04 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 0x7f3d119aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1499630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152a840>, '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 0x14976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1497b60>, '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': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', '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:09:04 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:09:04 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:09:04 INFO - Using env: {'DISPLAY': ':0', 08:09:04 INFO - 'HOME': '/home/cltbld', 08:09:04 INFO - 'LANG': 'en_US.UTF-8', 08:09:04 INFO - 'LANGUAGE': 'en_US:en', 08:09:04 INFO - 'LOGNAME': 'cltbld', 08:09:04 INFO - 'MAIL': '/var/mail/cltbld', 08:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:04 INFO - 'MOZ_NO_REMOTE': '1', 08:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:04 INFO - 'NO_EM_RESTART': '1', 08:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:04 INFO - 'SHELL': '/bin/bash', 08:09:04 INFO - 'SHLVL': '1', 08:09:04 INFO - 'TERM': 'linux', 08:09:04 INFO - 'TMOUT': '86400', 08:09:04 INFO - 'USER': 'cltbld', 08:09:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', 08:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:04 INFO - '_': '/tools/buildbot/bin/python'} 08:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:04 INFO - Downloading/unpacking flake8 08:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:09:06 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:09:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:09: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:09: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:09: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:09: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:09: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:09: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:09:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:09:06 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:09:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:09: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:09: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:09: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:09: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:09: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:09: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:09:06 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:09:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:09: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:09: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:09: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:09: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:09: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:09: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:09:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:09:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:09:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:06 INFO - no previously-included directories found matching 'docs/_build' 08:09:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:09:06 INFO - Running setup.py install for pep8 08:09:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:06 INFO - no previously-included directories found matching 'docs/_build' 08:09:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:09:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:09:06 INFO - Cleaning up... 08:09:06 INFO - Return code: 0 08:09:06 INFO - Running post-action listener: _resource_record_post_action 08:09:06 INFO - Running post-action listener: _start_resource_monitoring 08:09:06 INFO - Starting resource monitoring. 08:09:06 INFO - ##### 08:09:06 INFO - ##### Running install step. 08:09:06 INFO - ##### 08:09:06 INFO - Running pre-action listener: _resource_record_pre_action 08:09:06 INFO - Running main action method: install 08:09:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:09:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:09:07 INFO - Reading from file tmpfile_stdout 08:09:07 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:09:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:09:07 INFO - Reading from file tmpfile_stdout 08:09:07 INFO - Output received: 08:09:07 INFO - Usage: mozinstall [options] installer 08:09:07 INFO - Options: 08:09:07 INFO - -h, --help show this help message and exit 08:09:07 INFO - -d DEST, --destination=DEST 08:09:07 INFO - Directory to install application into. [default: 08:09:07 INFO - "/builds/slave/test-pgo"] 08:09:07 INFO - --app=APP Application being installed. [default: firefox] 08:09:07 INFO - mkdir: /builds/slave/test-pgo/build/application 08:09:07 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:09:07 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:09:23 INFO - Reading from file tmpfile_stdout 08:09:23 INFO - Output received: 08:09:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:09:23 INFO - Running post-action listener: _resource_record_post_action 08:09:23 INFO - ##### 08:09:23 INFO - ##### Running run-tests step. 08:09:23 INFO - ##### 08:09:23 INFO - Running pre-action listener: _resource_record_pre_action 08:09:23 INFO - Running main action method: run_tests 08:09:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:09:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:09:23 INFO - Python 2.7.3 08:09:23 INFO - Return code: 0 08:09:23 INFO - grabbing minidump binary from tooltool 08:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x152a840>, '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 0x14976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1497b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:09:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 08:09:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:09:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:09:23 INFO - Return code: 0 08:09:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:09:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:09:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:09:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:09:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:09:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:09:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:09:24 INFO - Return code: 0 08:09:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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:09:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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:09:24 INFO - Using env: {'DISPLAY': ':0', 08:09:24 INFO - 'HOME': '/home/cltbld', 08:09:24 INFO - 'LANG': 'en_US.UTF-8', 08:09:24 INFO - 'LANGUAGE': 'en_US:en', 08:09:24 INFO - 'LOGNAME': 'cltbld', 08:09:24 INFO - 'MAIL': '/var/mail/cltbld', 08:09:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:09:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:24 INFO - 'MOZ_NO_REMOTE': '1', 08:09:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:24 INFO - 'NO_EM_RESTART': '1', 08:09:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:09:24 INFO - 'PWD': '/builds/slave/test-pgo', 08:09:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:09:24 INFO - 'SHELL': '/bin/bash', 08:09:24 INFO - 'SHLVL': '1', 08:09:24 INFO - 'TERM': 'linux', 08:09:24 INFO - 'TMOUT': '86400', 08:09:24 INFO - 'USER': 'cltbld', 08:09:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179', 08:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:24 INFO - '_': '/tools/buildbot/bin/python'} 08:09:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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:09:24 INFO - mozversion application_buildid: 20160119053006 08:09:24 INFO - mozversion application_changeset: 491b1c69b3ed6e54de98f21b06d741e0981b0535 08:09:24 INFO - mozversion application_display_name: Nightly 08:09:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:09:24 INFO - mozversion application_name: Firefox 08:09:24 INFO - mozversion application_remotingname: firefox 08:09:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:09:24 INFO - mozversion application_vendor: Mozilla 08:09:24 INFO - mozversion application_version: 46.0a1 08:09:24 INFO - mozversion platform_buildid: 20160119053006 08:09:24 INFO - mozversion platform_changeset: 491b1c69b3ed6e54de98f21b06d741e0981b0535 08:09:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:09:24 INFO - mozversion platform_version: 46.0a1 08:09:24 INFO - using testdate: 1453219764 08:09:24 INFO - actual date: 1453219764 08:09:24 INFO - starting webserver on 'localhost:36241' 08:09:24 INFO - SUITE-START | Running 3 tests 08:09:24 INFO - TEST-START | dromaeo_css 08:09:24 INFO - operating with platform_type : linux_ 08:09:24 INFO - Initialising browser for dromaeo_css test... 08:09:24 INFO - TEST-INFO | started process 8506 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwmbX1k/profile http://localhost:36241/getInfo.html) 08:09:28 INFO - PROCESS | 8506 | 08:09:28 INFO - PROCESS | 8506 | (process:8588): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:09:29 INFO - PROCESS | 8506 | __metrics Screen width/height:1600/1200 08:09:29 INFO - PROCESS | 8506 | colorDepth:24 08:09:29 INFO - PROCESS | 8506 | Browser inner width/height: 1024/697 08:09:29 INFO - PROCESS | 8506 | __metrics 08:09:29 INFO - PROCESS | 8506 | 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:09:30 INFO - TEST-INFO | 8506: exit 0 08:09:30 INFO - Browser initialized. 08:09:30 INFO - Running cycle 1/1 for dromaeo_css test... 08:09:30 INFO - TEST-INFO | started process 8636 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwmbX1k/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:09:30 INFO - PROCESS | 8636 | -- checkerboarding starts below -- 08:09:30 INFO - PROCESS | 8636 | RENDERTRACE 0.053525 rect red 0 0 10 10 // viewport 08:09:30 INFO - PROCESS | 8636 | RENDERTRACE 17.8789 rect brown 0 0 10 10 // page 08:09:30 INFO - PROCESS | 8636 | RENDERTRACE 17.8993 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 08:09:30 INFO - PROCESS | 8636 | Checkerboarded for 1 frames (19.9619 ms), 100 peak, 1 severity. 08:09:31 INFO - PROCESS | 8636 | 08:09:31 INFO - PROCESS | 8636 | (process:8698): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:09:41 INFO - PROCESS | 8636 | RSS: Main: 150155264 08:09:41 INFO - PROCESS | 8636 | 08:10:31 INFO - PROCESS | 8636 | 1453219831343 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:12:40 INFO - PROCESS | 8636 | Cycle 1(1): loaded http://localhost:36241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36241/tests/dromaeo/cssquery-ext.html) 08:12:41 INFO - PROCESS | 8636 | RSS: Main: 156487680 08:12:41 INFO - PROCESS | 8636 | 08:15:43 INFO - PROCESS | 8636 | Cycle 1(1): loaded http://localhost:36241/tests/dromaeo/cssquery-ext.html (next: http://localhost:36241/tests/dromaeo/cssquery-jquery.html) 08:15:43 INFO - PROCESS | 8636 | RSS: Main: 150441984 08:15:43 INFO - PROCESS | 8636 | 08:18:45 INFO - PROCESS | 8636 | Cycle 1(1): loaded http://localhost:36241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36241/tests/dromaeo/cssquery-mootools.html) 08:18:46 INFO - PROCESS | 8636 | RSS: Main: 152166400 08:18:46 INFO - PROCESS | 8636 | 08:21:47 INFO - PROCESS | 8636 | Cycle 1(1): loaded http://localhost:36241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36241/tests/dromaeo/cssquery-prototype.html) 08:21:48 INFO - PROCESS | 8636 | RSS: Main: 150597632 08:21:48 INFO - PROCESS | 8636 | 08:24:50 INFO - PROCESS | 8636 | Cycle 1(1): loaded http://localhost:36241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36241/tests/dromaeo/cssquery-yui.html) 08:24:51 INFO - PROCESS | 8636 | RSS: Main: 151773184 08:24:51 INFO - PROCESS | 8636 | 08:27:53 INFO - PROCESS | 8636 | Cycle 1(1): loaded http://localhost:36241/tests/dromaeo/cssquery-yui.html (next: http://localhost:36241/tests/dromaeo/cssquery-dojo.html) 08:27:54 INFO - PROCESS | 8636 | RSS: Main: 153665536 08:27:54 INFO - PROCESS | 8636 | 08:27:54 INFO - PROCESS | 8636 | __start_tp_report 08:27:54 INFO - PROCESS | 8636 | _x_x_mozilla_page_load 08:27:54 INFO - PROCESS | 8636 | _x_x_mozilla_page_load_details 08:27:54 INFO - PROCESS | 8636 | |i|pagename|runs| 08:27:54 INFO - PROCESS | 8636 | |0;dojo.html;3159.1470303018177;3190.505471651892;3198.104530731396;3236.4336241157794;3240.995291459647;5246.868828279295;5272.446393128719;5326.3075800145925;5330.3603567571845;5362.544183744381;5274.709890955995;5317.255584218203;5377.731113444322;5385;5395.109806881869;4914.877128071809;4947.307376967227;4971.37857767779;5010.6993580385115;5014.423341315741;4954.578860796819;4956.2070068789;5001.074801161779;5002.12462819007;5010.599152067826;4836.854894353175;4875.366202393684;4882.414110306786;4902.975485122552;4908.3128362029165;4894.094592500399;4924.729139897304;4931.605471562267;4935.2843837643695;4956.702597844105;4885.828995985124;4902.901941961177;4903.8528844134735;4929.556339929388;4948.975255123737;5133.922991155136;5171.3535808024;5215.426303106655;5249.816256431007;5260.894782104375;5761.510271626917;5786.07422812348;5796.710164491801;5797.130430435468;5804.216430781833;5798.623089499169;5807.390224026459;5815.156802263648;5819.505342045931;5834.912476312858;5327.38735045467;5329;5386.272853164812;5388.865278368072;5428.4028756836715;5860.267466566679;5886.793962211302;5898.911516327258;5909.763609455574;5921.289445266596;5684.516816070598;5718.714064296769;5721.370649228582;5740.0815869460685;5745.9425405745405;5641.182028605829;5679.886402271932;5704.971475142598;5730.169125476783;5757.596968212269;5630.71846407678;5638.097904335286;5656.236408084856;5675.5459563234845;5763.510101641324;5720.48515633595;5730.656160630292;5768.567357448124;5769.826905192851;5776.653400795965;4389.473263208435;4473.483545893531;4478.037221997286;4488.798004089824;4525.411696479502;3942.5268967724055;3990.1620659661794;4010.8997275067773;4020.4170395292517;4025.8993525162105;5306.6550674206055;5325.121354976463;5328.866778330573;5331;5335.973320133375;5653.208550802891;5713.485786279171;5715.257016587817;5727.140928860705;5728.541716662657;5203.19350500673;5308.946910530923;5317.973410133002;5321;5410.026195284887;4903.681260718114;4911.9754401227765;4948.975255123702;4969.080720066727;5011.824586139468;5819.039858423397;5951.761929522857;5980.13288073227;5980.282366116094;5996.280446346466;5578.553715702653;5803.7678492861505;5832.24180856486;5853.502452291603;5911.615744976562;5889.823305300848;5922.200502932222;5946.048632218824;5963.463288304073;5969.224000879858;5528.391876893458;5713.028785106625;5720.3421606515785;5728.398518155534;5742.052561327334;5644.2380278663495;5681.488666020078;5687.71561421919;5691.686957217393;5693.5160511357;5653.773849045992;5696.772129114955;5707.6575405475805;5739.62692424991;5762.567807414544;5563.443655634404;5570.136628822539;5614.382417933943;5634.802781902614;5646.096624540054;5361.705106219196;5488.204210389391;5507.614466987433;5511.862203444946;5553.333599968029;5606.635568688022;5638.520725738194;5643.3792282848035;5663.518600918968;5670.064439367623;5397;5488.17677348401;5514.531264842373;5525.475079867406;5526.585506086979 08:27:54 INFO - PROCESS | 8636 | |1;ext.html;501.48096719894914;528.6246764796994;528.7646997086296;543.3154225675647;556.7105105345222;28175.29561760957;35672.10819729505;35767.64232357676;36052.99999999996;36178.81910590443;38401.231975360475;38893.22213555727;38910;38914.416283755694;39053.609463905355;8322.916770832306;8459.238668519833;8484;8496.490210587353;8520.062793092755;8153;8343.249107580317;8344.123866993968;8352.791180220482;8448.028476725163;8492.278156356686;8566.742997710047;8590.269827064707;8600.053994060649;8617.913820861806;8465.449745766537;8517.701880434217;8525.74422767318;8541.231289183972;8544.017437994586;8559;8672.219500244944;8675.305975521944;8685.261752751023;8687.261582765472;39832;40399;40406.19187616231;40441.39337909904;40452.39321410152;3361.427814031405;3387.4072037393603;3454.8790792322397;3490.930181396358;3862.7253006507785;29253.41493170146;30012.099637010706;30013.849930750424;30073;30106.84946575275;3935.5867633898315;3995.220931918277;4112.362583799516;4179.498460184767;4198.85304014358;264610.676946616;267156;267321;268097;268555;57315.71342143263;57838.421615784144;58007;58145.418545814;58257.41742582605;61314;61542;61642.383576163666;61660.691696542126;61762.38237617656;14635.487757928422;14723.558293251219;14806.259687015607;14837.961342706123;14843.40626374933;11026.889731102587;11030.779384412428;11098.5560577576;11156.944215278872;11162.107031437465;18973.714900870265;19923.20307187725;20111.597768044558;20120.597588048156;20165.798342016686;7986.281234688906;8500.574971251413;8687.956560217284;8741.650333986696;8807.471551706918;934.243262957007;968.4286271100085;986.5659109991581;1080.006394117414;1113.6492005018392;25614.97750203149;25667.486650267263;26011.73988260131;26250.343741406617;26738.866305668736;1058.1006144777032;1110.5224753355974;1111.111111111124;1148.7300484386162;1159.1885680023847;14259.500917468047;14533.496679347383;14645.48740794067;14736.189509576861;14846.480373186887;362700;368226;369992;370978;371937;53780.731096344265;54297.185542216896;54462;54549.1817622736;54820;1337.9665508362368;1351.5607427586074;1355.545892126129;1355.891528677723;1366.2417358366201;27017;27042.45915081648;27409.451810964067;27515.58726619062;27673.169804905887;43458.56541434672;44311.55688443074;44342.77828610966;44406.3339049908;44557.77721111503;284117;284801;286531;287084;287086;32103.03690889277;33085.17287067843;33218.33563328768;33325.66674333226;33594;42523.3621495684;44063;47164.528354716014;48226;48500.757496212296;33322;33413.33173336568;33847;33869.83065084659;34343;33002.17494562655;33574.49638255379;33891.15272118217;34040.65959340375;34069;33611;38770.22459550737;39727.205455890144;39843;39986.600133999455;27599.371993918827;32332.35335293328;32444;32751.34497310088;33227.335453291285;24808.627870582317;24995.253370107428;25053.624195637443;25124.874375628737;25549.3612659685 08:27:54 INFO - PROCESS | 8636 | |2;jquery.html;363.49655726818366;366.47410965264845;369.0791475269203;370.43323714716496;371.4205838891329;15664.765028524567;16390.34438622455;16883.662326753456;17162.5709357266;17653.117344132774;10415.166786657068;10438.804601367649;15528.922355388235;15657.530274091767;15697;4753.548412900786;5087.49125087492;5440.102383106782;5454.154606036071;5463.453654634544;4170.499540055198;5322.2282768998475;5379.408265090837;5382.946170538303;5389.703566303851;5004.949950500503;5192.740362981855;5198.40218374888;5400.29796126505;5417.485338892819;5047.570956468705;5080.949190508085;5084.872878178056;5110.105731496973;5406.91889621656;5208.7916483341;5209.71346575942;5226.372835259793;5232.3459567554055;5245.737713114368;18151.27394904202;18669.25322987079;19282.80717192824;19324.1304141314;19351.709724354147;1961.9607607847906;1998.8201061904354;2040.7959204079623;2103.400530848701;2113.376553916583;9694.709158725249;10359.637412690596;12167.574134905235;12892.613221603367;13159.86840131596;1805.5666640006305;1821.8360347568782;1826.5433641589602;1886.7452893859427;1906.1327096171208;50433.24350134751;50557.988840223356;55193;56715.149272760944;56787.71606141943;9719.65981190655;10031.648892288735;10086.243531735003;10123.595056197817;10145.442000690033;13038.152520086163;13068.803967940488;13145.34273286351;13156.473741050251;13202.405891734703;7222.638868056576;7274.527155734861;7282.635868206568;7308.196098429168;7348.375388091965;6895.827604309832;6977.476689248225;6993.720251189896;7066.434685225169;7103.964480177566;4188.643965262926;4218.325067989107;4590.6557008223845;4621.5378462154185;4637.6289896808175;1842.7788665360242;1865.309835360925;1943.805619438045;1949.3079956615197;1951.0732402108886;864.8054187807693;926.1016813690709;977.9951100244596;1031.7162780235494;1087.3475914451267;14473.710525789425;15803.841961580467;16291.814981855834;16435.753463698053;17600.911995440198;941.609232168656;947.2564037230878;1016.7915577306634;1017.7862648843677;1028.3675539543126;9332.90667093334;9485.38345007586;9807.117359437685;9891.505424728735;9936.50317484123;561111;561248;575306;582158;590366;72319.10723571104;72778.27221727821;73519.63240183765;74389;75626.62186689032;1202.0924202227263;1207;1207.9698007549882;1220.1885745978825;1221.1757063981777;15262.23688815577;15343.156126413154;15454.845451545341;15506.5348039559;15780.68438631198;33807.4928876072;33980.32039359248;33995.3200935975;34378;34417.82791086029;44975.775121124185;45984.54015459803;46505.302420464395;47452;47628.2855757157;7002.75490357835;7061.470389720689;7109.75115870942;7219.819504512429;7305.050343455317;9896.675405562793;10640.733981650521;11366.147538934447;11461;11718.179727419;9764.951175244363;9782.559784809559;9826.263030272616;9908;9972.354561497272;10073.294869359075;10141.645042423479;10287.43419111956;10370.22223333268;10414;9462.716118516455;10026.997300269915;10082.781788006627;10129.544170512492;10281.640142594973;7465.813354665959;7622.961885190539;7638.923610763822;7656.770296891103;7658.923410766044;9116.4074335168;9480.85778713306;10028.548715307974;10393.9480302598;10413.323133996266 08:27:54 INFO - PROCESS | 8636 | |3;mootools.html;1504.5110339139778;1511.939522419103;1655.9337626494942;1781.180656897827;1786.205138713273;7789.18213587573;7848.803779905491;7967;7967.282944534998;8062.314703250217;8021.7192398265925;8048.114707382183;8050.879236811438;8139.511629302231;8142.267195952363;2358.3396648938237;2358.7523310052457;2372.2764556810166;2376.4415362389823;2386.0455817672896;2396.8801559921935;2398.496315773681;2436.2082323244927;2440.7559244075537;2441.56051910656;2275.101334972685;2354.540864531417;2358.0685629176464;2387.689600351952;2410.517896420714;2374.5607062693284;2381.57131716291;2396.293093537402;2410.0841680161516;2424.442378252994;2414.1067804912295;2445.6453814196843;2446.510697860435;2450.2281781238853;2455.324785683951;7984.481008734414;8041.798955026113;8053.993250843644;8059.838803223961;8060.274575288252;4907.730074845882;5039.546440820343;5043;5052.898942021176;5061.44324124346;3337.215754297738;3346.4478361070637;3379.188994641293;3422.7261819054415;3427.657234276577;1085.5603480590294;1102.3606308341143;1135.1543100390263;1149.1611123879616;1176.8117101263842;10715.892841071567;10829.458527073615;10840.186985976083;10868.836967445495;10874.347539147677;4260.957390426056;4441.933370999438;4475.910481790411;4482.641388688897;4547.15877562652;8784.077671844492;8799.824003520022;8833.160849719266;8836.8674469883;8851.46891186518;4966.6771659842;4985.027919555652;4987.900241995212;5008.424031236382;5015.1975683890405;4554.658400619966;4577.130345234395;4581.289900065495;4600.42494688164;4611.031683346535;3573.714102871764;3591.1560783215923;3638.363286424918;3640.581333146669;3640.7087433005295;1128.638835572609;1132.456420917964;1148.9770204595861;1153.5789436855655;1202.0623913347604;1060.9628662996913;1065.169168048923;1083.7561548651647;1252.874712528758;1376.0436496634743;7296.890546641805;7430.256974302527;7435.367993720486;7458.552486850806;7466.887996680054;1124.4939777100337;1136.6476392318407;1138.6185627814775;1141.4178768827792;1145.7994850901225;5453.64551304164;5623.831285061455;5704.543636509069;5727.026405511073;5729.742161602738;9409.118176364755;9475.810483790285;9775.51122443875;9776.804463910681;9790.118889299998;9530.428174309563;9660.32377733552;9675.661351852652;9691.563879625433;9699;7355.963220183865;7395.482316237919;7520.699172033167;7531.284527969834;7543;7179.892301615584;7272.272772722686;7333.486655934247;7342.8898566520475;7363.263673632594;8214.58927053633;8340.207680270365;8634.827303454022;8642.178992995656;8714.607842647223;8648.870266946127;8797.868031979397;8805.735827925173;8818.07410221943;8892.244159246278;6789.422899053636;6854.691538880862;6868.690908909211;6886.380225779704;6886.586804791728;7541.095068591804;7558;7561.243875612395;7564.50830696003;7595.468317217963;6995.370416662525;7215.783526494213;7362.22696616869;7379.889301660372;7451.254874512505;6932.237453879969;7071.116110486189;7149.249328820399;7178.676959536729;7190.245024272376;7176.856462870818;7262.782116536512;7272.090988626422;7276.090488688914;7301.707931682673;6459.450946669585;6519.608823470607;6543.934560654523;6566.573172743948;6624.271330153583;6586.209654841449;6634.601923884389;6637.1703537057865;6655.933440665532;6675.232348279816 08:27:54 INFO - PROCESS | 8636 | |4;prototype.html;340.2141054164879;342.2316898562727;350.8964855367667;353.05557633330835;354.3886795278147;6143.569950103494;6266.903291923913;6266.968665156668;6324.1462402575635;6344.714487848052;5996.580239383245;6210.223722034746;6228.564000519954;6237.656928868911;6252.437280644741;4818.831340903069;4830.71015739055;4831.903361932759;4832.130216561035;4838.225883858566;4836.395450568679;4838;4840.806367745286;4841.782119804618;4848.442429120643;4718.882027949295;4789.568938795508;4791.47293797682;4793.376861008064;4799.352087468182;4778.211595086841;4789.712617242959;4793.760311984404;4795.784189711454;4803.855884323476;4217.957820421787;4218.388333691628;4224.535301116905;4227.154569086164;4233.745975241495;5923.437273459014;5929.347771745148;5934.673592952386;5956.761729530814;5962.224910761616;5398.676079435247;5560.110382338847;5570.220169176318;5590.440955904418;5611.6352437091455;6575.835604109888;6581.572197807127;6585.242697089848;6593;6600.108985287021;4652.930206046912;4662.067586482717;4662.393888794469;4673.906521869578;4693.507181745902;6775.2208496023095;6921.307869213088;6933;6940.72237110515;6967.198772141218;4780.1873681474235;4787.832425865078;4790.760461976887;4793.880152996203;4808.687435316693;4841.975790121027;4853.223484242504;4853.878653033632;4857.344258525124;4865.440474345425;5540.390557038722;5559.305086864142;5562.110062389998;5566.916496252559;5594.916076258859;6607.4383677386995;6720.126383570105;6724.29394913527;6731.49513786468;6735.29279425663;1653.3056116431128;1689.7211960026457;1694.788151481065;1695.279506209856;1711.7261238201827;1114.6711720042606;1123.7573836623048;1125.8536390269212;1129.4127053932073;1131.3438205840594;6226.159468471698;6239.282482514478;6248.625082495065;6250.937490625127;6259.749610015549;6790.219124800612;6803.081583986099;6809.148856392951;6823.420009299265;6829.93170068293;6067.696615169224;6188.690565471708;6219.315875253718;6219.502439804804;6234.501239900797;3679.5952445231005;3692.335379631692;3694.963050369462;3699.2971335446177;3700.481932529448;6994.125734283215;7034.73374792532;7053.047838541731;7057.964710176417;7058.400035996895;6894.413974812197;6974.093367862146;6978;6987.091678081817;6990.895136572955;7053.259407762111;7114.004039434483;7129.3583577478275;7129.500934934608;7147.2138064812825;6982.860342793218;6984.930150698631;6989.161300643956;6997.1253593300835;6999.8950015750825;6808.080909077211;6850.349216824394;6899.20659124187;6911.965440172767;6960.303969602999;7158.677859496231;7228.63856807168;7245.05814244166;7245.239249878898;7251.927480725125;4697.459792123949;4722.433308003062;4730;4733.242681170997;4739.810407583796;6848.075509806113;6979.581225126509;6987;7008.894866576903;7018.719251229893;6789.388954994074;6810.250872404131;6813;6835.7949261522235;6836.008778727156;6750.3924646782025;6813.739458200249;6813.761518346834;6814.420774234246;6825.215100263533;6541.672916354259;6661.16735408074;6661.700223489857;6673.232578253563;6682.398584127452;6784.7964561063245;6807.761728339485;6813.557118787461;6826.556273842184;6835.692393842389;6598.439132673777;6611.768588099586;6613.437857782143;6616.305287944697;6619.073329733745 08:27:54 INFO - PROCESS | 8636 | |5;yui.html;734.9967294642811;776.157868712447;800.207794283659;814.3484219516555;846.542951361084;13108.868911310885;13180.209187448749;13221.867781322184;13232;13254.668633284173;14663.046901951366;14699.19154446505;14706.779398309034;14713.705725885477;14720.779188312157;809.11402014794;821.9753407397787;837.0833936839182;837.7654256808104;838.3419016072385;827.6441130313963;827.9793005174859;831.9251267385933;835.2691395029349;837.0541288344193;868.4008034456236;869.326272139091;873.2271939333704;874.5364956573027;874.9343799215053;857.8155696525215;862.9913700862974;863.4301361101643;863.5509535041743;863.9697610583631;635.1457289945016;639.5714871036371;642.4699622811199;643.88088203682;644.001797214316;13164.86835131646;13218.00864935124;13229.536966206137;13230.933845330808;13267;12345;12456.31490268035;12612.243265404106;12647.613376997158;12699.746005079938;10504.894951050544;10511.526981285784;10515.78968420635;10531.473426328654;10577;3500.057125542071;3511.5434993450945;3521;3664.047347689593;3674.926501469956;48806.875278096;49262.26106608404;50030.7498462509;50765;52674.736626316626;9560.56977436017;9621.374610650286;9860.506974651238;10253.641122560675;10530.210234232463;16951.745723814154;17253;17348.392806251974;17367.218475168647;17393.739093913602;7454.291842274975;7560.735374261984;7616.3906887448875;7744;7755;4223.218704539609;4225.72532785368;4255.361695745601;4268.253055715238;4336.869893903188;3120.781545291853;3129.0769223079246;3136.6079240094987;3154.3375891062674;3166.60417447819;587.7472686744655;588.835126164666;605.8848818724429;608.2154021312457;619.8388419011;646.7251418147268;650.7375691159231;663.4725393312328;680.1328306409268;689.2452764223168;8005.399595030396;8354.373421993374;8379.832403351898;8404.747857564284;8574.356923230782;612.4793925163665;632.4750457120579;666.1406785247074;674.3349893329671;712.3339677401646;3844.8462061517225;3865.768053916774;3968.265870813851;3978.562358140602;4124.979375103106;49359.0128197434;49513.75243123833;49911.50088499069;55439.445605544235;56282;44944;45034.099318013454;45131.54868451339;45184.54815451869;45790.77104614455;43985.56014439878;44083.338749918774;44529.777351113036;44615.10769784586;44954.775226124315;8609.569521523774;8640.697575584825;8833.29333653319;8867.113288671339;9115.589798458952;30584.235394115327;31453.528197076605;31731.841340793148;31900.042998710076;33542;42270;43103.7844810774;43333.3499997494;43396;43490.78254608833;10442.164626829986;10545.683629491128;10875.238733288594;11165.72085697864;11398.658040258806;12647.683807904876;12747.171433856769;12967.870321296667;13054.08621396493;13356.866431335562;11105.222634415837;11160.609378671708;11167.553297867995;11337.093032557541;11360.602378917029;11870.703232419259;12012.440324082383;12071.456784444545;12521.248725076524;12603.369831508204;10885.782284354427;11235.831462527905;11453.083753299883;11502.194846360675;11713.297202167898;9667.468289243878;9778.217742580719;9803.460809655537;9888.653897113567;10282.845757313497;9047.595265444792;9246.9537652314;9762.170215531476;9936.850947235653;10083.596656133672 08:27:54 INFO - PROCESS | 8636 | __end_tp_report 08:27:54 INFO - PROCESS | 8636 | __start_cc_report 08:27:54 INFO - PROCESS | 8636 | _x_x_mozilla_cycle_collect,304 08:27:54 INFO - PROCESS | 8636 | __end_cc_report 08:27:54 INFO - PROCESS | 8636 | __startTimestamp1453220874180__endTimestamp 08:27:54 INFO - PROCESS | 8636 | 08:27:54 INFO - PROCESS | 8636 | ------- Summary: start ------- 08:27:54 INFO - PROCESS | 8636 | Number of tests: 6 08:27:54 INFO - PROCESS | 8636 | 08:27:54 INFO - PROCESS | 8636 | [#0] dojo.html Cycles:165 Average:5339.95 Median:5525.48 stddev:582.15 (10.5%) stddev-sans-first:558.23 08:27:54 INFO - PROCESS | 8636 | Values: 3159.1 3190.5 3198.1 3236.4 3241.0 5246.9 5272.4 5326.3 5330.4 5362.5 5274.7 5317.3 5377.7 5385.0 5395.1 4914.9 4947.3 4971.4 5010.7 5014.4 4954.6 4956.2 5001.1 5002.1 5010.6 4836.9 4875.4 4882.4 4903.0 4908.3 4894.1 4924.7 4931.6 4935.3 4956.7 4885.8 4902.9 4903.9 4929.6 4949.0 5133.9 5171.4 5215.4 5249.8 5260.9 5761.5 5786.1 5796.7 5797.1 5804.2 5798.6 5807.4 5815.2 5819.5 5834.9 5327.4 5329.0 5386.3 5388.9 5428.4 5860.3 5886.8 5898.9 5909.8 5921.3 5684.5 5718.7 5721.4 5740.1 5745.9 5641.2 5679.9 5705.0 5730.2 5757.6 5630.7 5638.1 5656.2 5675.5 5763.5 5720.5 5730.7 5768.6 5769.8 5776.7 4389.5 4473.5 4478.0 4488.8 4525.4 3942.5 3990.2 4010.9 4020.4 4025.9 5306.7 5325.1 5328.9 5331.0 5336.0 5653.2 5713.5 5715.3 5727.1 5728.5 5203.2 5308.9 5318.0 5321.0 5410.0 4903.7 4912.0 4949.0 4969.1 5011.8 5819.0 5951.8 5980.1 5980.3 5996.3 5578.6 5803.8 5832.2 5853.5 5911.6 5889.8 5922.2 5946.0 5963.5 5969.2 5528.4 5713.0 5720.3 5728.4 5742.1 5644.2 5681.5 5687.7 5691.7 5693.5 5653.8 5696.8 5707.7 5739.6 5762.6 5563.4 5570.1 5614.4 5634.8 5646.1 5361.7 5488.2 5507.6 5511.9 5553.3 5606.6 5638.5 5643.4 5663.5 5670.1 5397.0 5488.2 5514.5 5525.5 5526.6 08:27:54 INFO - PROCESS | 8636 | 08:27:54 INFO - PROCESS | 8636 | [#1] ext.html Cycles:180 Average:47265.09 Median:36115.91 stddev:81439.23 (225.5%) stddev-sans-first:81592.00 08:27:54 INFO - PROCESS | 8636 | Values: 501.5 528.6 528.8 543.3 556.7 28175.3 35672.1 35767.6 36053.0 36178.8 38401.2 38893.2 38910.0 38914.4 39053.6 8322.9 8459.2 8484.0 8496.5 8520.1 8153.0 8343.2 8344.1 8352.8 8448.0 8492.3 8566.7 8590.3 8600.1 8617.9 8465.4 8517.7 8525.7 8541.2 8544.0 8559.0 8672.2 8675.3 8685.3 8687.3 39832.0 40399.0 40406.2 40441.4 40452.4 3361.4 3387.4 3454.9 3490.9 3862.7 29253.4 30012.1 30013.8 30073.0 30106.8 3935.6 3995.2 4112.4 4179.5 4198.9 264610.7 267156.0 267321.0 268097.0 268555.0 57315.7 57838.4 58007.0 58145.4 58257.4 61314.0 61542.0 61642.4 61660.7 61762.4 14635.5 14723.6 14806.3 14838.0 14843.4 11026.9 11030.8 11098.6 11156.9 11162.1 18973.7 19923.2 20111.6 20120.6 20165.8 7986.3 8500.6 8688.0 8741.7 8807.5 934.2 968.4 986.6 1080.0 1113.6 25615.0 25667.5 26011.7 26250.3 26738.9 1058.1 1110.5 1111.1 1148.7 1159.2 14259.5 14533.5 14645.5 14736.2 14846.5 362700.0 368226.0 369992.0 370978.0 371937.0 53780.7 54297.2 54462.0 54549.2 54820.0 1338.0 1351.6 1355.5 1355.9 1366.2 27017.0 27042.5 27409.5 27515.6 27673.2 43458.6 44311.6 44342.8 44406.3 44557.8 284117.0 284801.0 286531.0 287084.0 287086.0 32103.0 33085.2 33218.3 33325.7 33594.0 42523.4 44063.0 47164.5 48226.0 48500.8 33322.0 33413.3 33847.0 33869.8 34343.0 33002.2 33574.5 33891.2 34040.7 34069.0 33611.0 38770.2 39727.2 39843.0 39986.6 27599.4 32332.4 32444.0 32751.3 33227.3 24808.6 24995.3 25053.6 25124.9 25549.4 08:27:54 INFO - PROCESS | 8636 | 08:27:54 INFO - PROCESS | 8636 | [#2] jquery.html Cycles:180 Average:28541.58 Median:4203.48 stddev:93764.67 (2230.6%) stddev-sans-first:94003.83 08:27:54 INFO - PROCESS | 8636 | Values: 363.5 366.5 369.1 370.4 371.4 15664.8 16390.3 16883.7 17162.6 17653.1 10415.2 10438.8 15528.9 15657.5 15697.0 4753.5 5087.5 5440.1 5454.2 5463.5 4170.5 5322.2 5379.4 5382.9 5389.7 5004.9 5192.7 5198.4 5400.3 5417.5 5047.6 5080.9 5084.9 5110.1 5406.9 5208.8 5209.7 5226.4 5232.3 5245.7 18151.3 18669.3 19282.8 19324.1 19351.7 1962.0 1998.8 2040.8 2103.4 2113.4 9694.7 10359.6 12167.6 12892.6 13159.9 1805.6 1821.8 1826.5 1886.7 1906.1 50433.2 50558.0 55193.0 56715.1 56787.7 9719.7 10031.6 10086.2 10123.6 10145.4 13038.2 13068.8 13145.3 13156.5 13202.4 7222.6 7274.5 7282.6 7308.2 7348.4 6895.8 6977.5 6993.7 7066.4 7104.0 4188.6 4218.3 4590.7 4621.5 4637.6 1842.8 1865.3 1943.8 1949.3 1951.1 864.8 926.1 978.0 1031.7 1087.3 14473.7 15803.8 16291.8 16435.8 17600.9 941.6 947.3 1016.8 1017.8 1028.4 9332.9 9485.4 9807.1 9891.5 9936.5 561111.0 561248.0 575306.0 582158.0 590366.0 72319.1 72778.3 73519.6 74389.0 75626.6 1202.1 1207.0 1208.0 1220.2 1221.2 15262.2 15343.2 15454.8 15506.5 15780.7 33807.5 33980.3 33995.3 34378.0 34417.8 44975.8 45984.5 46505.3 47452.0 47628.3 7002.8 7061.5 7109.8 7219.8 7305.1 9896.7 10640.7 11366.1 11461.0 11718.2 9765.0 9782.6 9826.3 9908.0 9972.4 10073.3 10141.6 10287.4 10370.2 10414.0 9462.7 10027.0 10082.8 10129.5 10281.6 7465.8 7623.0 7638.9 7656.8 7658.9 9116.4 9480.9 10028.5 10393.9 10413.3 08:27:54 INFO - PROCESS | 8636 | 08:27:54 INFO - PROCESS | 8636 | [#3] mootools.html Cycles:180 Average:5601.02 Median:6489.53 stddev:2845.70 (43.9%) stddev-sans-first:2837.02 08:27:54 INFO - PROCESS | 8636 | Values: 1504.5 1511.9 1655.9 1781.2 1786.2 7789.2 7848.8 7967.0 7967.3 8062.3 8021.7 8048.1 8050.9 8139.5 8142.3 2358.3 2358.8 2372.3 2376.4 2386.0 2396.9 2398.5 2436.2 2440.8 2441.6 2275.1 2354.5 2358.1 2387.7 2410.5 2374.6 2381.6 2396.3 2410.1 2424.4 2414.1 2445.6 2446.5 2450.2 2455.3 7984.5 8041.8 8054.0 8059.8 8060.3 4907.7 5039.5 5043.0 5052.9 5061.4 3337.2 3346.4 3379.2 3422.7 3427.7 1085.6 1102.4 1135.2 1149.2 1176.8 10715.9 10829.5 10840.2 10868.8 10874.3 4261.0 4441.9 4475.9 4482.6 4547.2 8784.1 8799.8 8833.2 8836.9 8851.5 4966.7 4985.0 4987.9 5008.4 5015.2 4554.7 4577.1 4581.3 4600.4 4611.0 3573.7 3591.2 3638.4 3640.6 3640.7 1128.6 1132.5 1149.0 1153.6 1202.1 1061.0 1065.2 1083.8 1252.9 1376.0 7296.9 7430.3 7435.4 7458.6 7466.9 1124.5 1136.6 1138.6 1141.4 1145.8 5453.6 5623.8 5704.5 5727.0 5729.7 9409.1 9475.8 9775.5 9776.8 9790.1 9530.4 9660.3 9675.7 9691.6 9699.0 7356.0 7395.5 7520.7 7531.3 7543.0 7179.9 7272.3 7333.5 7342.9 7363.3 8214.6 8340.2 8634.8 8642.2 8714.6 8648.9 8797.9 8805.7 8818.1 8892.2 6789.4 6854.7 6868.7 6886.4 6886.6 7541.1 7558.0 7561.2 7564.5 7595.5 6995.4 7215.8 7362.2 7379.9 7451.3 6932.2 7071.1 7149.2 7178.7 7190.2 7176.9 7262.8 7272.1 7276.1 7301.7 6459.5 6519.6 6543.9 6566.6 6624.3 6586.2 6634.6 6637.2 6655.9 6675.2 08:27:54 INFO - PROCESS | 8636 | 08:27:54 INFO - PROCESS | 8636 | [#4] prototype.html Cycles:180 Average:5588.60 Median:6238.47 stddev:1685.47 (27.0%) stddev-sans-first:1643.52 08:27:54 INFO - PROCESS | 8636 | Values: 340.2 342.2 350.9 353.1 354.4 6143.6 6266.9 6267.0 6324.1 6344.7 5996.6 6210.2 6228.6 6237.7 6252.4 4818.8 4830.7 4831.9 4832.1 4838.2 4836.4 4838.0 4840.8 4841.8 4848.4 4718.9 4789.6 4791.5 4793.4 4799.4 4778.2 4789.7 4793.8 4795.8 4803.9 4218.0 4218.4 4224.5 4227.2 4233.7 5923.4 5929.3 5934.7 5956.8 5962.2 5398.7 5560.1 5570.2 5590.4 5611.6 6575.8 6581.6 6585.2 6593.0 6600.1 4652.9 4662.1 4662.4 4673.9 4693.5 6775.2 6921.3 6933.0 6940.7 6967.2 4780.2 4787.8 4790.8 4793.9 4808.7 4842.0 4853.2 4853.9 4857.3 4865.4 5540.4 5559.3 5562.1 5566.9 5594.9 6607.4 6720.1 6724.3 6731.5 6735.3 1653.3 1689.7 1694.8 1695.3 1711.7 1114.7 1123.8 1125.9 1129.4 1131.3 6226.2 6239.3 6248.6 6250.9 6259.7 6790.2 6803.1 6809.1 6823.4 6829.9 6067.7 6188.7 6219.3 6219.5 6234.5 3679.6 3692.3 3695.0 3699.3 3700.5 6994.1 7034.7 7053.0 7058.0 7058.4 6894.4 6974.1 6978.0 6987.1 6990.9 7053.3 7114.0 7129.4 7129.5 7147.2 6982.9 6984.9 6989.2 6997.1 6999.9 6808.1 6850.3 6899.2 6912.0 6960.3 7158.7 7228.6 7245.1 7245.2 7251.9 4697.5 4722.4 4730.0 4733.2 4739.8 6848.1 6979.6 6987.0 7008.9 7018.7 6789.4 6810.3 6813.0 6835.8 6836.0 6750.4 6813.7 6813.8 6814.4 6825.2 6541.7 6661.2 6661.7 6673.2 6682.4 6784.8 6807.8 6813.6 6826.6 6835.7 6598.4 6611.8 6613.4 6616.3 6619.1 08:27:54 INFO - PROCESS | 8636 | 08:27:54 INFO - PROCESS | 8636 | [#5] yui.html Cycles:180 Average:13418.53 Median:44306.56 stddev:14993.21 (33.8%) stddev-sans-first:15005.02 08:27:54 INFO - PROCESS | 8636 | Values: 735.0 776.2 800.2 814.3 846.5 13108.9 13180.2 13221.9 13232.0 13254.7 14663.0 14699.2 14706.8 14713.7 14720.8 809.1 822.0 837.1 837.8 838.3 827.6 828.0 831.9 835.3 837.1 868.4 869.3 873.2 874.5 874.9 857.8 863.0 863.4 863.6 864.0 635.1 639.6 642.5 643.9 644.0 13164.9 13218.0 13229.5 13230.9 13267.0 12345.0 12456.3 12612.2 12647.6 12699.7 10504.9 10511.5 10515.8 10531.5 10577.0 3500.1 3511.5 3521.0 3664.0 3674.9 48806.9 49262.3 50030.7 50765.0 52674.7 9560.6 9621.4 9860.5 10253.6 10530.2 16951.7 17253.0 17348.4 17367.2 17393.7 7454.3 7560.7 7616.4 7744.0 7755.0 4223.2 4225.7 4255.4 4268.3 4336.9 3120.8 3129.1 3136.6 3154.3 3166.6 587.7 588.8 605.9 608.2 619.8 646.7 650.7 663.5 680.1 689.2 8005.4 8354.4 8379.8 8404.7 8574.4 612.5 632.5 666.1 674.3 712.3 3844.8 3865.8 3968.3 3978.6 4125.0 49359.0 49513.8 49911.5 55439.4 56282.0 44944.0 45034.1 45131.5 45184.5 45790.8 43985.6 44083.3 44529.8 44615.1 44954.8 8609.6 8640.7 8833.3 8867.1 9115.6 30584.2 31453.5 31731.8 31900.0 33542.0 42270.0 43103.8 43333.3 43396.0 43490.8 10442.2 10545.7 10875.2 11165.7 11398.7 12647.7 12747.2 12967.9 13054.1 13356.9 11105.2 11160.6 11167.6 11337.1 11360.6 11870.7 12012.4 12071.5 12521.2 12603.4 10885.8 11235.8 11453.1 11502.2 11713.3 9667.5 9778.2 9803.5 9888.7 10282.8 9047.6 9247.0 9762.2 9936.9 10083.6 08:27:54 INFO - PROCESS | 8636 | -------- Summary: end -------- 08:27:54 INFO - PROCESS | 8636 | 08:27:54 INFO - TEST-INFO | 8636: exit 0 08:27:54 INFO - TEST-OK | dromaeo_css | took 1110263ms 08:27:54 INFO - TEST-START | kraken 08:27:54 INFO - operating with platform_type : linux_ 08:27:54 INFO - Initialising browser for kraken test... 08:27:54 INFO - TEST-INFO | started process 8883 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLUfV8n/profile http://localhost:36241/getInfo.html) 08:27:58 INFO - PROCESS | 8883 | 08:27:58 INFO - PROCESS | 8883 | (process:8955): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:27:59 INFO - PROCESS | 8883 | __metrics Screen width/height:1600/1200 08:27:59 INFO - PROCESS | 8883 | colorDepth:24 08:27:59 INFO - PROCESS | 8883 | Browser inner width/height: 1024/697 08:27:59 INFO - PROCESS | 8883 | __metrics 08:27:59 INFO - PROCESS | 8883 | 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:28:00 INFO - TEST-INFO | 8883: exit 0 08:28:00 INFO - Browser initialized. 08:28:00 INFO - Running cycle 1/1 for kraken test... 08:28:00 INFO - TEST-INFO | started process 9003 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLUfV8n/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:00 INFO - PROCESS | 9003 | -- checkerboarding starts below -- 08:28:00 INFO - PROCESS | 9003 | RENDERTRACE 0.060069 rect red 0 0 10 10 // viewport 08:28:00 INFO - PROCESS | 9003 | RENDERTRACE 42.7615 rect brown 0 0 10 10 // page 08:28:00 INFO - PROCESS | 9003 | RENDERTRACE 42.8022 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 08:28:00 INFO - PROCESS | 9003 | Checkerboarded for 1 frames (42.8972 ms), 100 peak, 1 severity. 08:28:01 INFO - PROCESS | 9003 | 08:28:01 INFO - PROCESS | 9003 | (process:9059): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:28:12 INFO - PROCESS | 9003 | RSS: Main: 150294528 08:28:12 INFO - PROCESS | 9003 | 08:28:14 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36241/tests/kraken/driver.html?testName=audio-beat-detection) 08:28:15 INFO - PROCESS | 9003 | RSS: Main: 150695936 08:28:15 INFO - PROCESS | 9003 | 08:28:17 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36241/tests/kraken/driver.html?testName=audio-dft) 08:28:18 INFO - PROCESS | 9003 | RSS: Main: 154533888 08:28:18 INFO - PROCESS | 9003 | 08:28:21 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36241/tests/kraken/driver.html?testName=audio-fft) 08:28:21 INFO - PROCESS | 9003 | RSS: Main: 146706432 08:28:21 INFO - PROCESS | 9003 | 08:28:23 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36241/tests/kraken/driver.html?testName=audio-oscillator) 08:28:24 INFO - PROCESS | 9003 | RSS: Main: 148082688 08:28:24 INFO - PROCESS | 9003 | 08:28:26 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:28:27 INFO - PROCESS | 9003 | RSS: Main: 148078592 08:28:27 INFO - PROCESS | 9003 | 08:28:30 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36241/tests/kraken/driver.html?testName=imaging-darkroom) 08:28:30 INFO - PROCESS | 9003 | RSS: Main: 147394560 08:28:30 INFO - PROCESS | 9003 | 08:28:34 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36241/tests/kraken/driver.html?testName=imaging-desaturate) 08:28:34 INFO - PROCESS | 9003 | RSS: Main: 146690048 08:28:34 INFO - PROCESS | 9003 | 08:28:37 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36241/tests/kraken/driver.html?testName=json-parse-financial) 08:28:38 INFO - PROCESS | 9003 | RSS: Main: 150102016 08:28:38 INFO - PROCESS | 9003 | 08:28:39 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:28:40 INFO - PROCESS | 9003 | RSS: Main: 150446080 08:28:40 INFO - PROCESS | 9003 | 08:28:42 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36241/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:28:42 INFO - PROCESS | 9003 | RSS: Main: 151347200 08:28:42 INFO - PROCESS | 9003 | 08:28:44 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:45 INFO - PROCESS | 9003 | RSS: Main: 151519232 08:28:45 INFO - PROCESS | 9003 | 08:28:47 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:28:48 INFO - PROCESS | 9003 | RSS: Main: 149659648 08:28:48 INFO - PROCESS | 9003 | 08:28:51 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:28:51 INFO - PROCESS | 9003 | RSS: Main: 150548480 08:28:51 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | Cycle 1(1): loaded http://localhost:36241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36241/tests/kraken/driver.html?testName=ai-astar) 08:28:53 INFO - PROCESS | 9003 | RSS: Main: 151539712 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | __start_tp_report 08:28:53 INFO - PROCESS | 9003 | _x_x_mozilla_page_load 08:28:53 INFO - PROCESS | 9003 | _x_x_mozilla_page_load_details 08:28:53 INFO - PROCESS | 9003 | |i|pagename|runs| 08:28:53 INFO - PROCESS | 9003 | |0;ai-astar;113;106;112;112;112;122;112;111;111;113 08:28:53 INFO - PROCESS | 9003 | |1;audio-beat-detection;146;126;151;166;130;156;153;135;161;128 08:28:53 INFO - PROCESS | 9003 | |2;audio-dft;163;161;164;162;160;162;169;169;165;162 08:28:53 INFO - PROCESS | 9003 | |3;audio-fft;76;72;71;74;73;151;72;75;73;74 08:28:53 INFO - PROCESS | 9003 | |4;audio-oscillator;96;97;155;102;96;96;142;95;96;137 08:28:53 INFO - PROCESS | 9003 | |5;imaging-gaussian-blur;109;110;110;110;110;111;110;110;110;111 08:28:53 INFO - PROCESS | 9003 | |6;imaging-darkroom;148;147;148;148;148;147;147;147;148;147 08:28:53 INFO - PROCESS | 9003 | |7;imaging-desaturate;97;97;96;96;97;98;96;95;96;96 08:28:53 INFO - PROCESS | 9003 | |8;json-parse-financial;61;62;60;59;60;62;60;61;69;58 08:28:53 INFO - PROCESS | 9003 | |9;json-stringify-tinderbox;68;67;70;69;70;69;68;70;71;69 08:28:53 INFO - PROCESS | 9003 | |10;stanford-crypto-aes;81;81;83;84;83;84;83;82;84;83 08:28:53 INFO - PROCESS | 9003 | |11;stanford-crypto-ccm;127;122;135;121;120;132;117;141;132;117 08:28:53 INFO - PROCESS | 9003 | |12;stanford-crypto-pbkdf2;131;144;143;145;150;151;147;135;142;132 08:28:53 INFO - PROCESS | 9003 | |13;stanford-crypto-sha256-iterative;74;68;65;70;66;67;65;69;65;70 08:28:53 INFO - PROCESS | 9003 | __end_tp_report 08:28:53 INFO - PROCESS | 9003 | __start_cc_report 08:28:53 INFO - PROCESS | 9003 | _x_x_mozilla_cycle_collect,744 08:28:53 INFO - PROCESS | 9003 | __end_cc_report 08:28:53 INFO - PROCESS | 9003 | __startTimestamp1453220933551__endTimestamp 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | ------- Summary: start ------- 08:28:53 INFO - PROCESS | 9003 | Number of tests: 14 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:3.92 (3.5%) stddev-sans-first:4.15 08:28:53 INFO - PROCESS | 9003 | Values: 113.0 106.0 112.0 112.0 112.0 122.0 112.0 111.0 111.0 113.0 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:152.00 stddev:14.51 (9.5%) stddev-sans-first:15.38 08:28:53 INFO - PROCESS | 9003 | Values: 146.0 126.0 151.0 166.0 130.0 156.0 153.0 135.0 161.0 128.0 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:3.13 (1.9%) stddev-sans-first:3.31 08:28:53 INFO - PROCESS | 9003 | Values: 163.0 161.0 164.0 162.0 160.0 162.0 169.0 169.0 165.0 162.0 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#3] audio-fft Cycles:10 Average:81.10 Median:73.50 stddev:24.61 (33.5%) stddev-sans-first:26.03 08:28:53 INFO - PROCESS | 9003 | Values: 76.0 72.0 71.0 74.0 73.0 151.0 72.0 75.0 73.0 74.0 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:96.00 stddev:23.58 (24.6%) stddev-sans-first:24.36 08:28:53 INFO - PROCESS | 9003 | Values: 96.0 97.0 155.0 102.0 96.0 96.0 142.0 95.0 96.0 137.0 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 08:28:53 INFO - PROCESS | 9003 | Values: 109.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 111.0 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:28:53 INFO - PROCESS | 9003 | Values: 148.0 147.0 148.0 148.0 148.0 147.0 147.0 147.0 148.0 147.0 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 08:28:53 INFO - PROCESS | 9003 | Values: 97.0 97.0 96.0 96.0 97.0 98.0 96.0 95.0 96.0 96.0 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:61.00 stddev:3.01 (4.9%) stddev-sans-first:3.19 08:28:53 INFO - PROCESS | 9003 | Values: 61.0 62.0 60.0 59.0 60.0 62.0 60.0 61.0 69.0 58.0 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.50 stddev:1.20 (1.7%) stddev-sans-first:1.20 08:28:53 INFO - PROCESS | 9003 | Values: 68.0 67.0 70.0 69.0 70.0 69.0 68.0 70.0 71.0 69.0 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.14 (1.4%) stddev-sans-first:1.00 08:28:53 INFO - PROCESS | 9003 | Values: 81.0 81.0 83.0 84.0 83.0 84.0 83.0 82.0 84.0 83.0 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:129.50 stddev:8.28 (6.4%) stddev-sans-first:8.77 08:28:53 INFO - PROCESS | 9003 | Values: 127.0 122.0 135.0 121.0 120.0 132.0 117.0 141.0 132.0 117.0 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:144.50 stddev:7.10 (4.9%) stddev-sans-first:6.32 08:28:53 INFO - PROCESS | 9003 | Values: 131.0 144.0 143.0 145.0 150.0 151.0 147.0 135.0 142.0 132.0 08:28:53 INFO - PROCESS | 9003 | 08:28:53 INFO - PROCESS | 9003 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:2.92 (4.3%) stddev-sans-first:2.11 08:28:53 INFO - PROCESS | 9003 | Values: 74.0 68.0 65.0 70.0 66.0 67.0 65.0 69.0 65.0 70.0 08:28:53 INFO - PROCESS | 9003 | -------- Summary: end -------- 08:28:53 INFO - PROCESS | 9003 | 08:28:54 INFO - TEST-INFO | 9003: exit 0 08:28:54 INFO - TEST-OK | kraken | took 59611ms 08:28:54 INFO - TEST-START | v8_7 08:28:54 INFO - operating with platform_type : linux_ 08:28:54 INFO - Initialising browser for v8_7 test... 08:28:54 INFO - TEST-INFO | started process 9286 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7DcSoH/profile http://localhost:36241/getInfo.html) 08:28:57 INFO - PROCESS | 9286 | -- checkerboarding starts below -- 08:28:57 INFO - PROCESS | 9286 | RENDERTRACE 0.042198 rect red 0 0 1024 768 // viewport 08:28:57 INFO - PROCESS | 9286 | RENDERTRACE 9.89192 rect brown 0 0 1024 768 // page 08:28:57 INFO - PROCESS | 9286 | RENDERTRACE 9.91029 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 08:28:57 INFO - PROCESS | 9286 | Checkerboarded for 1 frames (15.9598 ms), 786432 peak, 10713 severity. 08:28:57 INFO - PROCESS | 9286 | 08:28:57 INFO - PROCESS | 9286 | (process:9356): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:28:58 INFO - PROCESS | 9286 | __metrics Screen width/height:1600/1200 08:28:58 INFO - PROCESS | 9286 | colorDepth:24 08:28:58 INFO - PROCESS | 9286 | Browser inner width/height: 1024/697 08:28:58 INFO - PROCESS | 9286 | __metrics 08:28:58 INFO - PROCESS | 9286 | 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:28:59 INFO - TEST-INFO | 9286: exit 0 08:28:59 INFO - Browser initialized. 08:28:59 INFO - Running cycle 1/1 for v8_7 test... 08:28:59 INFO - TEST-INFO | started process 9404 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7DcSoH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:00 INFO - PROCESS | 9404 | -- checkerboarding starts below -- 08:29:00 INFO - PROCESS | 9404 | RENDERTRACE 0.097113 rect red 0 0 10 10 // viewport 08:29:00 INFO - PROCESS | 9404 | RENDERTRACE 8.75635 rect brown 0 0 10 10 // page 08:29:00 INFO - PROCESS | 9404 | RENDERTRACE 8.77635 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 08:29:00 INFO - PROCESS | 9404 | Checkerboarded for 1 frames (8.8683 ms), 100 peak, 2 severity. 08:29:00 INFO - PROCESS | 9404 | 08:29:00 INFO - PROCESS | 9404 | (process:9461): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:29:11 INFO - PROCESS | 9404 | RSS: Main: 150384640 08:29:11 INFO - PROCESS | 9404 | 08:29:33 INFO - PROCESS | 9404 | Cycle 1(1): loaded http://localhost:36241/tests/v8_7/run.html (next: http://localhost:36241/tests/v8_7/run.html) 08:29:34 INFO - PROCESS | 9404 | RSS: Main: 146767872 08:29:34 INFO - PROCESS | 9404 | 08:29:34 INFO - PROCESS | 9404 | __start_tp_report 08:29:34 INFO - PROCESS | 9404 | _x_x_mozilla_page_load 08:29:34 INFO - PROCESS | 9404 | _x_x_mozilla_page_load_details 08:29:34 INFO - PROCESS | 9404 | |i|pagename|runs| 08:29:34 INFO - PROCESS | 9404 | |0;Richards;166.72224074691565 08:29:34 INFO - PROCESS | 9404 | |1;DeltaBlue;188.25301204819277 08:29:34 INFO - PROCESS | 9404 | |2;Encrypt;279.3296089385475 08:29:34 INFO - PROCESS | 9404 | |3;Decrypt;5263.1578947368425 08:29:34 INFO - PROCESS | 9404 | |4;RayTrace;1062.6992561105208 08:29:34 INFO - PROCESS | 9404 | |5;Earley;730.4601899196493 08:29:34 INFO - PROCESS | 9404 | |6;Boyer;12662.5 08:29:34 INFO - PROCESS | 9404 | |7;RegExp;41265.30612244898 08:29:34 INFO - PROCESS | 9404 | |8;Splay;659.1957811470006 08:29:34 INFO - PROCESS | 9404 | |9;NavierStokes;4840.579710144928 08:29:34 INFO - PROCESS | 9404 | __end_tp_report 08:29:34 INFO - PROCESS | 9404 | __startTimestamp1453220974127__endTimestamp 08:29:34 INFO - PROCESS | 9404 | 08:29:34 INFO - PROCESS | 9404 | ------- Summary: start ------- 08:29:34 INFO - PROCESS | 9404 | Number of tests: 10 08:29:34 INFO - PROCESS | 9404 | 08:29:34 INFO - PROCESS | 9404 | [#0] Richards Cycles:1 Average:166.72 Median:166.72 stddev:0.00 (0.0%) 08:29:34 INFO - PROCESS | 9404 | Values: 166.7 08:29:34 INFO - PROCESS | 9404 | 08:29:34 INFO - PROCESS | 9404 | [#1] DeltaBlue Cycles:1 Average:188.25 Median:188.25 stddev:0.00 (0.0%) 08:29:34 INFO - PROCESS | 9404 | Values: 188.3 08:29:34 INFO - PROCESS | 9404 | 08:29:34 INFO - PROCESS | 9404 | [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 08:29:34 INFO - PROCESS | 9404 | Values: 279.3 08:29:34 INFO - PROCESS | 9404 | 08:29:34 INFO - PROCESS | 9404 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 08:29:34 INFO - PROCESS | 9404 | Values: 5263.2 08:29:34 INFO - PROCESS | 9404 | 08:29:34 INFO - PROCESS | 9404 | [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 08:29:34 INFO - PROCESS | 9404 | Values: 1062.7 08:29:34 INFO - PROCESS | 9404 | 08:29:34 INFO - PROCESS | 9404 | [#5] Earley Cycles:1 Average:730.46 Median:730.46 stddev:0.00 (0.0%) 08:29:34 INFO - PROCESS | 9404 | Values: 730.5 08:29:34 INFO - PROCESS | 9404 | 08:29:34 INFO - PROCESS | 9404 | [#6] Boyer Cycles:1 Average:12662.50 Median:12662.50 stddev:0.00 (0.0%) 08:29:34 INFO - PROCESS | 9404 | Values: 12662.5 08:29:34 INFO - PROCESS | 9404 | 08:29:34 INFO - PROCESS | 9404 | [#7] RegExp Cycles:1 Average:41265.31 Median:41265.31 stddev:0.00 (0.0%) 08:29:34 INFO - PROCESS | 9404 | Values: 41265.3 08:29:34 INFO - PROCESS | 9404 | 08:29:34 INFO - PROCESS | 9404 | [#8] Splay Cycles:1 Average:659.20 Median:659.20 stddev:0.00 (0.0%) 08:29:34 INFO - PROCESS | 9404 | Values: 659.2 08:29:34 INFO - PROCESS | 9404 | 08:29:34 INFO - PROCESS | 9404 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 08:29:34 INFO - PROCESS | 9404 | Values: 4840.6 08:29:34 INFO - PROCESS | 9404 | -------- Summary: end -------- 08:29:34 INFO - PROCESS | 9404 | 08:29:34 INFO - TEST-INFO | 9404: exit 0 08:29:35 INFO - TEST-OK | v8_7 | took 40569ms 08:29:35 INFO - SUITE-END | took 1210s 08:29:35 INFO - Completed test suite (00:20:10) 08:29:35 INFO - Working with test: dromaeo_css 08:29:35 INFO - Generating results file: dromaeo_css 08:29:35 INFO - Working with test: kraken 08:29:35 INFO - Generating results file: kraken 08:29:35 INFO - javascript benchmark 08:29:35 INFO - Working with test: v8_7 08:29:35 INFO - Generating results file: v8_7 08:29:35 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 08:29:35 INFO - process_Request line: dromaeo_css 7005.65 graph.html#tests=[[72,64,43]] 08:29:35 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:35 INFO - process_Request line: kraken 1517.00 graph.html#tests=[[232,64,43]] 08:29:35 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:29:35 INFO - process_Request line: v8_7 20069.03 graph.html#tests=[[230,64,43]] 08:29:35 INFO - RETURN: dromaeo_css: 7005.65 08:29:35 INFO - RETURN: kraken: 1517.00 08:29:35 INFO - RETURN: v8_7: 20069.03 08:29:35 INFO - javascript benchmark 08:29:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3159.1470303018177, 3190.505471651892, 3198.104530731396, 3236.4336241157794, 3240.995291459647, 5246.868828279295, 5272.446393128719, 5326.3075800145925, 5330.3603567571845, 5362.544183744381, 5274.709890955995, 5317.255584218203, 5377.731113444322, 5385.0, 5395.109806881869, 4914.877128071809, 4947.307376967227, 4971.37857767779, 5010.6993580385115, 5014.423341315741, 4954.578860796819, 4956.2070068789, 5001.074801161779, 5002.12462819007, 5010.599152067826, 4836.854894353175, 4875.366202393684, 4882.414110306786, 4902.975485122552, 4908.3128362029165, 4894.094592500399, 4924.729139897304, 4931.605471562267, 4935.2843837643695, 4956.702597844105, 4885.828995985124, 4902.901941961177, 4903.8528844134735, 4929.556339929388, 4948.975255123737, 5133.922991155136, 5171.3535808024, 5215.426303106655, 5249.816256431007, 5260.894782104375, 5761.510271626917, 5786.07422812348, 5796.710164491801, 5797.130430435468, 5804.216430781833, 5798.623089499169, 5807.390224026459, 5815.156802263648, 5819.505342045931, 5834.912476312858, 5327.38735045467, 5329.0, 5386.272853164812, 5388.865278368072, 5428.4028756836715, 5860.267466566679, 5886.793962211302, 5898.911516327258, 5909.763609455574, 5921.289445266596, 5684.516816070598, 5718.714064296769, 5721.370649228582, 5740.0815869460685, 5745.9425405745405, 5641.182028605829, 5679.886402271932, 5704.971475142598, 5730.169125476783, 5757.596968212269, 5630.71846407678, 5638.097904335286, 5656.236408084856, 5675.5459563234845, 5763.510101641324, 5720.48515633595, 5730.656160630292, 5768.567357448124, 5769.826905192851, 5776.653400795965, 4389.473263208435, 4473.483545893531, 4478.037221997286, 4488.798004089824, 4525.411696479502, 3942.5268967724055, 3990.1620659661794, 4010.8997275067773, 4020.4170395292517, 4025.8993525162105, 5306.6550674206055, 5325.121354976463, 5328.866778330573, 5331.0, 5335.973320133375, 5653.208550802891, 5713.485786279171, 5715.257016587817, 5727.140928860705, 5728.541716662657, 5203.19350500673, 5308.946910530923, 5317.973410133002, 5321.0, 5410.026195284887, 4903.681260718114, 4911.9754401227765, 4948.975255123702, 4969.080720066727, 5011.824586139468, 5819.039858423397, 5951.761929522857, 5980.13288073227, 5980.282366116094, 5996.280446346466, 5578.553715702653, 5803.7678492861505, 5832.24180856486, 5853.502452291603, 5911.615744976562, 5889.823305300848, 5922.200502932222, 5946.048632218824, 5963.463288304073, 5969.224000879858, 5528.391876893458, 5713.028785106625, 5720.3421606515785, 5728.398518155534, 5742.052561327334, 5644.2380278663495, 5681.488666020078, 5687.71561421919, 5691.686957217393, 5693.5160511357, 5653.773849045992, 5696.772129114955, 5707.6575405475805, 5739.62692424991, 5762.567807414544, 5563.443655634404, 5570.136628822539, 5614.382417933943, 5634.802781902614, 5646.096624540054, 5361.705106219196, 5488.204210389391, 5507.614466987433, 5511.862203444946, 5553.333599968029, 5606.635568688022, 5638.520725738194, 5643.3792282848035, 5663.518600918968, 5670.064439367623, 5397.0, 5488.17677348401, 5514.531264842373, 5525.475079867406, 5526.585506086979], "unit": "score", "name": "dojo.html", "value": 5302.721089110601}, {"lowerIsBetter": false, "replicates": [501.48096719894914, 528.6246764796994, 528.7646997086296, 543.3154225675647, 556.7105105345222, 28175.29561760957, 35672.10819729505, 35767.64232357676, 36052.99999999996, 36178.81910590443, 38401.231975360475, 38893.22213555727, 38910.0, 38914.416283755694, 39053.609463905355, 8322.916770832306, 8459.238668519833, 8484.0, 8496.490210587353, 8520.062793092755, 8153.0, 8343.249107580317, 8344.123866993968, 8352.791180220482, 8448.028476725163, 8492.278156356686, 8566.742997710047, 8590.269827064707, 8600.053994060649, 8617.913820861806, 8465.449745766537, 8517.701880434217, 8525.74422767318, 8541.231289183972, 8544.017437994586, 8559.0, 8672.219500244944, 8675.305975521944, 8685.261752751023, 8687.261582765472, 39832.0, 40399.0, 40406.19187616231, 40441.39337909904, 40452.39321410152, 3361.427814031405, 3387.4072037393603, 3454.8790792322397, 3490.930181396358, 3862.7253006507785, 29253.41493170146, 30012.099637010706, 30013.849930750424, 30073.0, 30106.84946575275, 3935.5867633898315, 3995.220931918277, 4112.362583799516, 4179.498460184767, 4198.85304014358, 264610.676946616, 267156.0, 267321.0, 268097.0, 268555.0, 57315.71342143263, 57838.421615784144, 58007.0, 58145.418545814, 58257.41742582605, 61314.0, 61542.0, 61642.383576163666, 61660.691696542126, 61762.38237617656, 14635.487757928422, 14723.558293251219, 14806.259687015607, 14837.961342706123, 14843.40626374933, 11026.889731102587, 11030.779384412428, 11098.5560577576, 11156.944215278872, 11162.107031437465, 18973.714900870265, 19923.20307187725, 20111.597768044558, 20120.597588048156, 20165.798342016686, 7986.281234688906, 8500.574971251413, 8687.956560217284, 8741.650333986696, 8807.471551706918, 934.243262957007, 968.4286271100085, 986.5659109991581, 1080.006394117414, 1113.6492005018392, 25614.97750203149, 25667.486650267263, 26011.73988260131, 26250.343741406617, 26738.866305668736, 1058.1006144777032, 1110.5224753355974, 1111.111111111124, 1148.7300484386162, 1159.1885680023847, 14259.500917468047, 14533.496679347383, 14645.48740794067, 14736.189509576861, 14846.480373186887, 362700.0, 368226.0, 369992.0, 370978.0, 371937.0, 53780.731096344265, 54297.185542216896, 54462.0, 54549.1817622736, 54820.0, 1337.9665508362368, 1351.5607427586074, 1355.545892126129, 1355.891528677723, 1366.2417358366201, 27017.0, 27042.45915081648, 27409.451810964067, 27515.58726619062, 27673.169804905887, 43458.56541434672, 44311.55688443074, 44342.77828610966, 44406.3339049908, 44557.77721111503, 284117.0, 284801.0, 286531.0, 287084.0, 287086.0, 32103.03690889277, 33085.17287067843, 33218.33563328768, 33325.66674333226, 33594.0, 42523.3621495684, 44063.0, 47164.528354716014, 48226.0, 48500.757496212296, 33322.0, 33413.33173336568, 33847.0, 33869.83065084659, 34343.0, 33002.17494562655, 33574.49638255379, 33891.15272118217, 34040.65959340375, 34069.0, 33611.0, 38770.22459550737, 39727.205455890144, 39843.0, 39986.600133999455, 27599.371993918827, 32332.35335293328, 32444.0, 32751.34497310088, 33227.335453291285, 24808.627870582317, 24995.253370107428, 25053.624195637443, 25124.874375628737, 25549.3612659685], "unit": "score", "name": "ext.html", "value": 18353.83788265903}, {"lowerIsBetter": false, "replicates": [363.49655726818366, 366.47410965264845, 369.0791475269203, 370.43323714716496, 371.4205838891329, 15664.765028524567, 16390.34438622455, 16883.662326753456, 17162.5709357266, 17653.117344132774, 10415.166786657068, 10438.804601367649, 15528.922355388235, 15657.530274091767, 15697.0, 4753.548412900786, 5087.49125087492, 5440.102383106782, 5454.154606036071, 5463.453654634544, 4170.499540055198, 5322.2282768998475, 5379.408265090837, 5382.946170538303, 5389.703566303851, 5004.949950500503, 5192.740362981855, 5198.40218374888, 5400.29796126505, 5417.485338892819, 5047.570956468705, 5080.949190508085, 5084.872878178056, 5110.105731496973, 5406.91889621656, 5208.7916483341, 5209.71346575942, 5226.372835259793, 5232.3459567554055, 5245.737713114368, 18151.27394904202, 18669.25322987079, 19282.80717192824, 19324.1304141314, 19351.709724354147, 1961.9607607847906, 1998.8201061904354, 2040.7959204079623, 2103.400530848701, 2113.376553916583, 9694.709158725249, 10359.637412690596, 12167.574134905235, 12892.613221603367, 13159.86840131596, 1805.5666640006305, 1821.8360347568782, 1826.5433641589602, 1886.7452893859427, 1906.1327096171208, 50433.24350134751, 50557.988840223356, 55193.0, 56715.149272760944, 56787.71606141943, 9719.65981190655, 10031.648892288735, 10086.243531735003, 10123.595056197817, 10145.442000690033, 13038.152520086163, 13068.803967940488, 13145.34273286351, 13156.473741050251, 13202.405891734703, 7222.638868056576, 7274.527155734861, 7282.635868206568, 7308.196098429168, 7348.375388091965, 6895.827604309832, 6977.476689248225, 6993.720251189896, 7066.434685225169, 7103.964480177566, 4188.643965262926, 4218.325067989107, 4590.6557008223845, 4621.5378462154185, 4637.6289896808175, 1842.7788665360242, 1865.309835360925, 1943.805619438045, 1949.3079956615197, 1951.0732402108886, 864.8054187807693, 926.1016813690709, 977.9951100244596, 1031.7162780235494, 1087.3475914451267, 14473.710525789425, 15803.841961580467, 16291.814981855834, 16435.753463698053, 17600.911995440198, 941.609232168656, 947.2564037230878, 1016.7915577306634, 1017.7862648843677, 1028.3675539543126, 9332.90667093334, 9485.38345007586, 9807.117359437685, 9891.505424728735, 9936.50317484123, 561111.0, 561248.0, 575306.0, 582158.0, 590366.0, 72319.10723571104, 72778.27221727821, 73519.63240183765, 74389.0, 75626.62186689032, 1202.0924202227263, 1207.0, 1207.9698007549882, 1220.1885745978825, 1221.1757063981777, 15262.23688815577, 15343.156126413154, 15454.845451545341, 15506.5348039559, 15780.68438631198, 33807.4928876072, 33980.32039359248, 33995.3200935975, 34378.0, 34417.82791086029, 44975.775121124185, 45984.54015459803, 46505.302420464395, 47452.0, 47628.2855757157, 7002.75490357835, 7061.470389720689, 7109.75115870942, 7219.819504512429, 7305.050343455317, 9896.675405562793, 10640.733981650521, 11366.147538934447, 11461.0, 11718.179727419, 9764.951175244363, 9782.559784809559, 9826.263030272616, 9908.0, 9972.354561497272, 10073.294869359075, 10141.645042423479, 10287.43419111956, 10370.22223333268, 10414.0, 9462.716118516455, 10026.997300269915, 10082.781788006627, 10129.544170512492, 10281.640142594973, 7465.813354665959, 7622.961885190539, 7638.923610763822, 7656.770296891103, 7658.923410766044, 9116.4074335168, 9480.85778713306, 10028.548715307974, 10393.9480302598, 10413.323133996266], "unit": "score", "name": "jquery.html", "value": 8237.811150322324}, {"lowerIsBetter": false, "replicates": [1504.5110339139778, 1511.939522419103, 1655.9337626494942, 1781.180656897827, 1786.205138713273, 7789.18213587573, 7848.803779905491, 7967.0, 7967.282944534998, 8062.314703250217, 8021.7192398265925, 8048.114707382183, 8050.879236811438, 8139.511629302231, 8142.267195952363, 2358.3396648938237, 2358.7523310052457, 2372.2764556810166, 2376.4415362389823, 2386.0455817672896, 2396.8801559921935, 2398.496315773681, 2436.2082323244927, 2440.7559244075537, 2441.56051910656, 2275.101334972685, 2354.540864531417, 2358.0685629176464, 2387.689600351952, 2410.517896420714, 2374.5607062693284, 2381.57131716291, 2396.293093537402, 2410.0841680161516, 2424.442378252994, 2414.1067804912295, 2445.6453814196843, 2446.510697860435, 2450.2281781238853, 2455.324785683951, 7984.481008734414, 8041.798955026113, 8053.993250843644, 8059.838803223961, 8060.274575288252, 4907.730074845882, 5039.546440820343, 5043.0, 5052.898942021176, 5061.44324124346, 3337.215754297738, 3346.4478361070637, 3379.188994641293, 3422.7261819054415, 3427.657234276577, 1085.5603480590294, 1102.3606308341143, 1135.1543100390263, 1149.1611123879616, 1176.8117101263842, 10715.892841071567, 10829.458527073615, 10840.186985976083, 10868.836967445495, 10874.347539147677, 4260.957390426056, 4441.933370999438, 4475.910481790411, 4482.641388688897, 4547.15877562652, 8784.077671844492, 8799.824003520022, 8833.160849719266, 8836.8674469883, 8851.46891186518, 4966.6771659842, 4985.027919555652, 4987.900241995212, 5008.424031236382, 5015.1975683890405, 4554.658400619966, 4577.130345234395, 4581.289900065495, 4600.42494688164, 4611.031683346535, 3573.714102871764, 3591.1560783215923, 3638.363286424918, 3640.581333146669, 3640.7087433005295, 1128.638835572609, 1132.456420917964, 1148.9770204595861, 1153.5789436855655, 1202.0623913347604, 1060.9628662996913, 1065.169168048923, 1083.7561548651647, 1252.874712528758, 1376.0436496634743, 7296.890546641805, 7430.256974302527, 7435.367993720486, 7458.552486850806, 7466.887996680054, 1124.4939777100337, 1136.6476392318407, 1138.6185627814775, 1141.4178768827792, 1145.7994850901225, 5453.64551304164, 5623.831285061455, 5704.543636509069, 5727.026405511073, 5729.742161602738, 9409.118176364755, 9475.810483790285, 9775.51122443875, 9776.804463910681, 9790.118889299998, 9530.428174309563, 9660.32377733552, 9675.661351852652, 9691.563879625433, 9699.0, 7355.963220183865, 7395.482316237919, 7520.699172033167, 7531.284527969834, 7543.0, 7179.892301615584, 7272.272772722686, 7333.486655934247, 7342.8898566520475, 7363.263673632594, 8214.58927053633, 8340.207680270365, 8634.827303454022, 8642.178992995656, 8714.607842647223, 8648.870266946127, 8797.868031979397, 8805.735827925173, 8818.07410221943, 8892.244159246278, 6789.422899053636, 6854.691538880862, 6868.690908909211, 6886.380225779704, 6886.586804791728, 7541.095068591804, 7558.0, 7561.243875612395, 7564.50830696003, 7595.468317217963, 6995.370416662525, 7215.783526494213, 7362.22696616869, 7379.889301660372, 7451.254874512505, 6932.237453879969, 7071.116110486189, 7149.249328820399, 7178.676959536729, 7190.245024272376, 7176.856462870818, 7262.782116536512, 7272.090988626422, 7276.090488688914, 7301.707931682673, 6459.450946669585, 6519.608823470607, 6543.934560654523, 6566.573172743948, 6624.271330153583, 6586.209654841449, 6634.601923884389, 6637.1703537057865, 6655.933440665532, 6675.232348279816], "unit": "score", "name": "mootools.html", "value": 4633.095707216196}, {"lowerIsBetter": false, "replicates": [340.2141054164879, 342.2316898562727, 350.8964855367667, 353.05557633330835, 354.3886795278147, 6143.569950103494, 6266.903291923913, 6266.968665156668, 6324.1462402575635, 6344.714487848052, 5996.580239383245, 6210.223722034746, 6228.564000519954, 6237.656928868911, 6252.437280644741, 4818.831340903069, 4830.71015739055, 4831.903361932759, 4832.130216561035, 4838.225883858566, 4836.395450568679, 4838.0, 4840.806367745286, 4841.782119804618, 4848.442429120643, 4718.882027949295, 4789.568938795508, 4791.47293797682, 4793.376861008064, 4799.352087468182, 4778.211595086841, 4789.712617242959, 4793.760311984404, 4795.784189711454, 4803.855884323476, 4217.957820421787, 4218.388333691628, 4224.535301116905, 4227.154569086164, 4233.745975241495, 5923.437273459014, 5929.347771745148, 5934.673592952386, 5956.761729530814, 5962.224910761616, 5398.676079435247, 5560.110382338847, 5570.220169176318, 5590.440955904418, 5611.6352437091455, 6575.835604109888, 6581.572197807127, 6585.242697089848, 6593.0, 6600.108985287021, 4652.930206046912, 4662.067586482717, 4662.393888794469, 4673.906521869578, 4693.507181745902, 6775.2208496023095, 6921.307869213088, 6933.0, 6940.72237110515, 6967.198772141218, 4780.1873681474235, 4787.832425865078, 4790.760461976887, 4793.880152996203, 4808.687435316693, 4841.975790121027, 4853.223484242504, 4853.878653033632, 4857.344258525124, 4865.440474345425, 5540.390557038722, 5559.305086864142, 5562.110062389998, 5566.916496252559, 5594.916076258859, 6607.4383677386995, 6720.126383570105, 6724.29394913527, 6731.49513786468, 6735.29279425663, 1653.3056116431128, 1689.7211960026457, 1694.788151481065, 1695.279506209856, 1711.7261238201827, 1114.6711720042606, 1123.7573836623048, 1125.8536390269212, 1129.4127053932073, 1131.3438205840594, 6226.159468471698, 6239.282482514478, 6248.625082495065, 6250.937490625127, 6259.749610015549, 6790.219124800612, 6803.081583986099, 6809.148856392951, 6823.420009299265, 6829.93170068293, 6067.696615169224, 6188.690565471708, 6219.315875253718, 6219.502439804804, 6234.501239900797, 3679.5952445231005, 3692.335379631692, 3694.963050369462, 3699.2971335446177, 3700.481932529448, 6994.125734283215, 7034.73374792532, 7053.047838541731, 7057.964710176417, 7058.400035996895, 6894.413974812197, 6974.093367862146, 6978.0, 6987.091678081817, 6990.895136572955, 7053.259407762111, 7114.004039434483, 7129.3583577478275, 7129.500934934608, 7147.2138064812825, 6982.860342793218, 6984.930150698631, 6989.161300643956, 6997.1253593300835, 6999.8950015750825, 6808.080909077211, 6850.349216824394, 6899.20659124187, 6911.965440172767, 6960.303969602999, 7158.677859496231, 7228.63856807168, 7245.05814244166, 7245.239249878898, 7251.927480725125, 4697.459792123949, 4722.433308003062, 4730.0, 4733.242681170997, 4739.810407583796, 6848.075509806113, 6979.581225126509, 6987.0, 7008.894866576903, 7018.719251229893, 6789.388954994074, 6810.250872404131, 6813.0, 6835.7949261522235, 6836.008778727156, 6750.3924646782025, 6813.739458200249, 6813.761518346834, 6814.420774234246, 6825.215100263533, 6541.672916354259, 6661.16735408074, 6661.700223489857, 6673.232578253563, 6682.398584127452, 6784.7964561063245, 6807.761728339485, 6813.557118787461, 6826.556273842184, 6835.692393842389, 6598.439132673777, 6611.768588099586, 6613.437857782143, 6616.305287944697, 6619.073329733745], "unit": "score", "name": "prototype.html", "value": 5037.572714194663}, {"lowerIsBetter": false, "replicates": [734.9967294642811, 776.157868712447, 800.207794283659, 814.3484219516555, 846.542951361084, 13108.868911310885, 13180.209187448749, 13221.867781322184, 13232.0, 13254.668633284173, 14663.046901951366, 14699.19154446505, 14706.779398309034, 14713.705725885477, 14720.779188312157, 809.11402014794, 821.9753407397787, 837.0833936839182, 837.7654256808104, 838.3419016072385, 827.6441130313963, 827.9793005174859, 831.9251267385933, 835.2691395029349, 837.0541288344193, 868.4008034456236, 869.326272139091, 873.2271939333704, 874.5364956573027, 874.9343799215053, 857.8155696525215, 862.9913700862974, 863.4301361101643, 863.5509535041743, 863.9697610583631, 635.1457289945016, 639.5714871036371, 642.4699622811199, 643.88088203682, 644.001797214316, 13164.86835131646, 13218.00864935124, 13229.536966206137, 13230.933845330808, 13267.0, 12345.0, 12456.31490268035, 12612.243265404106, 12647.613376997158, 12699.746005079938, 10504.894951050544, 10511.526981285784, 10515.78968420635, 10531.473426328654, 10577.0, 3500.057125542071, 3511.5434993450945, 3521.0, 3664.047347689593, 3674.926501469956, 48806.875278096, 49262.26106608404, 50030.7498462509, 50765.0, 52674.736626316626, 9560.56977436017, 9621.374610650286, 9860.506974651238, 10253.641122560675, 10530.210234232463, 16951.745723814154, 17253.0, 17348.392806251974, 17367.218475168647, 17393.739093913602, 7454.291842274975, 7560.735374261984, 7616.3906887448875, 7744.0, 7755.0, 4223.218704539609, 4225.72532785368, 4255.361695745601, 4268.253055715238, 4336.869893903188, 3120.781545291853, 3129.0769223079246, 3136.6079240094987, 3154.3375891062674, 3166.60417447819, 587.7472686744655, 588.835126164666, 605.8848818724429, 608.2154021312457, 619.8388419011, 646.7251418147268, 650.7375691159231, 663.4725393312328, 680.1328306409268, 689.2452764223168, 8005.399595030396, 8354.373421993374, 8379.832403351898, 8404.747857564284, 8574.356923230782, 612.4793925163665, 632.4750457120579, 666.1406785247074, 674.3349893329671, 712.3339677401646, 3844.8462061517225, 3865.768053916774, 3968.265870813851, 3978.562358140602, 4124.979375103106, 49359.0128197434, 49513.75243123833, 49911.50088499069, 55439.445605544235, 56282.0, 44944.0, 45034.099318013454, 45131.54868451339, 45184.54815451869, 45790.77104614455, 43985.56014439878, 44083.338749918774, 44529.777351113036, 44615.10769784586, 44954.775226124315, 8609.569521523774, 8640.697575584825, 8833.29333653319, 8867.113288671339, 9115.589798458952, 30584.235394115327, 31453.528197076605, 31731.841340793148, 31900.042998710076, 33542.0, 42270.0, 43103.7844810774, 43333.3499997494, 43396.0, 43490.78254608833, 10442.164626829986, 10545.683629491128, 10875.238733288594, 11165.72085697864, 11398.658040258806, 12647.683807904876, 12747.171433856769, 12967.870321296667, 13054.08621396493, 13356.866431335562, 11105.222634415837, 11160.609378671708, 11167.553297867995, 11337.093032557541, 11360.602378917029, 11870.703232419259, 12012.440324082383, 12071.456784444545, 12521.248725076524, 12603.369831508204, 10885.782284354427, 11235.831462527905, 11453.083753299883, 11502.194846360675, 11713.297202167898, 9667.468289243878, 9778.217742580719, 9803.460809655537, 9888.653897113567, 10282.845757313497, 9047.595265444792, 9246.9537652314, 9762.170215531476, 9936.850947235653, 10083.596656133672], "unit": "score", "name": "yui.html", "value": 6317.225764157305}], "name": "dromaeo_css", "value": 7005.652432245857}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 112.0, 112.0, 112.0, 122.0, 112.0, 111.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [146.0, 126.0, 151.0, 166.0, 130.0, 156.0, 153.0, 135.0, 161.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 164.0, 162.0, 160.0, 162.0, 169.0, 169.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 71.0, 74.0, 73.0, 151.0, 72.0, 75.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 155.0, 102.0, 96.0, 96.0, 142.0, 95.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 111.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 96.0, 97.0, 98.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 60.0, 59.0, 60.0, 62.0, 60.0, 61.0, 69.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 61.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 70.0, 69.0, 70.0, 69.0, 68.0, 70.0, 71.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 83.0, 84.0, 83.0, 84.0, 83.0, 82.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [127.0, 122.0, 135.0, 121.0, 120.0, 132.0, 117.0, 141.0, 132.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.4}, {"lowerIsBetter": true, "replicates": [131.0, 144.0, 143.0, 145.0, 150.0, 151.0, 147.0, 135.0, 142.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [74.0, 68.0, 65.0, 70.0, 66.0, 67.0, 65.0, 69.0, 65.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1517.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.72224074691565], "unit": "score", "name": "Richards", "value": 211.74139599999998}, {"lowerIsBetter": false, "replicates": [188.25301204819277], "unit": "score", "name": "DeltaBlue", "value": 351.2188160000002}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [730.4601899196493], "unit": "score", "name": "Earley", "value": 912.3878469999997}, {"lowerIsBetter": false, "replicates": [12662.5], "unit": "score", "name": "Boyer", "value": 52.632813425468896}, {"lowerIsBetter": false, "replicates": [41265.30612244898], "unit": "score", "name": "RegExp", "value": 22.076293273986163}, {"lowerIsBetter": false, "replicates": [659.1957811470006], "unit": "score", "name": "Splay", "value": 123.621847}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20069.025909501932}]} 08:29:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20069.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1517.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7005.65"}}} 08:29:35 INFO - Return code: 0 08:29:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:29:35 INFO - # TBPL SUCCESS # 08:29:35 INFO - Running post-action listener: _resource_record_post_action 08:29:35 INFO - Running post-run listener: _resource_record_post_run 08:29:36 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 16384; Write bytes: 547467264; Read time: 28; Write time: 492380 08:29:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237531136; Read time: 0; Write time: 257180 08:29:36 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 16384; Write bytes: 309936128; Read time: 28; Write time: 235200 08:29:36 INFO - Running post-run listener: _upload_blobber_files 08:29:36 INFO - Blob upload gear active. 08:29:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:29:36 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:29:36 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:29:36 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:29:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:29:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:29:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:37 INFO - (blobuploader) - INFO - Done attempting. 08:29:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:29:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:29:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:39 INFO - (blobuploader) - INFO - Done attempting. 08:29:39 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:39 INFO - Return code: 0 08:29:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:29:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/76f9764525449080b491dbed32bd2a00eaae170482a277cc9c6b31f1978afc82be0d264c6567cbac8429bb0e8a7466e96bb381bd05a8cd7e077e3308b93379ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70e28d857393e75ee2f6872c501f8fb85641108cd80a35c8fba24670c1664f2a97b6f02f7150197d4de5682aa93a0799272091a756975eaade41e4db06236591"} 08:29:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:29:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:29:39 INFO - Contents: 08:29:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/76f9764525449080b491dbed32bd2a00eaae170482a277cc9c6b31f1978afc82be0d264c6567cbac8429bb0e8a7466e96bb381bd05a8cd7e077e3308b93379ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70e28d857393e75ee2f6872c501f8fb85641108cd80a35c8fba24670c1664f2a97b6f02f7150197d4de5682aa93a0799272091a756975eaade41e4db06236591"} 08:29:39 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:39 INFO - Copying logs to upload dir... 08:29:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:29:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.397847 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-19 08:29:38.921950) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 08:29:38.925303) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179 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/76f9764525449080b491dbed32bd2a00eaae170482a277cc9c6b31f1978afc82be0d264c6567cbac8429bb0e8a7466e96bb381bd05a8cd7e077e3308b93379ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70e28d857393e75ee2f6872c501f8fb85641108cd80a35c8fba24670c1664f2a97b6f02f7150197d4de5682aa93a0799272091a756975eaade41e4db06236591"} build_url:https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/YtY4yORURVyE2x1VMYXZxA/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/76f9764525449080b491dbed32bd2a00eaae170482a277cc9c6b31f1978afc82be0d264c6567cbac8429bb0e8a7466e96bb381bd05a8cd7e077e3308b93379ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70e28d857393e75ee2f6872c501f8fb85641108cd80a35c8fba24670c1664f2a97b6f02f7150197d4de5682aa93a0799272091a756975eaade41e4db06236591"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 08:29:38.950942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:29:38.951305) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453219492.828788-1800945179 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 08:29:39.035153) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 08:29:39.035516) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 08:29:39.035860) ========= ========= Total master_lag: 0.25 =========