builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1452657750.79 results: success (0) buildid: 20160112173002 builduid: ea30df7d1997477f84cd633c460c62a6 revision: c60cb3b3bf83ea6fc8faccddf56965b1e279422d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:30.791130) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:30.791722) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:30.792144) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006457 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:30.824365) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:30.824723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:30.838244) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:30.838594) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:30.889617) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:30.889958) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:30.890374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:30.890712) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 20:02:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.7M=0s 2016-01-12 20:02:31 (84.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203992 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:31.109063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:31.109992) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018078 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:31.165870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 20:02:31.166241) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c60cb3b3bf83ea6fc8faccddf56965b1e279422d --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 c60cb3b3bf83ea6fc8faccddf56965b1e279422d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 20:02:31,323 truncating revision to first 12 chars 2016-01-12 20:02:31,324 Setting DEBUG logging. 2016-01-12 20:02:31,324 attempt 1/10 2016-01-12 20:02:31,324 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c60cb3b3bf83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 20:02:32,333 unpacking tar archive at: fx-team-c60cb3b3bf83/testing/mozharness/ program finished with exit code 0 elapsedTime=1.312437 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 20:02:32.501469) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.502060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.517592) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.518045) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 20:02:32.518473) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-01-12 20:02:32.518842) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:02:32 INFO - MultiFileLogger online at 20160112 20:02:32 in /builds/slave/test-pgo 20:02:32 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 20:02:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:02:32 INFO - {'append_to_log': False, 20:02:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:02:32 INFO - 'blob_upload_branch': 'Fx-Team', 20:02:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:02:32 INFO - 'branch': 'Fx-Team', 20:02:32 INFO - 'buildbot_json_path': 'buildprops.json', 20:02:32 INFO - 'config_files': ('talos/linux_config.py',), 20:02:32 INFO - 'default_actions': ('clobber', 20:02:32 INFO - 'read-buildbot-config', 20:02:32 INFO - 'download-and-extract', 20:02:32 INFO - 'populate-webroot', 20:02:32 INFO - 'create-virtualenv', 20:02:32 INFO - 'install', 20:02:32 INFO - 'run-tests'), 20:02:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:02:32 INFO - 'download_minidump_stackwalk': True, 20:02:32 INFO - 'download_symbols': 'ondemand', 20:02:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:02:32 INFO - 'tooltool.py': '/tools/tooltool.py', 20:02:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:02:32 INFO - '/tools/misc-python/virtualenv.py')}, 20:02:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:02:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:02:32 INFO - 'installer_path': 'installer.exe', 20:02:32 INFO - 'log_level': 'info', 20:02:32 INFO - 'log_name': 'talos', 20:02:32 INFO - 'log_to_console': True, 20:02:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:02:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:02:32 INFO - 'opt_config_files': (), 20:02:32 INFO - 'pip_index': False, 20:02:32 INFO - 'sps_profile': False, 20:02:32 INFO - 'sps_profile_interval': 0, 20:02:32 INFO - 'suite': 'dromaeojs-e10s', 20:02:32 INFO - 'system_bits': '32', 20:02:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:02:32 INFO - 'title': 'talos-linux64-ix-007', 20:02:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:02:32 INFO - 'use_talos_json': True, 20:02:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:02:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:02:32 INFO - 'work_dir': 'build'} 20:02:32 INFO - ##### 20:02:32 INFO - ##### Running clobber step. 20:02:32 INFO - ##### 20:02:32 INFO - Running pre-action listener: _resource_record_pre_action 20:02:32 INFO - Running main action method: clobber 20:02:32 INFO - rmtree: /builds/slave/test-pgo/build 20:02:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:02:33 INFO - Running post-action listener: _resource_record_post_action 20:02:33 INFO - ##### 20:02:33 INFO - ##### Running read-buildbot-config step. 20:02:33 INFO - ##### 20:02:33 INFO - Running pre-action listener: _resource_record_pre_action 20:02:33 INFO - Running main action method: read_buildbot_config 20:02:33 INFO - Using buildbot properties: 20:02:33 INFO - { 20:02:33 INFO - "project": "", 20:02:33 INFO - "product": "firefox", 20:02:33 INFO - "script_repo_revision": "production", 20:02:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:02:33 INFO - "repository": "", 20:02:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:02:33 INFO - "buildid": "20160112173002", 20:02:33 INFO - "pgo_build": "True", 20:02:33 INFO - "basedir": "/builds/slave/test-pgo", 20:02:33 INFO - "buildnumber": 199, 20:02:33 INFO - "slavename": "talos-linux64-ix-007", 20:02:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:02:33 INFO - "platform": "ubuntu64_hw", 20:02:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:02:33 INFO - "branch": "fx-team", 20:02:33 INFO - "repo_path": "integration/fx-team", 20:02:33 INFO - "revision": "c60cb3b3bf83ea6fc8faccddf56965b1e279422d", 20:02:33 INFO - "stage_platform": "linux64-pgo", 20:02:33 INFO - "builduid": "ea30df7d1997477f84cd633c460c62a6", 20:02:33 INFO - "slavebuilddir": "test" 20:02:33 INFO - } 20:02:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 20:02:33 INFO - Running post-action listener: _resource_record_post_action 20:02:33 INFO - ##### 20:02:33 INFO - ##### Running download-and-extract step. 20:02:33 INFO - ##### 20:02:33 INFO - Running pre-action listener: _resource_record_pre_action 20:02:33 INFO - Running main action method: download_and_extract 20:02:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:02:33 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')]} 20:02:33 INFO - https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:02:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/test_packages.json 20:02:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/test_packages.json 20:02:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:02:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:02:39 INFO - Downloaded 1302 bytes. 20:02:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:02:39 INFO - Using the following test package requirements: 20:02:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:02:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:39 INFO - u'jsshell-linux-x86_64.zip'], 20:02:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:02:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:02:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:02:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:02:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:02:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:39 INFO - https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:02:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:02:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:02:54 INFO - Downloaded 24027162 bytes. 20:02:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 20:02:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:02:55 INFO - Return code: 0 20:02:55 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 20:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:55 INFO - https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:02:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:02:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:02:57 INFO - Downloaded 24027162 bytes. 20:02:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 20:02:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:02:58 INFO - Return code: 0 20:02:58 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')]} 20:02:58 INFO - https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:02:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:02:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:03:01 INFO - Downloaded 11132285 bytes. 20:03:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 20:03:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:03:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 20:03:01 INFO - Return code: 0 20:03: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')]} 20:03:01 INFO - https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:03:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:03:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:03:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:03:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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 20:03:05 INFO - Downloaded 55746442 bytes. 20:03:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:03:05 INFO - mkdir: /builds/slave/test-pgo/properties 20:03:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:03:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:03:05 INFO - Contents: 20:03:05 INFO - build_url:https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:03:05 INFO - Running post-action listener: _resource_record_post_action 20:03:05 INFO - Running post-action listener: set_extra_try_arguments 20:03:05 INFO - ##### 20:03:05 INFO - ##### Running populate-webroot step. 20:03:05 INFO - ##### 20:03:05 INFO - Running pre-action listener: _resource_record_pre_action 20:03:05 INFO - Running main action method: populate_webroot 20:03:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:03:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:03:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:03:05 INFO - '--tppagecycles', 20:03:05 INFO - '7'], 20:03:05 INFO - 'tests': ['tsvgm']}}, 20:03:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:03:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:03:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:03:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:03:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:03:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:03:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:05 INFO - 'talos_options': ['--e10s'], 20:03:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:05 INFO - 'tests': ['damp', 'tps']}, 20:03:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:05 INFO - 'talos_options': ['--e10s'], 20:03:05 INFO - 'tests': ['damp', 'tps']}, 20:03:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:03:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:03:05 INFO - 'other': {'tests': ['a11yr', 20:03:05 INFO - 'ts_paint', 20:03:05 INFO - 'tpaint', 20:03:05 INFO - 'sessionrestore', 20:03:05 INFO - 'sessionrestore_no_auto_restore']}, 20:03:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:03:05 INFO - 'tests': ['a11yr', 20:03:05 INFO - 'ts_paint', 20:03:05 INFO - 'tpaint', 20:03:05 INFO - 'sessionrestore', 20:03:05 INFO - 'sessionrestore_no_auto_restore']}, 20:03:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:03:05 INFO - 'tests': ['a11yr', 20:03:05 INFO - 'ts_paint', 20:03:05 INFO - 'tpaint', 20:03:05 INFO - 'sessionrestore', 20:03:05 INFO - 'sessionrestore_no_auto_restore']}, 20:03:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:03:05 INFO - 'tests': ['a11yr', 20:03:05 INFO - 'ts_paint', 20:03:05 INFO - 'tpaint', 20:03:05 INFO - 'sessionrestore', 20:03:05 INFO - 'sessionrestore_no_auto_restore']}, 20:03:05 INFO - 'other_l64': {'tests': ['a11yr', 20:03:05 INFO - 'ts_paint', 20:03:05 INFO - 'tpaint', 20:03:05 INFO - 'sessionrestore', 20:03:05 INFO - 'sessionrestore_no_auto_restore']}, 20:03:05 INFO - 'other_nol64': {'tests': ['a11yr', 20:03:05 INFO - 'ts_paint', 20:03:05 INFO - 'tpaint', 20:03:05 INFO - 'sessionrestore', 20:03:05 INFO - 'sessionrestore_no_auto_restore']}, 20:03:05 INFO - 'svgr': {'tests': ['tsvgx', 20:03:05 INFO - 'tsvgr_opacity', 20:03:05 INFO - 'tart', 20:03:05 INFO - 'tscrollx', 20:03:05 INFO - 'cart']}, 20:03:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:03:05 INFO - 'tests': ['tsvgx', 20:03:05 INFO - 'tsvgr_opacity', 20:03:05 INFO - 'tart', 20:03:05 INFO - 'tscrollx', 20:03:05 INFO - 'cart']}, 20:03:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:05 INFO - 'tests': ['tp5o']}, 20:03:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:05 INFO - 'talos_options': ['--e10s'], 20:03:05 INFO - 'tests': ['tp5o']}, 20:03:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:05 INFO - 'talos_options': ['--xperf_path', 20:03:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:05 INFO - 'tests': ['tp5n']}, 20:03:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:05 INFO - 'talos_options': ['--e10s', 20:03:05 INFO - '--xperf_path', 20:03:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:05 INFO - 'tests': ['tp5n']}}, 20:03:05 INFO - 'talos.zip': {'path': '', 20:03:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:03:05 INFO - Running post-action listener: _resource_record_post_action 20:03:05 INFO - ##### 20:03:05 INFO - ##### Running create-virtualenv step. 20:03:05 INFO - ##### 20:03:05 INFO - Running pre-action listener: _resource_record_pre_action 20:03:05 INFO - Running main action method: create_virtualenv 20:03:05 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:03:05 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 20:03:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:03:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:03:05 INFO - Using real prefix '/usr' 20:03:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:03:06 INFO - Installing distribute.............................................................................................................................................................................................done. 20:03:08 INFO - Installing pip.................done. 20:03:08 INFO - Return code: 0 20:03:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f28d0b4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1178630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1209840>, '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 0x11766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1176b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', '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 20:03:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:03:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:03:08 INFO - Using env: {'DISPLAY': ':0', 20:03:08 INFO - 'HOME': '/home/cltbld', 20:03:08 INFO - 'LANG': 'en_US.UTF-8', 20:03:08 INFO - 'LANGUAGE': 'en_US:en', 20:03:08 INFO - 'LOGNAME': 'cltbld', 20:03:08 INFO - 'MAIL': '/var/mail/cltbld', 20:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:08 INFO - 'MOZ_NO_REMOTE': '1', 20:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:08 INFO - 'NO_EM_RESTART': '1', 20:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:08 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:08 INFO - 'SHELL': '/bin/bash', 20:03:08 INFO - 'SHLVL': '1', 20:03:08 INFO - 'TERM': 'linux', 20:03:08 INFO - 'TMOUT': '86400', 20:03:08 INFO - 'USER': 'cltbld', 20:03:08 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', 20:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:08 INFO - '_': '/tools/buildbot/bin/python'} 20:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:08 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 20:03:08 INFO - Cleaning up... 20:03:08 INFO - Return code: 0 20:03:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f28d0b4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1178630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1209840>, '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 0x11766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1176b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', '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 20:03:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:03:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:03:08 INFO - Using env: {'DISPLAY': ':0', 20:03:08 INFO - 'HOME': '/home/cltbld', 20:03:08 INFO - 'LANG': 'en_US.UTF-8', 20:03:08 INFO - 'LANGUAGE': 'en_US:en', 20:03:08 INFO - 'LOGNAME': 'cltbld', 20:03:08 INFO - 'MAIL': '/var/mail/cltbld', 20:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:08 INFO - 'MOZ_NO_REMOTE': '1', 20:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:08 INFO - 'NO_EM_RESTART': '1', 20:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:08 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:08 INFO - 'SHELL': '/bin/bash', 20:03:08 INFO - 'SHLVL': '1', 20:03:08 INFO - 'TERM': 'linux', 20:03:08 INFO - 'TMOUT': '86400', 20:03:08 INFO - 'USER': 'cltbld', 20:03:08 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', 20:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:08 INFO - '_': '/tools/buildbot/bin/python'} 20:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:08 INFO - Downloading/unpacking psutil>=0.7.1 20:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:10 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:03:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:03:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:03:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:10 INFO - Installing collected packages: psutil 20:03:10 INFO - Running setup.py install for psutil 20:03:10 INFO - building 'psutil._psutil_linux' extension 20:03:10 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 20:03:10 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 20:03:10 INFO - building 'psutil._psutil_posix' extension 20:03:10 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 20:03:11 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 20:03:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:11 INFO - Successfully installed psutil 20:03:11 INFO - Cleaning up... 20:03:11 INFO - Return code: 0 20:03:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:03:11 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')]} 20:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:11 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')]} 20:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:11 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 0x7f28d0b4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1178630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1209840>, '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 0x11766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1176b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', '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 20:03:11 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 20:03:11 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 20:03:11 INFO - Using env: {'DISPLAY': ':0', 20:03:11 INFO - 'HOME': '/home/cltbld', 20:03:11 INFO - 'LANG': 'en_US.UTF-8', 20:03:11 INFO - 'LANGUAGE': 'en_US:en', 20:03:11 INFO - 'LOGNAME': 'cltbld', 20:03:11 INFO - 'MAIL': '/var/mail/cltbld', 20:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:11 INFO - 'MOZ_NO_REMOTE': '1', 20:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:11 INFO - 'NO_EM_RESTART': '1', 20:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:11 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:11 INFO - 'SHELL': '/bin/bash', 20:03:11 INFO - 'SHLVL': '1', 20:03:11 INFO - 'TERM': 'linux', 20:03:11 INFO - 'TMOUT': '86400', 20:03:11 INFO - 'USER': 'cltbld', 20:03:11 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', 20:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:11 INFO - '_': '/tools/buildbot/bin/python'} 20:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:03:11 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 20:03:11 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 20:03:11 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 20:03:11 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 20:03:11 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 20:03:11 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 20:03:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:03:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:03:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:03:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:03:13 INFO - Installing collected packages: mozsystemmonitor 20:03:13 INFO - Running setup.py install for mozsystemmonitor 20:03:13 INFO - Successfully installed mozsystemmonitor 20:03:13 INFO - Cleaning up... 20:03:13 INFO - Return code: 0 20:03:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:03:13 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')]} 20:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:13 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')]} 20:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:13 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 0x7f28d0b4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1178630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1209840>, '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 0x11766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1176b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', '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 20:03:13 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 20:03:13 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 20:03:13 INFO - Using env: {'DISPLAY': ':0', 20:03:13 INFO - 'HOME': '/home/cltbld', 20:03:13 INFO - 'LANG': 'en_US.UTF-8', 20:03:13 INFO - 'LANGUAGE': 'en_US:en', 20:03:13 INFO - 'LOGNAME': 'cltbld', 20:03:13 INFO - 'MAIL': '/var/mail/cltbld', 20:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:13 INFO - 'MOZ_NO_REMOTE': '1', 20:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:13 INFO - 'NO_EM_RESTART': '1', 20:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:13 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:13 INFO - 'SHELL': '/bin/bash', 20:03:13 INFO - 'SHLVL': '1', 20:03:13 INFO - 'TERM': 'linux', 20:03:13 INFO - 'TMOUT': '86400', 20:03:13 INFO - 'USER': 'cltbld', 20:03:13 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', 20:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:13 INFO - '_': '/tools/buildbot/bin/python'} 20:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:13 INFO - Downloading/unpacking blobuploader==1.2.4 20:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:15 INFO - Downloading blobuploader-1.2.4.tar.gz 20:03:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:03:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:03:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:03:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:03:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:15 INFO - Downloading docopt-0.6.1.tar.gz 20:03:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:03:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:03:15 INFO - Installing collected packages: blobuploader, requests, docopt 20:03:15 INFO - Running setup.py install for blobuploader 20:03:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:03:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:03:16 INFO - Running setup.py install for requests 20:03:16 INFO - Running setup.py install for docopt 20:03:16 INFO - Successfully installed blobuploader requests docopt 20:03:16 INFO - Cleaning up... 20:03:16 INFO - Return code: 0 20:03:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:16 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 0x7f28d0b4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1178630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1209840>, '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 0x11766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1176b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', '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 20:03:16 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 20:03:16 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 20:03:16 INFO - Using env: {'DISPLAY': ':0', 20:03:16 INFO - 'HOME': '/home/cltbld', 20:03:16 INFO - 'LANG': 'en_US.UTF-8', 20:03:16 INFO - 'LANGUAGE': 'en_US:en', 20:03:16 INFO - 'LOGNAME': 'cltbld', 20:03:16 INFO - 'MAIL': '/var/mail/cltbld', 20:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:16 INFO - 'MOZ_NO_REMOTE': '1', 20:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:16 INFO - 'NO_EM_RESTART': '1', 20:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:16 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:16 INFO - 'SHELL': '/bin/bash', 20:03:16 INFO - 'SHLVL': '1', 20:03:16 INFO - 'TERM': 'linux', 20:03:16 INFO - 'TMOUT': '86400', 20:03:16 INFO - 'USER': 'cltbld', 20:03:16 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', 20:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:16 INFO - '_': '/tools/buildbot/bin/python'} 20:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:03:16 INFO - Running setup.py (path:/tmp/pip-PrO9YX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:03:16 INFO - Running setup.py (path:/tmp/pip-lUGQRP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:03:16 INFO - Running setup.py (path:/tmp/pip-2N_WPG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:03:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:03:16 INFO - Running setup.py (path:/tmp/pip-HTuAIC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:03:17 INFO - Running setup.py (path:/tmp/pip-h2j2H3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:03:17 INFO - Running setup.py (path:/tmp/pip-Z8EzMu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:03:17 INFO - Running setup.py (path:/tmp/pip-ycSIMc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:03:17 INFO - Running setup.py (path:/tmp/pip-DEgPgd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:03:17 INFO - Running setup.py (path:/tmp/pip-MVCaNj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:03:17 INFO - Running setup.py (path:/tmp/pip-pMSMpt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:03:17 INFO - Running setup.py (path:/tmp/pip-XLuRuy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:03:17 INFO - Running setup.py (path:/tmp/pip-IjSsTz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:03:17 INFO - Running setup.py (path:/tmp/pip-7GnZdq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:03:17 INFO - Running setup.py (path:/tmp/pip-9a29RW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:03:17 INFO - Running setup.py (path:/tmp/pip-EiRkIa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:03:17 INFO - Running setup.py (path:/tmp/pip-KJ2MAB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:03:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:03:17 INFO - Running setup.py (path:/tmp/pip-Y8w5u0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:03:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:03:17 INFO - Running setup.py install for manifestparser 20:03:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:03:18 INFO - Running setup.py install for mozcrash 20:03:18 INFO - Running setup.py install for mozdebug 20:03:18 INFO - Running setup.py install for mozdevice 20:03:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:03:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:03:18 INFO - Running setup.py install for mozfile 20:03:18 INFO - Running setup.py install for mozhttpd 20:03:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:03:18 INFO - Running setup.py install for mozinfo 20:03:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:03:18 INFO - Running setup.py install for mozInstall 20:03:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:03:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:03:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:03:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:03:18 INFO - Running setup.py install for mozleak 20:03:18 INFO - Running setup.py install for mozlog 20:03:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:03:18 INFO - Running setup.py install for moznetwork 20:03:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:03:19 INFO - Running setup.py install for mozprocess 20:03:19 INFO - Running setup.py install for mozprofile 20:03:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:03:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:03:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:03:19 INFO - Running setup.py install for mozrunner 20:03:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:03:19 INFO - Running setup.py install for mozscreenshot 20:03:19 INFO - Running setup.py install for moztest 20:03:19 INFO - Running setup.py install for mozversion 20:03:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:03:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:03:19 INFO - Cleaning up... 20:03:19 INFO - Return code: 0 20:03:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:03:19 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')]} 20:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:19 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')]} 20:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:19 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 0x7f28d0b4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1178630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1209840>, '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 0x11766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1176b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', '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 20:03:19 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 20:03:19 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 20:03:19 INFO - Using env: {'DISPLAY': ':0', 20:03:19 INFO - 'HOME': '/home/cltbld', 20:03:19 INFO - 'LANG': 'en_US.UTF-8', 20:03:19 INFO - 'LANGUAGE': 'en_US:en', 20:03:19 INFO - 'LOGNAME': 'cltbld', 20:03:19 INFO - 'MAIL': '/var/mail/cltbld', 20:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:19 INFO - 'MOZ_NO_REMOTE': '1', 20:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:19 INFO - 'NO_EM_RESTART': '1', 20:03:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:19 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:19 INFO - 'SHELL': '/bin/bash', 20:03:19 INFO - 'SHLVL': '1', 20:03:19 INFO - 'TERM': 'linux', 20:03:19 INFO - 'TMOUT': '86400', 20:03:19 INFO - 'USER': 'cltbld', 20:03:19 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', 20:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:19 INFO - '_': '/tools/buildbot/bin/python'} 20:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:03:19 INFO - Running setup.py (path:/tmp/pip-qNOJFg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:03:20 INFO - Running setup.py (path:/tmp/pip-fEpB1X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:03:20 INFO - Running setup.py (path:/tmp/pip-igjRGk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:03:20 INFO - Running setup.py (path:/tmp/pip-xy17px-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:03:20 INFO - Running setup.py (path:/tmp/pip-1L1uDG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:03:20 INFO - Running setup.py (path:/tmp/pip-znZx04-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:03:20 INFO - Running setup.py (path:/tmp/pip-CR5xea-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:03:20 INFO - Running setup.py (path:/tmp/pip-1O5UMA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:03:20 INFO - Running setup.py (path:/tmp/pip-Cboy4A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:03:20 INFO - Running setup.py (path:/tmp/pip-XDo6aL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:03:20 INFO - Running setup.py (path:/tmp/pip-jPB8gM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:03:20 INFO - Running setup.py (path:/tmp/pip-Q0ODbe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:03:20 INFO - Running setup.py (path:/tmp/pip-qpB71s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:03:20 INFO - Running setup.py (path:/tmp/pip-XyYB3V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:03:20 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)) 20:03:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:03:20 INFO - Running setup.py (path:/tmp/pip-rOQf7z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:03:21 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)) 20:03:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:03:21 INFO - Running setup.py (path:/tmp/pip-Uahu5t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:03:21 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)) 20:03:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:03:21 INFO - Running setup.py (path:/tmp/pip-UqRMPf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:03:21 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)) 20:03:21 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)) 20:03:21 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)) 20:03:21 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)) 20:03:21 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:03:21 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:03:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:03:21 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 20:03:21 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 20:03:21 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 20:03:21 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 20:03:21 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 20:03:21 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 20:03:23 INFO - Downloading blessings-1.5.1.tar.gz 20:03:23 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 20:03:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:03:23 INFO - Installing collected packages: blessings 20:03:23 INFO - Running setup.py install for blessings 20:03:23 INFO - Successfully installed blessings 20:03:23 INFO - Cleaning up... 20:03:23 INFO - Return code: 0 20:03:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:03:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:03:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:03:23 INFO - Reading from file tmpfile_stdout 20:03:23 INFO - Current package versions: 20:03:23 INFO - argparse == 1.2.1 20:03:23 INFO - blessings == 1.5.1 20:03:23 INFO - blobuploader == 1.2.4 20:03:23 INFO - docopt == 0.6.1 20:03:23 INFO - manifestparser == 1.1 20:03:23 INFO - mozInstall == 1.12 20:03:23 INFO - mozcrash == 0.16 20:03:23 INFO - mozdebug == 0.1 20:03:23 INFO - mozdevice == 0.47 20:03:23 INFO - mozfile == 1.2 20:03:23 INFO - mozhttpd == 0.7 20:03:23 INFO - mozinfo == 0.9 20:03:23 INFO - mozleak == 0.1 20:03:23 INFO - mozlog == 3.1 20:03:23 INFO - moznetwork == 0.27 20:03:23 INFO - mozprocess == 0.22 20:03:23 INFO - mozprofile == 0.28 20:03:23 INFO - mozrunner == 6.11 20:03:23 INFO - mozscreenshot == 0.1 20:03:23 INFO - mozsystemmonitor == 0.0 20:03:23 INFO - moztest == 0.7 20:03:23 INFO - mozversion == 1.4 20:03:23 INFO - psutil == 3.1.1 20:03:23 INFO - requests == 1.2.3 20:03:23 INFO - wsgiref == 0.1.2 20:03:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:03: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')]} 20:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03: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')]} 20:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:23 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 0x7f28d0b4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1178630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1209840>, '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 0x11766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1176b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', '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 20:03:23 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 20:03:23 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 20:03:23 INFO - Using env: {'DISPLAY': ':0', 20:03:23 INFO - 'HOME': '/home/cltbld', 20:03:23 INFO - 'LANG': 'en_US.UTF-8', 20:03:23 INFO - 'LANGUAGE': 'en_US:en', 20:03:23 INFO - 'LOGNAME': 'cltbld', 20:03:23 INFO - 'MAIL': '/var/mail/cltbld', 20:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:23 INFO - 'MOZ_NO_REMOTE': '1', 20:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:23 INFO - 'NO_EM_RESTART': '1', 20:03:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:23 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:23 INFO - 'SHELL': '/bin/bash', 20:03:23 INFO - 'SHLVL': '1', 20:03:23 INFO - 'TERM': 'linux', 20:03:23 INFO - 'TMOUT': '86400', 20:03:23 INFO - 'USER': 'cltbld', 20:03:23 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', 20:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:23 INFO - '_': '/tools/buildbot/bin/python'} 20:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:23 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)) 20:03:23 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)) 20:03:23 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)) 20:03:23 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)) 20:03:23 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)) 20:03:23 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)) 20:03:23 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)) 20:03:23 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)) 20:03:23 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)) 20:03:23 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)) 20:03:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 20:03:23 INFO - Cleaning up... 20:03:23 INFO - Return code: 0 20:03:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:03: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')]} 20:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03: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')]} 20:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:23 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 0x7f28d0b4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1178630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1209840>, '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 0x11766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1176b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', '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 20:03:23 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 20:03:23 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 20:03:23 INFO - Using env: {'DISPLAY': ':0', 20:03:23 INFO - 'HOME': '/home/cltbld', 20:03:23 INFO - 'LANG': 'en_US.UTF-8', 20:03:23 INFO - 'LANGUAGE': 'en_US:en', 20:03:23 INFO - 'LOGNAME': 'cltbld', 20:03:23 INFO - 'MAIL': '/var/mail/cltbld', 20:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:23 INFO - 'MOZ_NO_REMOTE': '1', 20:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:23 INFO - 'NO_EM_RESTART': '1', 20:03:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:23 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:23 INFO - 'SHELL': '/bin/bash', 20:03:23 INFO - 'SHLVL': '1', 20:03:23 INFO - 'TERM': 'linux', 20:03:23 INFO - 'TMOUT': '86400', 20:03:23 INFO - 'USER': 'cltbld', 20:03:23 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', 20:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:23 INFO - '_': '/tools/buildbot/bin/python'} 20:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:24 INFO - Downloading/unpacking jsonschema 20:03:24 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 20:03:24 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 20:03:24 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 20:03:24 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 20:03:24 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 20:03:24 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 20:03:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:03:25 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 20:03:25 INFO - Downloading/unpacking functools32 (from jsonschema) 20:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:26 INFO - Downloading functools32-3.2.3-2.tar.gz 20:03:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:03:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:03:26 INFO - warning: no files found matching '*.txt' 20:03:26 INFO - no previously-included directories found matching 'build' 20:03:26 INFO - no previously-included directories found matching 'dist' 20:03:26 INFO - no previously-included directories found matching '.git*' 20:03:26 INFO - Installing collected packages: jsonschema, functools32 20:03:26 INFO - Running setup.py install for functools32 20:03:26 INFO - warning: no files found matching '*.txt' 20:03:26 INFO - no previously-included directories found matching 'build' 20:03:26 INFO - no previously-included directories found matching 'dist' 20:03:26 INFO - no previously-included directories found matching '.git*' 20:03:26 INFO - Successfully installed jsonschema functools32 20:03:26 INFO - Cleaning up... 20:03:26 INFO - Return code: 0 20:03:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:03:26 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')]} 20:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:26 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')]} 20:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:26 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 0x7f28d0b4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1178630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1209840>, '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 0x11766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1176b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', '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 20:03:26 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 20:03:26 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 20:03:26 INFO - Using env: {'DISPLAY': ':0', 20:03:26 INFO - 'HOME': '/home/cltbld', 20:03:26 INFO - 'LANG': 'en_US.UTF-8', 20:03:26 INFO - 'LANGUAGE': 'en_US:en', 20:03:26 INFO - 'LOGNAME': 'cltbld', 20:03:26 INFO - 'MAIL': '/var/mail/cltbld', 20:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:26 INFO - 'MOZ_NO_REMOTE': '1', 20:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:26 INFO - 'NO_EM_RESTART': '1', 20:03:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:26 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:26 INFO - 'SHELL': '/bin/bash', 20:03:26 INFO - 'SHLVL': '1', 20:03:26 INFO - 'TERM': 'linux', 20:03:26 INFO - 'TMOUT': '86400', 20:03:26 INFO - 'USER': 'cltbld', 20:03:26 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', 20:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:26 INFO - '_': '/tools/buildbot/bin/python'} 20:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:26 INFO - Downloading/unpacking flake8 20:03:26 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 20:03:26 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 20:03:26 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 20:03:26 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 20:03:26 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 20:03:26 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 20:03:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:03:28 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 20:03:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:03:28 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 20:03:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:28 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 20:03:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:03:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:03:28 INFO - no previously-included directories found matching 'docs/_build' 20:03:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:03:28 INFO - Running setup.py install for pep8 20:03:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:03:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:03:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:03:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:03:29 INFO - no previously-included directories found matching 'docs/_build' 20:03:29 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:03:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:03:29 INFO - Cleaning up... 20:03:29 INFO - Return code: 0 20:03:29 INFO - Running post-action listener: _resource_record_post_action 20:03:29 INFO - Running post-action listener: _start_resource_monitoring 20:03:29 INFO - Starting resource monitoring. 20:03:29 INFO - ##### 20:03:29 INFO - ##### Running install step. 20:03:29 INFO - ##### 20:03:29 INFO - Running pre-action listener: _resource_record_pre_action 20:03:29 INFO - Running main action method: install 20:03:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:03:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:03:29 INFO - Reading from file tmpfile_stdout 20:03:29 INFO - Detecting whether we're running mozinstall >=1.0... 20:03:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:03:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:03:29 INFO - Reading from file tmpfile_stdout 20:03:29 INFO - Output received: 20:03:29 INFO - Usage: mozinstall [options] installer 20:03:29 INFO - Options: 20:03:29 INFO - -h, --help show this help message and exit 20:03:29 INFO - -d DEST, --destination=DEST 20:03:29 INFO - Directory to install application into. [default: 20:03:29 INFO - "/builds/slave/test-pgo"] 20:03:29 INFO - --app=APP Application being installed. [default: firefox] 20:03:29 INFO - mkdir: /builds/slave/test-pgo/build/application 20:03:29 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'] 20:03:29 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 20:03:45 INFO - Reading from file tmpfile_stdout 20:03:45 INFO - Output received: 20:03:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:03:45 INFO - Running post-action listener: _resource_record_post_action 20:03:45 INFO - ##### 20:03:45 INFO - ##### Running run-tests step. 20:03:45 INFO - ##### 20:03:45 INFO - Running pre-action listener: _resource_record_pre_action 20:03:45 INFO - Running main action method: run_tests 20:03:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:03:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:03:45 INFO - Python 2.7.3 20:03:45 INFO - Return code: 0 20:03:45 INFO - grabbing minidump binary from tooltool 20:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:45 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 0x1209840>, '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 0x11766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1176b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:03:45 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 20:03:45 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 20:03:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:03:45 INFO - Return code: 0 20:03:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:03:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:03:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:03:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:03:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:03:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:03:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:03:46 INFO - Return code: 0 20:03:46 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/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 20:03:46 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/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:03:46 INFO - Using env: {'DISPLAY': ':0', 20:03:46 INFO - 'HOME': '/home/cltbld', 20:03:46 INFO - 'LANG': 'en_US.UTF-8', 20:03:46 INFO - 'LANGUAGE': 'en_US:en', 20:03:46 INFO - 'LOGNAME': 'cltbld', 20:03:46 INFO - 'MAIL': '/var/mail/cltbld', 20:03:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:03:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:46 INFO - 'MOZ_NO_REMOTE': '1', 20:03:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:46 INFO - 'NO_EM_RESTART': '1', 20:03:46 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:03:46 INFO - 'PWD': '/builds/slave/test-pgo', 20:03:46 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:03:46 INFO - 'SHELL': '/bin/bash', 20:03:46 INFO - 'SHLVL': '1', 20:03:46 INFO - 'TERM': 'linux', 20:03:46 INFO - 'TMOUT': '86400', 20:03:46 INFO - 'USER': 'cltbld', 20:03:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453', 20:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:46 INFO - '_': '/tools/buildbot/bin/python'} 20:03:46 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/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:03:46 INFO - mozversion application_buildid: 20160112173002 20:03:46 INFO - mozversion application_changeset: c60cb3b3bf83ea6fc8faccddf56965b1e279422d 20:03:46 INFO - mozversion application_display_name: Nightly 20:03:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:03:46 INFO - mozversion application_name: Firefox 20:03:46 INFO - mozversion application_remotingname: firefox 20:03:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:03:46 INFO - mozversion application_vendor: Mozilla 20:03:46 INFO - mozversion application_version: 46.0a1 20:03:46 INFO - mozversion platform_buildid: 20160112173002 20:03:46 INFO - mozversion platform_changeset: c60cb3b3bf83ea6fc8faccddf56965b1e279422d 20:03:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:03:46 INFO - mozversion platform_version: 46.0a1 20:03:46 INFO - using testdate: 1452657826 20:03:46 INFO - actual date: 1452657826 20:03:46 INFO - starting webserver on 'localhost:35449' 20:03:46 INFO - SUITE-START | Running 3 tests 20:03:46 INFO - TEST-START | dromaeo_css 20:03:46 INFO - operating with platform_type : linux_ 20:03:46 INFO - Initialising browser for dromaeo_css test... 20:03:46 INFO - TEST-INFO | started process 14132 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRezkgc/profile http://localhost:35449/getInfo.html) 20:03:50 INFO - PROCESS | 14132 | 20:03:50 INFO - PROCESS | 14132 | (process:14218): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:03:51 INFO - PROCESS | 14132 | __metrics Screen width/height:1600/1200 20:03:51 INFO - PROCESS | 14132 | colorDepth:24 20:03:51 INFO - PROCESS | 14132 | Browser inner width/height: 1024/697 20:03:51 INFO - PROCESS | 14132 | __metrics 20:03:51 INFO - PROCESS | 14132 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:03:52 INFO - TEST-INFO | 14132: exit 0 20:03:52 INFO - Browser initialized. 20:03:52 INFO - Running cycle 1/1 for dromaeo_css test... 20:03:52 INFO - TEST-INFO | started process 14267 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRezkgc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:03:53 INFO - PROCESS | 14267 | 20:03:53 INFO - PROCESS | 14267 | (process:14324): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:04:04 INFO - PROCESS | 14267 | RSS: Main: 150249472 20:04:04 INFO - PROCESS | 14267 | 20:04:53 INFO - PROCESS | 14267 | 1452657893636 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] 20:07:02 INFO - PROCESS | 14267 | Cycle 1(1): loaded http://localhost:35449/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35449/tests/dromaeo/cssquery-ext.html) 20:07:03 INFO - PROCESS | 14267 | RSS: Main: 155791360 20:07:03 INFO - PROCESS | 14267 | 20:10:05 INFO - PROCESS | 14267 | Cycle 1(1): loaded http://localhost:35449/tests/dromaeo/cssquery-ext.html (next: http://localhost:35449/tests/dromaeo/cssquery-jquery.html) 20:10:06 INFO - PROCESS | 14267 | RSS: Main: 152305664 20:10:06 INFO - PROCESS | 14267 | 20:13:08 INFO - PROCESS | 14267 | Cycle 1(1): loaded http://localhost:35449/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35449/tests/dromaeo/cssquery-mootools.html) 20:13:08 INFO - PROCESS | 14267 | RSS: Main: 151191552 20:13:08 INFO - PROCESS | 14267 | 20:16:10 INFO - PROCESS | 14267 | Cycle 1(1): loaded http://localhost:35449/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35449/tests/dromaeo/cssquery-prototype.html) 20:16:11 INFO - PROCESS | 14267 | RSS: Main: 149262336 20:16:11 INFO - PROCESS | 14267 | 20:19:13 INFO - PROCESS | 14267 | Cycle 1(1): loaded http://localhost:35449/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35449/tests/dromaeo/cssquery-yui.html) 20:19:14 INFO - PROCESS | 14267 | RSS: Main: 151310336 20:19:14 INFO - PROCESS | 14267 | 20:22:16 INFO - PROCESS | 14267 | Cycle 1(1): loaded http://localhost:35449/tests/dromaeo/cssquery-yui.html (next: http://localhost:35449/tests/dromaeo/cssquery-dojo.html) 20:22:17 INFO - PROCESS | 14267 | RSS: Main: 152940544 20:22:17 INFO - PROCESS | 14267 | 20:22:17 INFO - PROCESS | 14267 | __start_tp_report 20:22:17 INFO - PROCESS | 14267 | _x_x_mozilla_page_load 20:22:17 INFO - PROCESS | 14267 | _x_x_mozilla_page_load_details 20:22:17 INFO - PROCESS | 14267 | |i|pagename|runs| 20:22:17 INFO - PROCESS | 14267 | |0;dojo.html;3181.3319202967377;3216.983915080424;3219.259570298833;3228.467302895022;3270.476723724203;5103.8468845934685;5193.999999999995;5206.947930520699;5215.8696032599155;5282.947170528294;5145.3311069560905;5165.896682066356;5235.685858848472;5268.710220937847;5293.179557168635;4755.571998520141;4770.499097594755;4810.446798618169;4814.903701925977;4954.677945933521;4819.963707802822;4826.734529600871;4848.466668666444;4853.733044682541;4883.12103821312;4685.508021657728;4764.904701905977;4781.306710526989;4847.733374664392;4890.853274401774;4757.9286310705365;4764.071006153801;4783.1868582341085;4792.0895029944195;4809.807607695723;4658.627309815207;4737.123632128068;4743.454502732196;4777.689450185727;4815.181419158752;5096.719680417576;5097.362829646294;5100.311457953203;5250.816221432232;5259.15853463444;5647.717614119319;5650.124230744241;5650.26546548946;5651.06757385031;5664;5650.632708873951;5671.234383358235;5682.801101961411;5695.088785794294;5697.03150464422;5209.583233341324;5237.8428647140645;5259.184826351883;5311.920321195185;5330.973345133327;5782.88434231313;5783.566232532577;5785.4793068623185;5787.045137552341;5795.246617939725;5576.330840299109;5594.104943209067;5594.300712410949;5602.439756024446;5605.159226116115;5544.972275138599;5570.637908535932;5579.581531385163;5624.578156638268;5674.2339784129435;5556.472135147154;5585.050541407889;5593;5596.076647353222;5607.299087614048;5474.726263686879;5590.860228494239;5606.131049687305;5616.1014237721765;5616.129499927436;4331.523532411432;4340.891477713019;4357.607815296575;4383.956160438419;4420.756858372756;3835.32881745699;3844.826982785781;3850.152966347399;3857.864974725871;3865.1110244643887;5252.737363131828;5264.210368444764;5303.681779093266;5333.493318134771;5345.9465405345445;5581.10702287632;5593.3847276799515;5625.54995600351;5679.545636349165;5702.914456283159;5303.28405665238;5309.230161626542;5309.8938021239355;5310.468953104736;5313.601479889024;4680.7191568506;4803.231482962779;4812.831550895702;4812.903741925142;4836.056968891033;5806.535477161817;5868.882622347614;5878.529717622666;5885.911711324334;5936.347001829795;5634.6337488063145;5662.5469962402085;5662.971685141548;5667.1782591524825;5709.0865461525955;5791.739371728367;5860.560457965585;5884.08796636522;5896.734646940812;5904.704764761831;5525.834224973257;5584.86037849057;5595.244641973281;5598.1322894951345;5640.60515763909;5568.860778480571;5640.210370548045;5643.71781410936;5651.378348381592;5656.066748986371;5419.295491586068;5487.835364939058;5511;5513.58648101386;5517.69652669107;5495.807646732345;5548.944510554843;5555.861103472445;5558.055130627884;5610.43895610452;5362.463753624606;5420.159875219348;5422.376426710821;5431.4296998816135;5453.672779633076;5402.810901618424;5477.096279113902;5518.641288316247;5544.972275138599;5548.500634942875;5460.153676180198;5473.781048758165;5478.068728316275;5492.368377636623;5494.80768173112 20:22:17 INFO - PROCESS | 14267 | |1;ext.html;535.296085647374;549.9945000549993;558.1070287539936;563.6223730100834;565.2171742137139;33770.49344259835;34433.96698099058;34475.65524344756;34625.82687086561;34667.4799878002;37609.435858462144;38109.428358574645;38119.428208576894;38148.61851381485;38238.61761382385;8391.328693704489;8578.656853725843;8585.31317494599;8602.569871506399;8612.22489975902;8221.917780822176;8436.282915952152;8449.873251901226;8622.611982460805;8677.219050285474;8636;8650.740477785645;8674.86987695182;8717.869231961526;8725.38922275441;8520.147985201493;8613.784655383603;8623.525706086195;8665.566721663892;8686.39195256326;8494.957525212396;8515.872261916076;8630.223279904776;8659.91751031121;8672.913270867337;37679.246415071546;37877.81061094705;38015.23969520622;38059;38091;3361.6974472297366;3477.4957631143598;3856.710746693981;3880.6507414332846;3899.922001559953;28231.57652635212;28686.426271474662;28880.133595992153;29316.120516384544;30010.39979200404;3922.411638254256;3927.528696556403;3988.162485877969;3992.261431635157;4107.096438783463;268869;269036.65481672663;269055;269813;270147;48767;49445;52304;52434.73782631062;59491.40508594859;55091.17363239555;55217.723911380184;55382.16926746102;55469.72265138649;55596.444035559936;14095.36570854314;14184.148951062969;14199.290035498183;14276.21480818565;14281;10994.120470362352;11142;11161.944190278997;11198.160137989684;11202.159838012181;17932.551686207687;18308.633827323378;18310.725339119923;18390.816091839177;18397.172127254307;7113.466490013167;7396.112466504054;7446.218147094585;7446.329830315298;7506.924930750732;898.4968417686117;945.6217512994857;1025.6051420203125;1030.314840630972;1047.9939258312106;27640.861795690893;27992.160235192976;28162.577561336595;28175.859120704266;28203.15390538287;995.2933417273672;1084.4089970965842;1104.690686607751;1111.7220694826294;1131.6491887514896;14421.629945155193;14437.639059023608;14728.410863565337;14729.779053314209;14967.625809354853;264701;267186;270713;271489;272321;47855;48018.5198148021;48307.5169248303;48375.274370884465;48485.27272090921;1341.2287934437738;1363.1139759156626;1371.9794203086963;1376.6489545165919;1382.315753701924;27345.453090938467;29691.554626680187;29759.702402975694;29912.401751964404;30185.245368865955;45066;45143;45171.548284516735;45506;45630.31554526618;286904;289340;291923;293036;293258;30946.45267736649;41172.176556469305;41970.160596788504;42213.36679949742;42324.78837605792;37914.43128353022;38939.221215574966;39178.4123238146;39243.80378098091;39439.408408873314;35368.469472958444;35407.82296088503;35427.64572354243;35572;35602.643973559934;34845.303093938484;35158.472622910165;35177;35595.64404356027;35658.64341356553;34568.308633827684;35009;36749.26501469902;37502.62497374992;37561.624383755814;29810.552841706958;31855.362892741552;32129.67870321267;32442.188945276557;32482.675173247964;24656.383590409667;24920.626190606792;24929.127480538093;25190.24429267125;25265 20:22:17 INFO - PROCESS | 14267 | |2;jquery.html;353.5562868599907;361.51917949127665;362.24291231326526;364.16787640242035;365.8884040367687;15844.683106337867;16397.918010409947;16852.662946741057;17347.21937512812;17621.823781762178;10495.845456999743;10546.787119481261;10798.5680572777;10946.726331841708;10984.231103822716;4840.273958906166;4891.608671306305;5062.721550314731;5063.696178229299;5094.694318340893;4975.527324904128;5061.19020956647;5065.290859279704;5065.924011139836;5093.516115968977;3747.1006958330076;3849.287881741887;4955.182394904837;5061.949380506203;5416.51251387375;5141.845744627667;5352.411234764173;5358.946410535884;5378.193271009361;5387.676739395649;5000.324956130912;5129.281900533928;5196.662216955886;5197.116490196676;5199.922001169985;12098.576549820802;12269.815952760715;14102.647433814134;19796.505087372785;19811.702824457643;2029.3404643490924;2075.138817390781;2137.3801597536694;2144.656854903208;2207.381933058746;9517.23862091031;9707.369021013683;9762.121409073146;12043.578474753429;12205.694857628541;1774.370098614986;1786.767720196366;1796.8113348098393;1806.2594336322045;1873.166440933785;52896;53253;53520.46479535194;54381.728091359684;55238.72380638071;9728.805423891483;9857.35927164732;9989.700308990741;10110.595576176871;10193.643222487177;12133.272003679807;12141.757164856654;12184.51261949512;12190.878091219152;12223.572174974011;7077.3984211341585;7309.817254568572;7381.224971377928;7428;7454.589997550187;7004.054452648929;7035.33164349386;7054.259302773135;7119.6084215368655;7181.8922716159295;4414.205443020223;4455.376247325377;4505.459344878635;4525.411696479437;4530.592246697813;1823.2706917233213;1890.5273681579606;1897.829195372423;1914.5405102775233;1917.4918646558674;420.9305464598368;437.835811570661;456.30641425033764;477.99522004779504;864.4942708515589;9965.701028969142;10087;10115.937826528256;10189.694309170589;10225.539850706737;437.9978100109479;442.599447500013;475.95002524734406;870.5516658920661;917.6283605139929;8645.91354086451;8910.153535414125;8969.103089691109;9047.81904361909;9094.454332740057;339383;353490;357681;362828;362848;46963.06073878503;60901;62714.37285627086;62716.68641656762;62765.37234627687;1122.1471681522103;1132.7791080739341;1135.1429670598811;1135.1543100390097;1147.581132886507;13951;13957.58127256184;14017.719645606827;14151.150930944177;14393;29699.703002969694;30489.54265685972;30525.542116867822;30988;31757.682423175473;42308.36537452002;42669.78665106655;43883.561164387946;44414.11171776482;45079.32381014353;7177.677004534704;7197.460190485839;7225.5664660120565;7353.926460735324;7374.926250737424;9759.316847820584;11050.668479945614;11143.108551316038;11203.095473769316;11295.604653837076;7413.264900135164;7448.648108351155;9493.905060949302;9736.513174341113;9782.706518804447;7080.645967701697;7845.254700803414;7883.408744344082;7940.523568585903;8068.1528439513;7826.882596760939;7831;7892.605369731606;7973.20267973198;8044.919550804417;8931.73204803857;9081.091890810865;9159.313051521029;9198.126178013077;9854.162396196403;7446.372728271735;7708.190639982721;7713.267239612228;7793.688252469838;7798.064232292161 20:22:17 INFO - PROCESS | 14267 | |3;mootools.html;1430.449277028344;1444.7038357136785;1568.5216009117214;1725.1029464678359;1735.8784885058044;7142.571445713261;7381.9630901845485;7391.8152046198875;7473.588952607618;7618.08582970043;7599.810004749884;7638.38892888569;7659.617019149048;7697.576633285167;7730;2257.480779420734;2261.9886900565475;2265.1279257485903;2274.4996100857784;2280.486890449652;2271.6138256496433;2309.976900230993;2328.75548067453;2328.7787660172257;2330.6387509935985;1971.8126777956143;2026.564288677934;2239.317008312464;2274.55646149001;2291.736450308211;2267.818574514035;2276.271593090212;2280.395695140789;2281.441046943493;2283.56612243674;2189.6606026065983;2298.5173113646156;2299.701038864937;2300.1489448903844;2302.9193978210683;7471.364933980618;7472.402207823361;7485.737999170003;7511.812204694927;7525.059367579052;4592.448906131252;4671.948811517415;4714.811407543694;4729.59798417135;4739.573438390527;2828.60399544064;2841.5737639354056;2885.6825749167574;2892.8264304141608;2901.405211931549;924.2328867040341;964.6864768950119;966.4104896013426;968.0658164870933;989.8267803134495;10281.434521101337;10334.586616535405;10347.223958203165;10351.120154786851;10352.4306163161;4104.15864747726;4137.524184718735;4219.367094935723;4241.915161696748;4243.0241044559925;8273.503589784632;8301.543415112106;8315.916840831635;8329.208725171098;8342.708005219789;4593.471750748707;4643.489216186217;4649.18639238132;4664.160451118763;4676.415448068991;4263.744175349489;4284.036091879302;4285.485741711014;4310.827566897352;4315.4605674290715;3390.423627983249;3405.3529829332347;3413.9317213655586;3429.8113603751535;3441.8795342163403;1042.11940909931;1046.8429735539578;1047.9633212837514;1057.2493529594074;1063.8297872340543;1003.6286573967678;1007.4811472091878;1018.1549314069305;1060.0035966191756;1136.6078702847503;6919.827004324932;6981.511294209458;6984.511084224056;6989.405900498413;7002.474814388941;1080.8865069167782;1087.0705546757567;1109.522905150793;1111.6665000499818;1111.9499622517005;5591.776328946878;5622.57830662702;5626.774929002794;5646;5648.209250704905;8712.607932643046;8807.867881981776;9152.633894644272;9204;9256.629734810533;9144.771380715536;9145.3598248122;9166.954165229132;9195.770105747277;9249.075092490832;7081.256468070881;7118.216996130525;7159.463040272;7313.26867313275;7318.085239345082;6975.686094125675;6991.370776630128;7021.5787052777;7040;7081.787546373617;7885.802854928444;8105.716299929474;8151.959240203761;8191.508509489211;8214.3428525719;8316.085230624747;8445.66217351299;8478.703245386381;8493.065762766215;8498.405111642125;6253.093301471352;6339.936600633934;6443.806685799434;6594.307597702172;6616.371444712745;7205.567665940061;7262.31008054234;7279.235680253709;7281.672324745293;7283.963580182065;6847.554908930903;6988.965055174692;7000.054992575937;7127.394171495481;7157.856842863218;6566.80299591013;6657.101291325609;6861.245263020964;6862.451003919575;6922.896156557555;6545.985372267306;6554.541182117397;6565.704543295467;6571.080048793077;6572.507061970276;6041.335453100243;6087.512998959984;6182.567220294536;6233.283172435228;6249.843753906189;6162.476189523762;6207.751689932533;6221.129041934223;6228.813135605939;6234.625922444668 20:22:17 INFO - PROCESS | 14267 | |4;prototype.html;340.1309653834453;343.52593421078905;348.4685854072537;349.08539626179413;354.26666799724575;6202.348753380892;6206.534509911752;6220.253569571646;6252.499800015999;6380.361963803629;6244.937550624492;6247.7813276535335;6284.528660350469;6286.685665716719;6308.211473565804;4741.359916411292;4759.7144171349655;4778.4265888093305;4783.9953609742;4803.183458811993;4785.282207668843;4795.160846851804;4800;4803.423589169287;4807.110684523374;4667.76661166942;4747.359106520627;4747.90504189916;4754.78603462845;4759.738214398207;4734.621230301567;4740.525947405266;4741.525847415265;4742.027884283731;4768.928466072977;4096.40602112695;4127.752334859918;4128.112455821983;4131.938020929689;4132.607402296777;5936.5547583931375;5962.850928726773;5974.3726908674835;5975.342712301644;6004.0693692477735;5432.837014889559;5528.585356098309;5544.500994910478;5563.721813909328;5572.721363931787;6666.333366663343;6669.633170175638;6670.6331151786635;6680.265170831205;6686.264510903797;4550.453945526525;4579.358889755437;4584.197765391076;4584.243599806028;4595.908081838378;6791.660416979181;6878.415334696557;6929.376356127973;6942.813013900605;6972.2330543640155;4679.602233810097;4686.671932964659;4689.460712018094;4691.695039822401;4694.389729335233;4744.667873248908;4754.191787396151;4757.191277482836;4758.904821903542;4761.738104404221;5455.836324910179;5484.561235101262;5496.780128794803;5499.835004949858;5519.530839878656;6521.510886683518;6612.603243805291;6656.83357916056;6667.63328016954;6676.731421029989;1637.165045826637;1661.609521762385;1662.5178698177635;1674.6315810521667;1684.856787173104;1090.1224514265934;1103.3214573037524;1104.320842681745;1111.1444187975214;1113.3876367997732;6153.784617538365;6154.846128846725;6170.5372097092895;6213.409726076015;6238.064290356483;6775.898361524581;6812.557183783038;6813.148356455443;6813.454923606099;6824.761133360308;6026.849328766728;6174.25908890936;6180.938190618036;6204.627722336674;6208.099825525273;3689.3359195345097;3713.962860371416;3715.3498137826314;3717.9442308365396;3720.3489389356755;7026.191987921352;7076.823079422953;7082.362587367162;7089.645517724093;7103.644817759091;6904.965475172692;6914.308569143045;6947.444204463631;6975.546589471668;6985.196702379291;7178.38983686382;7251.3836323912;7294.416446684252;7303.3792127668685;7314.158871729713;6987.161540615159;6991.126109236346;6992.685329160098;6994.041668332875;7003.859922801414;6784.660766961731;6796.796096117125;6829.453643708591;6837.692303846438;6907.067545881242;7226.494145409771;7229.060222171084;7230.409309951802;7247.710091596277;7264.273572642694;4679.859604211879;4727.905441891212;4732.621390288838;4732.716037037789;4735.981763920774;6791.932080679328;6942.6181560012665;6969.372756451944;6989.440844732511;7002.684879180347;6732.966335168293;6744.831379215559;6767.323267673193;6771.830704232237;6778.661066946732;6742;6757.45940324763;6763.797086087426;6766.492513061442;6771.153605799275;6495.707693153725;6579.934200657932;6583.539152259296;6635.137432133792;6644.069830223676;6780.830479238059;6781.42357899584;6792.354726300993;6793.93206067933;6800.455963523005;6659.667016649245;6660.6336651484635;6661.833454163685;6664.433523150587;6665 20:22:17 INFO - PROCESS | 14267 | |5;yui.html;730.3974221267454;810.9784847507261;849.0702680564783;857.9656813727447;870.8606622940323;15504.534863954086;15588.298526566303;15743.763843542327;15793.368265269404;15813.920930395347;14352.210628415432;14375.712485750279;14407.63980900478;14430.927845360784;14496.637584060403;792.1959211400405;797.6091715059608;801.5711594297052;810.5582457560644;810.7648781853285;795.4749865089043;803.0443771911407;805.4522924411398;805.524740403162;808.3169721585281;838.8238469921293;839.6431516605448;843.1147295339869;843.5318398288947;844.2401838345477;824.4146655874337;824.6206744897354;830.1283652165203;831.0816547714779;841.0622156295717;613.0497728520819;617.4257940115691;618.916446279751;620.6121174266084;623.6195920488499;13676.726465470734;13736.65658358549;13845.861541384558;13851;13892.791608125886;12904.935475322658;12963.935180324039;13211.405486753023;13381.866181338159;13456.730865382637;10110.977804439142;10255.6410525632;10264.230182736324;10292.845607315896;10674.62638807638;3613.765105268149;3673.1000904778502;3677.3748462761396;3788.1287303919976;3800.1069748609057;44373.33439998403;44552.77723611361;44884.55115448836;45044.54955450437;45323.320150197775;10118.696439106838;10355.378677279386;10427.739306517398;10451.529681164366;10525.789484210427;18130;18138.274469021355;18194.545136371697;18194.81805181931;18218.817811821977;7477.513961592479;7909.406794490321;8141.592920353959;8182.549959752271;8194.754157375288;4128.318827393447;4180.163967206571;4241.87274381769;4320.740755554614;4374.518802931675;2847.5443928971267;2895.739383455457;2906.854657267128;2913.3153708878394;2915.4314908593046;525.6872161064238;529.4573062610855;546.8632841789553;553.297312413241;555.0757987950099;523.5523627298682;554.3292615934764;622.4522420270133;623.8334314831294;636.2015670333701;7581.545107293469;7942.08666003417;7942.523448592988;7960.721374751856;8053.557054362066;555.8018038657101;589.8230530840816;635.9729037604328;667.3060017581661;688.5145972089665;3839.117003089305;3924.9018774530864;3965.6232657897453;4313.935290970638;4357.542458041923;52612.736936315836;53628.19557706638;53706.73146634242;53778.193327100125;56003.719981400645;48523.5147648526;48689.756551217724;48981.510184898405;49054.81143725647;49122.26316605254;40842.38736418956;41959.16081678349;42134;42438.57561424408;43073.13853722971;7727.813133785633;8251.95874020626;8471.66113355459;8567;8807.383483156118;30518.84740576283;31231.84384078065;31274.687253127177;31277.68722312748;31475.213119672193;41079.38380924348;42104.3684344729;42199.57800422079;42462.78768606137;42967.785161073996;10758.623448179276;11025.117990560897;11125.388103654377;11220.55117795279;11291.548338066385;11159.721006974565;11372.601958931398;11390.373529455628;11422.086233101165;11779.116566257393;10364;10504.579816807242;10549.630762923261;10676.57293708243;11230.157738169506;10611.628592999208;11151;11510.769784604094;11585.682863427517;11907.94046029799;10826.188035897181;10841.295315804447;10878.40168790724;10886.727831804268;11119.888801112209;8894.599743011451;9061.818763624822;9347.672831450867;9500.144986951207;9739.902600974183;8274.917091963267;8927.598258078531;9198.310126740387;9206.355555111346;9334.159925606727 20:22:17 INFO - PROCESS | 14267 | __end_tp_report 20:22:17 INFO - PROCESS | 14267 | __start_cc_report 20:22:17 INFO - PROCESS | 14267 | _x_x_mozilla_cycle_collect,310 20:22:17 INFO - PROCESS | 14267 | __end_cc_report 20:22:17 INFO - PROCESS | 14267 | __startTimestamp1452658937034__endTimestamp 20:22:17 INFO - PROCESS | 14267 | 20:22:17 INFO - PROCESS | 14267 | ------- Summary: start ------- 20:22:17 INFO - PROCESS | 14267 | Number of tests: 6 20:22:17 INFO - PROCESS | 14267 | 20:22:17 INFO - PROCESS | 14267 | [#0] dojo.html Cycles:165 Average:5238.49 Median:5460.15 stddev:576.52 (10.6%) stddev-sans-first:555.24 20:22:17 INFO - PROCESS | 14267 | Values: 3181.3 3217.0 3219.3 3228.5 3270.5 5103.8 5194.0 5206.9 5215.9 5282.9 5145.3 5165.9 5235.7 5268.7 5293.2 4755.6 4770.5 4810.4 4814.9 4954.7 4820.0 4826.7 4848.5 4853.7 4883.1 4685.5 4764.9 4781.3 4847.7 4890.9 4757.9 4764.1 4783.2 4792.1 4809.8 4658.6 4737.1 4743.5 4777.7 4815.2 5096.7 5097.4 5100.3 5250.8 5259.2 5647.7 5650.1 5650.3 5651.1 5664.0 5650.6 5671.2 5682.8 5695.1 5697.0 5209.6 5237.8 5259.2 5311.9 5331.0 5782.9 5783.6 5785.5 5787.0 5795.2 5576.3 5594.1 5594.3 5602.4 5605.2 5545.0 5570.6 5579.6 5624.6 5674.2 5556.5 5585.1 5593.0 5596.1 5607.3 5474.7 5590.9 5606.1 5616.1 5616.1 4331.5 4340.9 4357.6 4384.0 4420.8 3835.3 3844.8 3850.2 3857.9 3865.1 5252.7 5264.2 5303.7 5333.5 5345.9 5581.1 5593.4 5625.5 5679.5 5702.9 5303.3 5309.2 5309.9 5310.5 5313.6 4680.7 4803.2 4812.8 4812.9 4836.1 5806.5 5868.9 5878.5 5885.9 5936.3 5634.6 5662.5 5663.0 5667.2 5709.1 5791.7 5860.6 5884.1 5896.7 5904.7 5525.8 5584.9 5595.2 5598.1 5640.6 5568.9 5640.2 5643.7 5651.4 5656.1 5419.3 5487.8 5511.0 5513.6 5517.7 5495.8 5548.9 5555.9 5558.1 5610.4 5362.5 5420.2 5422.4 5431.4 5453.7 5402.8 5477.1 5518.6 5545.0 5548.5 5460.2 5473.8 5478.1 5492.4 5494.8 20:22:17 INFO - PROCESS | 14267 | 20:22:17 INFO - PROCESS | 14267 | [#1] ext.html Cycles:180 Average:44179.03 Median:35630.64 stddev:72103.90 (202.4%) stddev-sans-first:72231.70 20:22:17 INFO - PROCESS | 14267 | Values: 535.3 550.0 558.1 563.6 565.2 33770.5 34434.0 34475.7 34625.8 34667.5 37609.4 38109.4 38119.4 38148.6 38238.6 8391.3 8578.7 8585.3 8602.6 8612.2 8221.9 8436.3 8449.9 8622.6 8677.2 8636.0 8650.7 8674.9 8717.9 8725.4 8520.1 8613.8 8623.5 8665.6 8686.4 8495.0 8515.9 8630.2 8659.9 8672.9 37679.2 37877.8 38015.2 38059.0 38091.0 3361.7 3477.5 3856.7 3880.7 3899.9 28231.6 28686.4 28880.1 29316.1 30010.4 3922.4 3927.5 3988.2 3992.3 4107.1 268869.0 269036.7 269055.0 269813.0 270147.0 48767.0 49445.0 52304.0 52434.7 59491.4 55091.2 55217.7 55382.2 55469.7 55596.4 14095.4 14184.1 14199.3 14276.2 14281.0 10994.1 11142.0 11161.9 11198.2 11202.2 17932.6 18308.6 18310.7 18390.8 18397.2 7113.5 7396.1 7446.2 7446.3 7506.9 898.5 945.6 1025.6 1030.3 1048.0 27640.9 27992.2 28162.6 28175.9 28203.2 995.3 1084.4 1104.7 1111.7 1131.6 14421.6 14437.6 14728.4 14729.8 14967.6 264701.0 267186.0 270713.0 271489.0 272321.0 47855.0 48018.5 48307.5 48375.3 48485.3 1341.2 1363.1 1372.0 1376.6 1382.3 27345.5 29691.6 29759.7 29912.4 30185.2 45066.0 45143.0 45171.5 45506.0 45630.3 286904.0 289340.0 291923.0 293036.0 293258.0 30946.5 41172.2 41970.2 42213.4 42324.8 37914.4 38939.2 39178.4 39243.8 39439.4 35368.5 35407.8 35427.6 35572.0 35602.6 34845.3 35158.5 35177.0 35595.6 35658.6 34568.3 35009.0 36749.3 37502.6 37561.6 29810.6 31855.4 32129.7 32442.2 32482.7 24656.4 24920.6 24929.1 25190.2 25265.0 20:22:17 INFO - PROCESS | 14267 | 20:22:17 INFO - PROCESS | 14267 | [#2] jquery.html Cycles:180 Average:21217.62 Median:476.97 stddev:58267.54 (12216.1%) stddev-sans-first:58409.93 20:22:17 INFO - PROCESS | 14267 | Values: 353.6 361.5 362.2 364.2 365.9 15844.7 16397.9 16852.7 17347.2 17621.8 10495.8 10546.8 10798.6 10946.7 10984.2 4840.3 4891.6 5062.7 5063.7 5094.7 4975.5 5061.2 5065.3 5065.9 5093.5 3747.1 3849.3 4955.2 5061.9 5416.5 5141.8 5352.4 5358.9 5378.2 5387.7 5000.3 5129.3 5196.7 5197.1 5199.9 12098.6 12269.8 14102.6 19796.5 19811.7 2029.3 2075.1 2137.4 2144.7 2207.4 9517.2 9707.4 9762.1 12043.6 12205.7 1774.4 1786.8 1796.8 1806.3 1873.2 52896.0 53253.0 53520.5 54381.7 55238.7 9728.8 9857.4 9989.7 10110.6 10193.6 12133.3 12141.8 12184.5 12190.9 12223.6 7077.4 7309.8 7381.2 7428.0 7454.6 7004.1 7035.3 7054.3 7119.6 7181.9 4414.2 4455.4 4505.5 4525.4 4530.6 1823.3 1890.5 1897.8 1914.5 1917.5 420.9 437.8 456.3 478.0 864.5 9965.7 10087.0 10115.9 10189.7 10225.5 438.0 442.6 476.0 870.6 917.6 8645.9 8910.2 8969.1 9047.8 9094.5 339383.0 353490.0 357681.0 362828.0 362848.0 46963.1 60901.0 62714.4 62716.7 62765.4 1122.1 1132.8 1135.1 1135.2 1147.6 13951.0 13957.6 14017.7 14151.2 14393.0 29699.7 30489.5 30525.5 30988.0 31757.7 42308.4 42669.8 43883.6 44414.1 45079.3 7177.7 7197.5 7225.6 7353.9 7374.9 9759.3 11050.7 11143.1 11203.1 11295.6 7413.3 7448.6 9493.9 9736.5 9782.7 7080.6 7845.3 7883.4 7940.5 8068.2 7826.9 7831.0 7892.6 7973.2 8044.9 8931.7 9081.1 9159.3 9198.1 9854.2 7446.4 7708.2 7713.3 7793.7 7798.1 20:22:17 INFO - PROCESS | 14267 | 20:22:17 INFO - PROCESS | 14267 | [#3] mootools.html Cycles:180 Average:5288.23 Median:6224.97 stddev:2717.19 (43.6%) stddev-sans-first:2709.34 20:22:17 INFO - PROCESS | 14267 | Values: 1430.4 1444.7 1568.5 1725.1 1735.9 7142.6 7382.0 7391.8 7473.6 7618.1 7599.8 7638.4 7659.6 7697.6 7730.0 2257.5 2262.0 2265.1 2274.5 2280.5 2271.6 2310.0 2328.8 2328.8 2330.6 1971.8 2026.6 2239.3 2274.6 2291.7 2267.8 2276.3 2280.4 2281.4 2283.6 2189.7 2298.5 2299.7 2300.1 2302.9 7471.4 7472.4 7485.7 7511.8 7525.1 4592.4 4671.9 4714.8 4729.6 4739.6 2828.6 2841.6 2885.7 2892.8 2901.4 924.2 964.7 966.4 968.1 989.8 10281.4 10334.6 10347.2 10351.1 10352.4 4104.2 4137.5 4219.4 4241.9 4243.0 8273.5 8301.5 8315.9 8329.2 8342.7 4593.5 4643.5 4649.2 4664.2 4676.4 4263.7 4284.0 4285.5 4310.8 4315.5 3390.4 3405.4 3413.9 3429.8 3441.9 1042.1 1046.8 1048.0 1057.2 1063.8 1003.6 1007.5 1018.2 1060.0 1136.6 6919.8 6981.5 6984.5 6989.4 7002.5 1080.9 1087.1 1109.5 1111.7 1111.9 5591.8 5622.6 5626.8 5646.0 5648.2 8712.6 8807.9 9152.6 9204.0 9256.6 9144.8 9145.4 9167.0 9195.8 9249.1 7081.3 7118.2 7159.5 7313.3 7318.1 6975.7 6991.4 7021.6 7040.0 7081.8 7885.8 8105.7 8152.0 8191.5 8214.3 8316.1 8445.7 8478.7 8493.1 8498.4 6253.1 6339.9 6443.8 6594.3 6616.4 7205.6 7262.3 7279.2 7281.7 7284.0 6847.6 6989.0 7000.1 7127.4 7157.9 6566.8 6657.1 6861.2 6862.5 6922.9 6546.0 6554.5 6565.7 6571.1 6572.5 6041.3 6087.5 6182.6 6233.3 6249.8 6162.5 6207.8 6221.1 6228.8 6234.6 20:22:17 INFO - PROCESS | 14267 | 20:22:17 INFO - PROCESS | 14267 | [#4] prototype.html Cycles:180 Average:5568.74 Median:6216.83 stddev:1697.73 (27.3%) stddev-sans-first:1656.52 20:22:17 INFO - PROCESS | 14267 | Values: 340.1 343.5 348.5 349.1 354.3 6202.3 6206.5 6220.3 6252.5 6380.4 6244.9 6247.8 6284.5 6286.7 6308.2 4741.4 4759.7 4778.4 4784.0 4803.2 4785.3 4795.2 4800.0 4803.4 4807.1 4667.8 4747.4 4747.9 4754.8 4759.7 4734.6 4740.5 4741.5 4742.0 4768.9 4096.4 4127.8 4128.1 4131.9 4132.6 5936.6 5962.9 5974.4 5975.3 6004.1 5432.8 5528.6 5544.5 5563.7 5572.7 6666.3 6669.6 6670.6 6680.3 6686.3 4550.5 4579.4 4584.2 4584.2 4595.9 6791.7 6878.4 6929.4 6942.8 6972.2 4679.6 4686.7 4689.5 4691.7 4694.4 4744.7 4754.2 4757.2 4758.9 4761.7 5455.8 5484.6 5496.8 5499.8 5519.5 6521.5 6612.6 6656.8 6667.6 6676.7 1637.2 1661.6 1662.5 1674.6 1684.9 1090.1 1103.3 1104.3 1111.1 1113.4 6153.8 6154.8 6170.5 6213.4 6238.1 6775.9 6812.6 6813.1 6813.5 6824.8 6026.8 6174.3 6180.9 6204.6 6208.1 3689.3 3714.0 3715.3 3717.9 3720.3 7026.2 7076.8 7082.4 7089.6 7103.6 6905.0 6914.3 6947.4 6975.5 6985.2 7178.4 7251.4 7294.4 7303.4 7314.2 6987.2 6991.1 6992.7 6994.0 7003.9 6784.7 6796.8 6829.5 6837.7 6907.1 7226.5 7229.1 7230.4 7247.7 7264.3 4679.9 4727.9 4732.6 4732.7 4736.0 6791.9 6942.6 6969.4 6989.4 7002.7 6733.0 6744.8 6767.3 6771.8 6778.7 6742.0 6757.5 6763.8 6766.5 6771.2 6495.7 6579.9 6583.5 6635.1 6644.1 6780.8 6781.4 6792.4 6793.9 6800.5 6659.7 6660.6 6661.8 6664.4 6665.0 20:22:17 INFO - PROCESS | 14267 | 20:22:17 INFO - PROCESS | 14267 | [#5] yui.html Cycles:180 Average:13289.33 Median:23693.54 stddev:14833.76 (62.6%) stddev-sans-first:14845.39 20:22:17 INFO - PROCESS | 14267 | Values: 730.4 811.0 849.1 858.0 870.9 15504.5 15588.3 15743.8 15793.4 15813.9 14352.2 14375.7 14407.6 14430.9 14496.6 792.2 797.6 801.6 810.6 810.8 795.5 803.0 805.5 805.5 808.3 838.8 839.6 843.1 843.5 844.2 824.4 824.6 830.1 831.1 841.1 613.0 617.4 618.9 620.6 623.6 13676.7 13736.7 13845.9 13851.0 13892.8 12904.9 12963.9 13211.4 13381.9 13456.7 10111.0 10255.6 10264.2 10292.8 10674.6 3613.8 3673.1 3677.4 3788.1 3800.1 44373.3 44552.8 44884.6 45044.5 45323.3 10118.7 10355.4 10427.7 10451.5 10525.8 18130.0 18138.3 18194.5 18194.8 18218.8 7477.5 7909.4 8141.6 8182.5 8194.8 4128.3 4180.2 4241.9 4320.7 4374.5 2847.5 2895.7 2906.9 2913.3 2915.4 525.7 529.5 546.9 553.3 555.1 523.6 554.3 622.5 623.8 636.2 7581.5 7942.1 7942.5 7960.7 8053.6 555.8 589.8 636.0 667.3 688.5 3839.1 3924.9 3965.6 4313.9 4357.5 52612.7 53628.2 53706.7 53778.2 56003.7 48523.5 48689.8 48981.5 49054.8 49122.3 40842.4 41959.2 42134.0 42438.6 43073.1 7727.8 8252.0 8471.7 8567.0 8807.4 30518.8 31231.8 31274.7 31277.7 31475.2 41079.4 42104.4 42199.6 42462.8 42967.8 10758.6 11025.1 11125.4 11220.6 11291.5 11159.7 11372.6 11390.4 11422.1 11779.1 10364.0 10504.6 10549.6 10676.6 11230.2 10611.6 11151.0 11510.8 11585.7 11907.9 10826.2 10841.3 10878.4 10886.7 11119.9 8894.6 9061.8 9347.7 9500.1 9739.9 8274.9 8927.6 9198.3 9206.4 9334.2 20:22:17 INFO - PROCESS | 14267 | -------- Summary: end -------- 20:22:17 INFO - PROCESS | 14267 | 20:22:17 INFO - TEST-INFO | 14267: exit 0 20:22:17 INFO - TEST-OK | dromaeo_css | took 1111088ms 20:22:17 INFO - TEST-START | kraken 20:22:17 INFO - operating with platform_type : linux_ 20:22:17 INFO - Initialising browser for kraken test... 20:22:17 INFO - TEST-INFO | started process 14511 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOFuf9F/profile http://localhost:35449/getInfo.html) 20:22:21 INFO - PROCESS | 14511 | 20:22:21 INFO - PROCESS | 14511 | (process:14583): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:22:22 INFO - PROCESS | 14511 | __metrics Screen width/height:1600/1200 20:22:22 INFO - PROCESS | 14511 | colorDepth:24 20:22:22 INFO - PROCESS | 14511 | Browser inner width/height: 1024/697 20:22:22 INFO - PROCESS | 14511 | __metrics 20:22:22 INFO - PROCESS | 14511 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:22:23 INFO - TEST-INFO | 14511: exit 0 20:22:23 INFO - Browser initialized. 20:22:23 INFO - Running cycle 1/1 for kraken test... 20:22:23 INFO - TEST-INFO | started process 14632 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOFuf9F/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:22:24 INFO - PROCESS | 14632 | 20:22:24 INFO - PROCESS | 14632 | (process:14692): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:22:35 INFO - PROCESS | 14632 | RSS: Main: 150020096 20:22:35 INFO - PROCESS | 14632 | 20:22:37 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35449/tests/kraken/driver.html?testName=audio-beat-detection) 20:22:38 INFO - PROCESS | 14632 | RSS: Main: 150491136 20:22:38 INFO - PROCESS | 14632 | 20:22:40 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35449/tests/kraken/driver.html?testName=audio-dft) 20:22:41 INFO - PROCESS | 14632 | RSS: Main: 149516288 20:22:41 INFO - PROCESS | 14632 | 20:22:44 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35449/tests/kraken/driver.html?testName=audio-fft) 20:22:44 INFO - PROCESS | 14632 | RSS: Main: 146497536 20:22:44 INFO - PROCESS | 14632 | 20:22:47 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35449/tests/kraken/driver.html?testName=audio-oscillator) 20:22:47 INFO - PROCESS | 14632 | RSS: Main: 146264064 20:22:47 INFO - PROCESS | 14632 | 20:22:50 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35449/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:22:50 INFO - PROCESS | 14632 | RSS: Main: 147124224 20:22:50 INFO - PROCESS | 14632 | 20:22:53 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35449/tests/kraken/driver.html?testName=imaging-darkroom) 20:22:54 INFO - PROCESS | 14632 | RSS: Main: 147189760 20:22:54 INFO - PROCESS | 14632 | 20:22:57 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35449/tests/kraken/driver.html?testName=imaging-desaturate) 20:22:58 INFO - PROCESS | 14632 | RSS: Main: 148582400 20:22:58 INFO - PROCESS | 14632 | 20:23:01 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35449/tests/kraken/driver.html?testName=json-parse-financial) 20:23:01 INFO - PROCESS | 14632 | RSS: Main: 148684800 20:23:01 INFO - PROCESS | 14632 | 20:23:03 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35449/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:23:03 INFO - PROCESS | 14632 | RSS: Main: 148213760 20:23:03 INFO - PROCESS | 14632 | 20:23:05 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35449/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:23:06 INFO - PROCESS | 14632 | RSS: Main: 148443136 20:23:06 INFO - PROCESS | 14632 | 20:23:08 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35449/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:23:08 INFO - PROCESS | 14632 | RSS: Main: 148602880 20:23:08 INFO - PROCESS | 14632 | 20:23:11 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:23:11 INFO - PROCESS | 14632 | RSS: Main: 149299200 20:23:11 INFO - PROCESS | 14632 | 20:23:14 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:23:15 INFO - PROCESS | 14632 | RSS: Main: 148025344 20:23:15 INFO - PROCESS | 14632 | 20:23:16 INFO - PROCESS | 14632 | Cycle 1(1): loaded http://localhost:35449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35449/tests/kraken/driver.html?testName=ai-astar) 20:23:17 INFO - PROCESS | 14632 | RSS: Main: 148492288 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | __start_tp_report 20:23:17 INFO - PROCESS | 14632 | _x_x_mozilla_page_load 20:23:17 INFO - PROCESS | 14632 | _x_x_mozilla_page_load_details 20:23:17 INFO - PROCESS | 14632 | |i|pagename|runs| 20:23:17 INFO - PROCESS | 14632 | |0;ai-astar;114;107;112;115;111;121;114;112;112;111 20:23:17 INFO - PROCESS | 14632 | |1;audio-beat-detection;154;126;151;168;126;148;149;125;168;130 20:23:17 INFO - PROCESS | 14632 | |2;audio-dft;162;163;162;163;164;161;161;164;170;184 20:23:17 INFO - PROCESS | 14632 | |3;audio-fft;74;77;74;71;74;75;71;141;73;72 20:23:17 INFO - PROCESS | 14632 | |4;audio-oscillator;96;96;135;96;97;96;146;97;96;134 20:23:17 INFO - PROCESS | 14632 | |5;imaging-gaussian-blur;110;109;111;111;110;109;110;110;110;109 20:23:17 INFO - PROCESS | 14632 | |6;imaging-darkroom;147;146;146;146;147;147;147;148;146;147 20:23:17 INFO - PROCESS | 14632 | |7;imaging-desaturate;96;96;97;116;98;96;96;96;97;96 20:23:17 INFO - PROCESS | 14632 | |8;json-parse-financial;60;58;58;59;58;67;58;60;56;67 20:23:17 INFO - PROCESS | 14632 | |9;json-stringify-tinderbox;66;68;67;66;67;67;67;66;67;67 20:23:17 INFO - PROCESS | 14632 | |10;stanford-crypto-aes;87;86;89;86;87;86;94;94;96;86 20:23:17 INFO - PROCESS | 14632 | |11;stanford-crypto-ccm;118;119;120;126;123;115;117;134;131;123 20:23:17 INFO - PROCESS | 14632 | |12;stanford-crypto-pbkdf2;145;160;145;151;153;145;155;157;155;142 20:23:17 INFO - PROCESS | 14632 | |13;stanford-crypto-sha256-iterative;71;68;73;71;75;72;67;67;67;69 20:23:17 INFO - PROCESS | 14632 | __end_tp_report 20:23:17 INFO - PROCESS | 14632 | __start_cc_report 20:23:17 INFO - PROCESS | 14632 | _x_x_mozilla_cycle_collect,758 20:23:17 INFO - PROCESS | 14632 | __end_cc_report 20:23:17 INFO - PROCESS | 14632 | __startTimestamp1452658997160__endTimestamp 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | ------- Summary: start ------- 20:23:17 INFO - PROCESS | 14632 | Number of tests: 14 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:3.60 (3.2%) stddev-sans-first:3.80 20:23:17 INFO - PROCESS | 14632 | Values: 114.0 107.0 112.0 115.0 111.0 121.0 114.0 112.0 112.0 111.0 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:150.00 stddev:16.81 (11.2%) stddev-sans-first:17.48 20:23:17 INFO - PROCESS | 14632 | Values: 154.0 126.0 151.0 168.0 126.0 148.0 149.0 125.0 168.0 130.0 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#2] audio-dft Cycles:10 Average:165.40 Median:163.50 stddev:7.03 (4.3%) stddev-sans-first:7.34 20:23:17 INFO - PROCESS | 14632 | Values: 162.0 163.0 162.0 163.0 164.0 161.0 161.0 164.0 170.0 184.0 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#3] audio-fft Cycles:10 Average:80.20 Median:74.00 stddev:21.44 (29.0%) stddev-sans-first:22.62 20:23:17 INFO - PROCESS | 14632 | Values: 74.0 77.0 74.0 71.0 74.0 75.0 71.0 141.0 73.0 72.0 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:96.00 stddev:20.56 (21.4%) stddev-sans-first:21.27 20:23:17 INFO - PROCESS | 14632 | Values: 96.0 96.0 135.0 96.0 97.0 96.0 146.0 97.0 96.0 134.0 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 20:23:17 INFO - PROCESS | 14632 | Values: 110.0 109.0 111.0 111.0 110.0 109.0 110.0 110.0 110.0 109.0 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 20:23:17 INFO - PROCESS | 14632 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 147.0 148.0 146.0 147.0 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#7] imaging-desaturate Cycles:10 Average:98.40 Median:96.00 stddev:6.22 (6.5%) stddev-sans-first:6.54 20:23:17 INFO - PROCESS | 14632 | Values: 96.0 96.0 97.0 116.0 98.0 96.0 96.0 96.0 97.0 96.0 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:59.50 stddev:3.81 (6.4%) stddev-sans-first:4.04 20:23:17 INFO - PROCESS | 14632 | Values: 60.0 58.0 58.0 59.0 58.0 67.0 58.0 60.0 56.0 67.0 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 20:23:17 INFO - PROCESS | 14632 | Values: 66.0 68.0 67.0 66.0 67.0 67.0 67.0 66.0 67.0 67.0 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:88.00 stddev:3.98 (4.5%) stddev-sans-first:4.15 20:23:17 INFO - PROCESS | 14632 | Values: 87.0 86.0 89.0 86.0 87.0 86.0 94.0 94.0 96.0 86.0 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:123.00 stddev:6.17 (5.0%) stddev-sans-first:6.31 20:23:17 INFO - PROCESS | 14632 | Values: 118.0 119.0 120.0 126.0 123.0 115.0 117.0 134.0 131.0 123.0 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.80 Median:154.00 stddev:6.16 (4.0%) stddev-sans-first:6.17 20:23:17 INFO - PROCESS | 14632 | Values: 145.0 160.0 145.0 151.0 153.0 145.0 155.0 157.0 155.0 142.0 20:23:17 INFO - PROCESS | 14632 | 20:23:17 INFO - PROCESS | 14632 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:71.00 stddev:2.83 (4.0%) stddev-sans-first:2.98 20:23:17 INFO - PROCESS | 14632 | Values: 71.0 68.0 73.0 71.0 75.0 72.0 67.0 67.0 67.0 69.0 20:23:17 INFO - PROCESS | 14632 | -------- Summary: end -------- 20:23:17 INFO - PROCESS | 14632 | 20:23:18 INFO - TEST-INFO | 14632: exit 0 20:23:18 INFO - TEST-OK | kraken | took 60332ms 20:23:18 INFO - TEST-START | v8_7 20:23:18 INFO - operating with platform_type : linux_ 20:23:18 INFO - Initialising browser for v8_7 test... 20:23:18 INFO - TEST-INFO | started process 14921 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmsMDk1/profile http://localhost:35449/getInfo.html) 20:23:21 INFO - PROCESS | 14921 | 20:23:21 INFO - PROCESS | 14921 | (process:14993): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:23:22 INFO - PROCESS | 14921 | __metrics Screen width/height:1600/1200 20:23:22 INFO - PROCESS | 14921 | colorDepth:24 20:23:22 INFO - PROCESS | 14921 | Browser inner width/height: 1024/697 20:23:22 INFO - PROCESS | 14921 | __metrics 20:23:22 INFO - PROCESS | 14921 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:23:23 INFO - TEST-INFO | 14921: exit 0 20:23:23 INFO - Browser initialized. 20:23:23 INFO - Running cycle 1/1 for v8_7 test... 20:23:23 INFO - TEST-INFO | started process 15042 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmsMDk1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:25 INFO - PROCESS | 15042 | 20:23:25 INFO - PROCESS | 15042 | (process:15100): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:23:35 INFO - PROCESS | 15042 | RSS: Main: 149880832 20:23:35 INFO - PROCESS | 15042 | 20:23:58 INFO - PROCESS | 15042 | Cycle 1(1): loaded http://localhost:35449/tests/v8_7/run.html (next: http://localhost:35449/tests/v8_7/run.html) 20:23:58 INFO - PROCESS | 15042 | RSS: Main: 145506304 20:23:58 INFO - PROCESS | 15042 | 20:23:58 INFO - PROCESS | 15042 | __start_tp_report 20:23:58 INFO - PROCESS | 15042 | _x_x_mozilla_page_load 20:23:58 INFO - PROCESS | 15042 | _x_x_mozilla_page_load_details 20:23:58 INFO - PROCESS | 15042 | |i|pagename|runs| 20:23:58 INFO - PROCESS | 15042 | |0;Richards;167.19612104999163 20:23:58 INFO - PROCESS | 15042 | |1;DeltaBlue;188.35938971557732 20:23:58 INFO - PROCESS | 15042 | |2;Encrypt;280.42624789680315 20:23:58 INFO - PROCESS | 15042 | |3;Decrypt;5218.75 20:23:58 INFO - PROCESS | 15042 | |4;RayTrace;1078.7486515641856 20:23:58 INFO - PROCESS | 15042 | |5;Earley;715.8196134574088 20:23:58 INFO - PROCESS | 15042 | |6;Boyer;12243.90243902439 20:23:58 INFO - PROCESS | 15042 | |7;RegExp;41326.5306122449 20:23:58 INFO - PROCESS | 15042 | |8;Splay;566.57223796034 20:23:58 INFO - PROCESS | 15042 | |9;NavierStokes;4850.241545893719 20:23:58 INFO - PROCESS | 15042 | __end_tp_report 20:23:58 INFO - PROCESS | 15042 | __startTimestamp1452659038328__endTimestamp 20:23:58 INFO - PROCESS | 15042 | 20:23:58 INFO - PROCESS | 15042 | ------- Summary: start ------- 20:23:58 INFO - PROCESS | 15042 | Number of tests: 10 20:23:58 INFO - PROCESS | 15042 | 20:23:58 INFO - PROCESS | 15042 | [#0] Richards Cycles:1 Average:167.20 Median:167.20 stddev:0.00 (0.0%) 20:23:58 INFO - PROCESS | 15042 | Values: 167.2 20:23:58 INFO - PROCESS | 15042 | 20:23:58 INFO - PROCESS | 15042 | [#1] DeltaBlue Cycles:1 Average:188.36 Median:188.36 stddev:0.00 (0.0%) 20:23:58 INFO - PROCESS | 15042 | Values: 188.4 20:23:58 INFO - PROCESS | 15042 | 20:23:58 INFO - PROCESS | 15042 | [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 20:23:58 INFO - PROCESS | 15042 | Values: 280.4 20:23:58 INFO - PROCESS | 15042 | 20:23:58 INFO - PROCESS | 15042 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 20:23:58 INFO - PROCESS | 15042 | Values: 5218.8 20:23:58 INFO - PROCESS | 15042 | 20:23:58 INFO - PROCESS | 15042 | [#4] RayTrace Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 20:23:58 INFO - PROCESS | 15042 | Values: 1078.7 20:23:58 INFO - PROCESS | 15042 | 20:23:58 INFO - PROCESS | 15042 | [#5] Earley Cycles:1 Average:715.82 Median:715.82 stddev:0.00 (0.0%) 20:23:58 INFO - PROCESS | 15042 | Values: 715.8 20:23:58 INFO - PROCESS | 15042 | 20:23:58 INFO - PROCESS | 15042 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 20:23:58 INFO - PROCESS | 15042 | Values: 12243.9 20:23:58 INFO - PROCESS | 15042 | 20:23:58 INFO - PROCESS | 15042 | [#7] RegExp Cycles:1 Average:41326.53 Median:41326.53 stddev:0.00 (0.0%) 20:23:58 INFO - PROCESS | 15042 | Values: 41326.5 20:23:58 INFO - PROCESS | 15042 | 20:23:58 INFO - PROCESS | 15042 | [#8] Splay Cycles:1 Average:566.57 Median:566.57 stddev:0.00 (0.0%) 20:23:58 INFO - PROCESS | 15042 | Values: 566.6 20:23:58 INFO - PROCESS | 15042 | 20:23:58 INFO - PROCESS | 15042 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 20:23:58 INFO - PROCESS | 15042 | Values: 4850.2 20:23:58 INFO - PROCESS | 15042 | -------- Summary: end -------- 20:23:58 INFO - PROCESS | 15042 | 20:23:59 INFO - TEST-INFO | 15042: exit 0 20:23:59 INFO - TEST-OK | v8_7 | took 41127ms 20:23:59 INFO - SUITE-END | took 1212s 20:23:59 INFO - Completed test suite (00:20:12) 20:23:59 INFO - Working with test: dromaeo_css 20:23:59 INFO - Generating results file: dromaeo_css 20:23:59 INFO - Working with test: kraken 20:23:59 INFO - Generating results file: kraken 20:23:59 INFO - javascript benchmark 20:23:59 INFO - Working with test: v8_7 20:23:59 INFO - Generating results file: v8_7 20:23:59 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:23:59 INFO - process_Request line: dromaeo_css 6732.57 graph.html#tests=[[72,64,43]] 20:23:59 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:59 INFO - process_Request line: kraken 1526.30 graph.html#tests=[[232,64,43]] 20:23:59 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:59 INFO - process_Request line: v8_7 20447.98 graph.html#tests=[[230,64,43]] 20:23:59 INFO - RETURN: dromaeo_css: 6732.57 20:23:59 INFO - RETURN: kraken: 1526.30 20:23:59 INFO - RETURN: v8_7: 20447.98 20:23:59 INFO - javascript benchmark 20:23:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3181.3319202967377, 3216.983915080424, 3219.259570298833, 3228.467302895022, 3270.476723724203, 5103.8468845934685, 5193.999999999995, 5206.947930520699, 5215.8696032599155, 5282.947170528294, 5145.3311069560905, 5165.896682066356, 5235.685858848472, 5268.710220937847, 5293.179557168635, 4755.571998520141, 4770.499097594755, 4810.446798618169, 4814.903701925977, 4954.677945933521, 4819.963707802822, 4826.734529600871, 4848.466668666444, 4853.733044682541, 4883.12103821312, 4685.508021657728, 4764.904701905977, 4781.306710526989, 4847.733374664392, 4890.853274401774, 4757.9286310705365, 4764.071006153801, 4783.1868582341085, 4792.0895029944195, 4809.807607695723, 4658.627309815207, 4737.123632128068, 4743.454502732196, 4777.689450185727, 4815.181419158752, 5096.719680417576, 5097.362829646294, 5100.311457953203, 5250.816221432232, 5259.15853463444, 5647.717614119319, 5650.124230744241, 5650.26546548946, 5651.06757385031, 5664.0, 5650.632708873951, 5671.234383358235, 5682.801101961411, 5695.088785794294, 5697.03150464422, 5209.583233341324, 5237.8428647140645, 5259.184826351883, 5311.920321195185, 5330.973345133327, 5782.88434231313, 5783.566232532577, 5785.4793068623185, 5787.045137552341, 5795.246617939725, 5576.330840299109, 5594.104943209067, 5594.300712410949, 5602.439756024446, 5605.159226116115, 5544.972275138599, 5570.637908535932, 5579.581531385163, 5624.578156638268, 5674.2339784129435, 5556.472135147154, 5585.050541407889, 5593.0, 5596.076647353222, 5607.299087614048, 5474.726263686879, 5590.860228494239, 5606.131049687305, 5616.1014237721765, 5616.129499927436, 4331.523532411432, 4340.891477713019, 4357.607815296575, 4383.956160438419, 4420.756858372756, 3835.32881745699, 3844.826982785781, 3850.152966347399, 3857.864974725871, 3865.1110244643887, 5252.737363131828, 5264.210368444764, 5303.681779093266, 5333.493318134771, 5345.9465405345445, 5581.10702287632, 5593.3847276799515, 5625.54995600351, 5679.545636349165, 5702.914456283159, 5303.28405665238, 5309.230161626542, 5309.8938021239355, 5310.468953104736, 5313.601479889024, 4680.7191568506, 4803.231482962779, 4812.831550895702, 4812.903741925142, 4836.056968891033, 5806.535477161817, 5868.882622347614, 5878.529717622666, 5885.911711324334, 5936.347001829795, 5634.6337488063145, 5662.5469962402085, 5662.971685141548, 5667.1782591524825, 5709.0865461525955, 5791.739371728367, 5860.560457965585, 5884.08796636522, 5896.734646940812, 5904.704764761831, 5525.834224973257, 5584.86037849057, 5595.244641973281, 5598.1322894951345, 5640.60515763909, 5568.860778480571, 5640.210370548045, 5643.71781410936, 5651.378348381592, 5656.066748986371, 5419.295491586068, 5487.835364939058, 5511.0, 5513.58648101386, 5517.69652669107, 5495.807646732345, 5548.944510554843, 5555.861103472445, 5558.055130627884, 5610.43895610452, 5362.463753624606, 5420.159875219348, 5422.376426710821, 5431.4296998816135, 5453.672779633076, 5402.810901618424, 5477.096279113902, 5518.641288316247, 5544.972275138599, 5548.500634942875, 5460.153676180198, 5473.781048758165, 5478.068728316275, 5492.368377636623, 5494.80768173112], "unit": "score", "name": "dojo.html", "value": 5201.7187789242735}, {"lowerIsBetter": false, "replicates": [535.296085647374, 549.9945000549993, 558.1070287539936, 563.6223730100834, 565.2171742137139, 33770.49344259835, 34433.96698099058, 34475.65524344756, 34625.82687086561, 34667.4799878002, 37609.435858462144, 38109.428358574645, 38119.428208576894, 38148.61851381485, 38238.61761382385, 8391.328693704489, 8578.656853725843, 8585.31317494599, 8602.569871506399, 8612.22489975902, 8221.917780822176, 8436.282915952152, 8449.873251901226, 8622.611982460805, 8677.219050285474, 8636.0, 8650.740477785645, 8674.86987695182, 8717.869231961526, 8725.38922275441, 8520.147985201493, 8613.784655383603, 8623.525706086195, 8665.566721663892, 8686.39195256326, 8494.957525212396, 8515.872261916076, 8630.223279904776, 8659.91751031121, 8672.913270867337, 37679.246415071546, 37877.81061094705, 38015.23969520622, 38059.0, 38091.0, 3361.6974472297366, 3477.4957631143598, 3856.710746693981, 3880.6507414332846, 3899.922001559953, 28231.57652635212, 28686.426271474662, 28880.133595992153, 29316.120516384544, 30010.39979200404, 3922.411638254256, 3927.528696556403, 3988.162485877969, 3992.261431635157, 4107.096438783463, 268869.0, 269036.65481672663, 269055.0, 269813.0, 270147.0, 48767.0, 49445.0, 52304.0, 52434.73782631062, 59491.40508594859, 55091.17363239555, 55217.723911380184, 55382.16926746102, 55469.72265138649, 55596.444035559936, 14095.36570854314, 14184.148951062969, 14199.290035498183, 14276.21480818565, 14281.0, 10994.120470362352, 11142.0, 11161.944190278997, 11198.160137989684, 11202.159838012181, 17932.551686207687, 18308.633827323378, 18310.725339119923, 18390.816091839177, 18397.172127254307, 7113.466490013167, 7396.112466504054, 7446.218147094585, 7446.329830315298, 7506.924930750732, 898.4968417686117, 945.6217512994857, 1025.6051420203125, 1030.314840630972, 1047.9939258312106, 27640.861795690893, 27992.160235192976, 28162.577561336595, 28175.859120704266, 28203.15390538287, 995.2933417273672, 1084.4089970965842, 1104.690686607751, 1111.7220694826294, 1131.6491887514896, 14421.629945155193, 14437.639059023608, 14728.410863565337, 14729.779053314209, 14967.625809354853, 264701.0, 267186.0, 270713.0, 271489.0, 272321.0, 47855.0, 48018.5198148021, 48307.5169248303, 48375.274370884465, 48485.27272090921, 1341.2287934437738, 1363.1139759156626, 1371.9794203086963, 1376.6489545165919, 1382.315753701924, 27345.453090938467, 29691.554626680187, 29759.702402975694, 29912.401751964404, 30185.245368865955, 45066.0, 45143.0, 45171.548284516735, 45506.0, 45630.31554526618, 286904.0, 289340.0, 291923.0, 293036.0, 293258.0, 30946.45267736649, 41172.176556469305, 41970.160596788504, 42213.36679949742, 42324.78837605792, 37914.43128353022, 38939.221215574966, 39178.4123238146, 39243.80378098091, 39439.408408873314, 35368.469472958444, 35407.82296088503, 35427.64572354243, 35572.0, 35602.643973559934, 34845.303093938484, 35158.472622910165, 35177.0, 35595.64404356027, 35658.64341356553, 34568.308633827684, 35009.0, 36749.26501469902, 37502.62497374992, 37561.624383755814, 29810.552841706958, 31855.362892741552, 32129.67870321267, 32442.188945276557, 32482.675173247964, 24656.383590409667, 24920.626190606792, 24929.127480538093, 25190.24429267125, 25265.0], "unit": "score", "name": "ext.html", "value": 18003.375819047335}, {"lowerIsBetter": false, "replicates": [353.5562868599907, 361.51917949127665, 362.24291231326526, 364.16787640242035, 365.8884040367687, 15844.683106337867, 16397.918010409947, 16852.662946741057, 17347.21937512812, 17621.823781762178, 10495.845456999743, 10546.787119481261, 10798.5680572777, 10946.726331841708, 10984.231103822716, 4840.273958906166, 4891.608671306305, 5062.721550314731, 5063.696178229299, 5094.694318340893, 4975.527324904128, 5061.19020956647, 5065.290859279704, 5065.924011139836, 5093.516115968977, 3747.1006958330076, 3849.287881741887, 4955.182394904837, 5061.949380506203, 5416.51251387375, 5141.845744627667, 5352.411234764173, 5358.946410535884, 5378.193271009361, 5387.676739395649, 5000.324956130912, 5129.281900533928, 5196.662216955886, 5197.116490196676, 5199.922001169985, 12098.576549820802, 12269.815952760715, 14102.647433814134, 19796.505087372785, 19811.702824457643, 2029.3404643490924, 2075.138817390781, 2137.3801597536694, 2144.656854903208, 2207.381933058746, 9517.23862091031, 9707.369021013683, 9762.121409073146, 12043.578474753429, 12205.694857628541, 1774.370098614986, 1786.767720196366, 1796.8113348098393, 1806.2594336322045, 1873.166440933785, 52896.0, 53253.0, 53520.46479535194, 54381.728091359684, 55238.72380638071, 9728.805423891483, 9857.35927164732, 9989.700308990741, 10110.595576176871, 10193.643222487177, 12133.272003679807, 12141.757164856654, 12184.51261949512, 12190.878091219152, 12223.572174974011, 7077.3984211341585, 7309.817254568572, 7381.224971377928, 7428.0, 7454.589997550187, 7004.054452648929, 7035.33164349386, 7054.259302773135, 7119.6084215368655, 7181.8922716159295, 4414.205443020223, 4455.376247325377, 4505.459344878635, 4525.411696479437, 4530.592246697813, 1823.2706917233213, 1890.5273681579606, 1897.829195372423, 1914.5405102775233, 1917.4918646558674, 420.9305464598368, 437.835811570661, 456.30641425033764, 477.99522004779504, 864.4942708515589, 9965.701028969142, 10087.0, 10115.937826528256, 10189.694309170589, 10225.539850706737, 437.9978100109479, 442.599447500013, 475.95002524734406, 870.5516658920661, 917.6283605139929, 8645.91354086451, 8910.153535414125, 8969.103089691109, 9047.81904361909, 9094.454332740057, 339383.0, 353490.0, 357681.0, 362828.0, 362848.0, 46963.06073878503, 60901.0, 62714.37285627086, 62716.68641656762, 62765.37234627687, 1122.1471681522103, 1132.7791080739341, 1135.1429670598811, 1135.1543100390097, 1147.581132886507, 13951.0, 13957.58127256184, 14017.719645606827, 14151.150930944177, 14393.0, 29699.703002969694, 30489.54265685972, 30525.542116867822, 30988.0, 31757.682423175473, 42308.36537452002, 42669.78665106655, 43883.561164387946, 44414.11171776482, 45079.32381014353, 7177.677004534704, 7197.460190485839, 7225.5664660120565, 7353.926460735324, 7374.926250737424, 9759.316847820584, 11050.668479945614, 11143.108551316038, 11203.095473769316, 11295.604653837076, 7413.264900135164, 7448.648108351155, 9493.905060949302, 9736.513174341113, 9782.706518804447, 7080.645967701697, 7845.254700803414, 7883.408744344082, 7940.523568585903, 8068.1528439513, 7826.882596760939, 7831.0, 7892.605369731606, 7973.20267973198, 8044.919550804417, 8931.73204803857, 9081.091890810865, 9159.313051521029, 9198.126178013077, 9854.162396196403, 7446.372728271735, 7708.190639982721, 7713.267239612228, 7793.688252469838, 7798.064232292161], "unit": "score", "name": "jquery.html", "value": 7356.339672904535}, {"lowerIsBetter": false, "replicates": [1430.449277028344, 1444.7038357136785, 1568.5216009117214, 1725.1029464678359, 1735.8784885058044, 7142.571445713261, 7381.9630901845485, 7391.8152046198875, 7473.588952607618, 7618.08582970043, 7599.810004749884, 7638.38892888569, 7659.617019149048, 7697.576633285167, 7730.0, 2257.480779420734, 2261.9886900565475, 2265.1279257485903, 2274.4996100857784, 2280.486890449652, 2271.6138256496433, 2309.976900230993, 2328.75548067453, 2328.7787660172257, 2330.6387509935985, 1971.8126777956143, 2026.564288677934, 2239.317008312464, 2274.55646149001, 2291.736450308211, 2267.818574514035, 2276.271593090212, 2280.395695140789, 2281.441046943493, 2283.56612243674, 2189.6606026065983, 2298.5173113646156, 2299.701038864937, 2300.1489448903844, 2302.9193978210683, 7471.364933980618, 7472.402207823361, 7485.737999170003, 7511.812204694927, 7525.059367579052, 4592.448906131252, 4671.948811517415, 4714.811407543694, 4729.59798417135, 4739.573438390527, 2828.60399544064, 2841.5737639354056, 2885.6825749167574, 2892.8264304141608, 2901.405211931549, 924.2328867040341, 964.6864768950119, 966.4104896013426, 968.0658164870933, 989.8267803134495, 10281.434521101337, 10334.586616535405, 10347.223958203165, 10351.120154786851, 10352.4306163161, 4104.15864747726, 4137.524184718735, 4219.367094935723, 4241.915161696748, 4243.0241044559925, 8273.503589784632, 8301.543415112106, 8315.916840831635, 8329.208725171098, 8342.708005219789, 4593.471750748707, 4643.489216186217, 4649.18639238132, 4664.160451118763, 4676.415448068991, 4263.744175349489, 4284.036091879302, 4285.485741711014, 4310.827566897352, 4315.4605674290715, 3390.423627983249, 3405.3529829332347, 3413.9317213655586, 3429.8113603751535, 3441.8795342163403, 1042.11940909931, 1046.8429735539578, 1047.9633212837514, 1057.2493529594074, 1063.8297872340543, 1003.6286573967678, 1007.4811472091878, 1018.1549314069305, 1060.0035966191756, 1136.6078702847503, 6919.827004324932, 6981.511294209458, 6984.511084224056, 6989.405900498413, 7002.474814388941, 1080.8865069167782, 1087.0705546757567, 1109.522905150793, 1111.6665000499818, 1111.9499622517005, 5591.776328946878, 5622.57830662702, 5626.774929002794, 5646.0, 5648.209250704905, 8712.607932643046, 8807.867881981776, 9152.633894644272, 9204.0, 9256.629734810533, 9144.771380715536, 9145.3598248122, 9166.954165229132, 9195.770105747277, 9249.075092490832, 7081.256468070881, 7118.216996130525, 7159.463040272, 7313.26867313275, 7318.085239345082, 6975.686094125675, 6991.370776630128, 7021.5787052777, 7040.0, 7081.787546373617, 7885.802854928444, 8105.716299929474, 8151.959240203761, 8191.508509489211, 8214.3428525719, 8316.085230624747, 8445.66217351299, 8478.703245386381, 8493.065762766215, 8498.405111642125, 6253.093301471352, 6339.936600633934, 6443.806685799434, 6594.307597702172, 6616.371444712745, 7205.567665940061, 7262.31008054234, 7279.235680253709, 7281.672324745293, 7283.963580182065, 6847.554908930903, 6988.965055174692, 7000.054992575937, 7127.394171495481, 7157.856842863218, 6566.80299591013, 6657.101291325609, 6861.245263020964, 6862.451003919575, 6922.896156557555, 6545.985372267306, 6554.541182117397, 6565.704543295467, 6571.080048793077, 6572.507061970276, 6041.335453100243, 6087.512998959984, 6182.567220294536, 6233.283172435228, 6249.843753906189, 6162.476189523762, 6207.751689932533, 6221.129041934223, 6228.813135605939, 6234.625922444668], "unit": "score", "name": "mootools.html", "value": 4349.009309089217}, {"lowerIsBetter": false, "replicates": [340.1309653834453, 343.52593421078905, 348.4685854072537, 349.08539626179413, 354.26666799724575, 6202.348753380892, 6206.534509911752, 6220.253569571646, 6252.499800015999, 6380.361963803629, 6244.937550624492, 6247.7813276535335, 6284.528660350469, 6286.685665716719, 6308.211473565804, 4741.359916411292, 4759.7144171349655, 4778.4265888093305, 4783.9953609742, 4803.183458811993, 4785.282207668843, 4795.160846851804, 4800.0, 4803.423589169287, 4807.110684523374, 4667.76661166942, 4747.359106520627, 4747.90504189916, 4754.78603462845, 4759.738214398207, 4734.621230301567, 4740.525947405266, 4741.525847415265, 4742.027884283731, 4768.928466072977, 4096.40602112695, 4127.752334859918, 4128.112455821983, 4131.938020929689, 4132.607402296777, 5936.5547583931375, 5962.850928726773, 5974.3726908674835, 5975.342712301644, 6004.0693692477735, 5432.837014889559, 5528.585356098309, 5544.500994910478, 5563.721813909328, 5572.721363931787, 6666.333366663343, 6669.633170175638, 6670.6331151786635, 6680.265170831205, 6686.264510903797, 4550.453945526525, 4579.358889755437, 4584.197765391076, 4584.243599806028, 4595.908081838378, 6791.660416979181, 6878.415334696557, 6929.376356127973, 6942.813013900605, 6972.2330543640155, 4679.602233810097, 4686.671932964659, 4689.460712018094, 4691.695039822401, 4694.389729335233, 4744.667873248908, 4754.191787396151, 4757.191277482836, 4758.904821903542, 4761.738104404221, 5455.836324910179, 5484.561235101262, 5496.780128794803, 5499.835004949858, 5519.530839878656, 6521.510886683518, 6612.603243805291, 6656.83357916056, 6667.63328016954, 6676.731421029989, 1637.165045826637, 1661.609521762385, 1662.5178698177635, 1674.6315810521667, 1684.856787173104, 1090.1224514265934, 1103.3214573037524, 1104.320842681745, 1111.1444187975214, 1113.3876367997732, 6153.784617538365, 6154.846128846725, 6170.5372097092895, 6213.409726076015, 6238.064290356483, 6775.898361524581, 6812.557183783038, 6813.148356455443, 6813.454923606099, 6824.761133360308, 6026.849328766728, 6174.25908890936, 6180.938190618036, 6204.627722336674, 6208.099825525273, 3689.3359195345097, 3713.962860371416, 3715.3498137826314, 3717.9442308365396, 3720.3489389356755, 7026.191987921352, 7076.823079422953, 7082.362587367162, 7089.645517724093, 7103.644817759091, 6904.965475172692, 6914.308569143045, 6947.444204463631, 6975.546589471668, 6985.196702379291, 7178.38983686382, 7251.3836323912, 7294.416446684252, 7303.3792127668685, 7314.158871729713, 6987.161540615159, 6991.126109236346, 6992.685329160098, 6994.041668332875, 7003.859922801414, 6784.660766961731, 6796.796096117125, 6829.453643708591, 6837.692303846438, 6907.067545881242, 7226.494145409771, 7229.060222171084, 7230.409309951802, 7247.710091596277, 7264.273572642694, 4679.859604211879, 4727.905441891212, 4732.621390288838, 4732.716037037789, 4735.981763920774, 6791.932080679328, 6942.6181560012665, 6969.372756451944, 6989.440844732511, 7002.684879180347, 6732.966335168293, 6744.831379215559, 6767.323267673193, 6771.830704232237, 6778.661066946732, 6742.0, 6757.45940324763, 6763.797086087426, 6766.492513061442, 6771.153605799275, 6495.707693153725, 6579.934200657932, 6583.539152259296, 6635.137432133792, 6644.069830223676, 6780.830479238059, 6781.42357899584, 6792.354726300993, 6793.93206067933, 6800.455963523005, 6659.667016649245, 6660.6336651484635, 6661.833454163685, 6664.433523150587, 6665.0], "unit": "score", "name": "prototype.html", "value": 5012.933698352379}, {"lowerIsBetter": false, "replicates": [730.3974221267454, 810.9784847507261, 849.0702680564783, 857.9656813727447, 870.8606622940323, 15504.534863954086, 15588.298526566303, 15743.763843542327, 15793.368265269404, 15813.920930395347, 14352.210628415432, 14375.712485750279, 14407.63980900478, 14430.927845360784, 14496.637584060403, 792.1959211400405, 797.6091715059608, 801.5711594297052, 810.5582457560644, 810.7648781853285, 795.4749865089043, 803.0443771911407, 805.4522924411398, 805.524740403162, 808.3169721585281, 838.8238469921293, 839.6431516605448, 843.1147295339869, 843.5318398288947, 844.2401838345477, 824.4146655874337, 824.6206744897354, 830.1283652165203, 831.0816547714779, 841.0622156295717, 613.0497728520819, 617.4257940115691, 618.916446279751, 620.6121174266084, 623.6195920488499, 13676.726465470734, 13736.65658358549, 13845.861541384558, 13851.0, 13892.791608125886, 12904.935475322658, 12963.935180324039, 13211.405486753023, 13381.866181338159, 13456.730865382637, 10110.977804439142, 10255.6410525632, 10264.230182736324, 10292.845607315896, 10674.62638807638, 3613.765105268149, 3673.1000904778502, 3677.3748462761396, 3788.1287303919976, 3800.1069748609057, 44373.33439998403, 44552.77723611361, 44884.55115448836, 45044.54955450437, 45323.320150197775, 10118.696439106838, 10355.378677279386, 10427.739306517398, 10451.529681164366, 10525.789484210427, 18130.0, 18138.274469021355, 18194.545136371697, 18194.81805181931, 18218.817811821977, 7477.513961592479, 7909.406794490321, 8141.592920353959, 8182.549959752271, 8194.754157375288, 4128.318827393447, 4180.163967206571, 4241.87274381769, 4320.740755554614, 4374.518802931675, 2847.5443928971267, 2895.739383455457, 2906.854657267128, 2913.3153708878394, 2915.4314908593046, 525.6872161064238, 529.4573062610855, 546.8632841789553, 553.297312413241, 555.0757987950099, 523.5523627298682, 554.3292615934764, 622.4522420270133, 623.8334314831294, 636.2015670333701, 7581.545107293469, 7942.08666003417, 7942.523448592988, 7960.721374751856, 8053.557054362066, 555.8018038657101, 589.8230530840816, 635.9729037604328, 667.3060017581661, 688.5145972089665, 3839.117003089305, 3924.9018774530864, 3965.6232657897453, 4313.935290970638, 4357.542458041923, 52612.736936315836, 53628.19557706638, 53706.73146634242, 53778.193327100125, 56003.719981400645, 48523.5147648526, 48689.756551217724, 48981.510184898405, 49054.81143725647, 49122.26316605254, 40842.38736418956, 41959.16081678349, 42134.0, 42438.57561424408, 43073.13853722971, 7727.813133785633, 8251.95874020626, 8471.66113355459, 8567.0, 8807.383483156118, 30518.84740576283, 31231.84384078065, 31274.687253127177, 31277.68722312748, 31475.213119672193, 41079.38380924348, 42104.3684344729, 42199.57800422079, 42462.78768606137, 42967.785161073996, 10758.623448179276, 11025.117990560897, 11125.388103654377, 11220.55117795279, 11291.548338066385, 11159.721006974565, 11372.601958931398, 11390.373529455628, 11422.086233101165, 11779.116566257393, 10364.0, 10504.579816807242, 10549.630762923261, 10676.57293708243, 11230.157738169506, 10611.628592999208, 11151.0, 11510.769784604094, 11585.682863427517, 11907.94046029799, 10826.188035897181, 10841.295315804447, 10878.40168790724, 10886.727831804268, 11119.888801112209, 8894.599743011451, 9061.818763624822, 9347.672831450867, 9500.144986951207, 9739.902600974183, 8274.917091963267, 8927.598258078531, 9198.310126740387, 9206.355555111346, 9334.159925606727], "unit": "score", "name": "yui.html", "value": 6200.172296748788}], "name": "dromaeo_css", "value": 6732.568770362535}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 112.0, 115.0, 111.0, 121.0, 114.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 151.0, 168.0, 126.0, 148.0, 149.0, 125.0, 168.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 163.0, 164.0, 161.0, 161.0, 164.0, 170.0, 184.0], "unit": "score", "name": "audio-dft", "value": 165.4}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 74.0, 71.0, 74.0, 75.0, 71.0, 141.0, 73.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 135.0, 96.0, 97.0, 96.0, 146.0, 97.0, 96.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 111.0, 111.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 148.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 116.0, 98.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 98.4}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 58.0, 59.0, 58.0, 67.0, 58.0, 60.0, 56.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 89.0, 86.0, 87.0, 86.0, 94.0, 94.0, 96.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.1}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 120.0, 126.0, 123.0, 115.0, 117.0, 134.0, 131.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [145.0, 160.0, 145.0, 151.0, 153.0, 145.0, 155.0, 157.0, 155.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.8}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 73.0, 71.0, 75.0, 72.0, 67.0, 67.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1526.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.19612104999163], "unit": "score", "name": "Richards", "value": 211.14126199999998}, {"lowerIsBetter": false, "replicates": [188.35938971557732], "unit": "score", "name": "DeltaBlue", "value": 351.0204619999999}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "RayTrace", "value": 685.9698030000003}, {"lowerIsBetter": false, "replicates": [715.8196134574088], "unit": "score", "name": "Earley", "value": 931.0488110000001}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [41326.5306122449], "unit": "score", "name": "RegExp", "value": 22.043587654320973}, {"lowerIsBetter": false, "replicates": [566.57223796034], "unit": "score", "name": "Splay", "value": 143.83161500000003}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 20447.98083948182}]} 20:23:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20447.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1526.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6732.57"}}} 20:23:59 INFO - Return code: 0 20:23:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:23:59 INFO - # TBPL SUCCESS # 20:23:59 INFO - Running post-action listener: _resource_record_post_action 20:23:59 INFO - Running post-run listener: _resource_record_post_run 20:24:00 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 552853504; Read time: 0; Write time: 404220 20:24:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 239120384; Read time: 0; Write time: 185344 20:24:00 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 313733120; Read time: 0; Write time: 218876 20:24:00 INFO - Running post-run listener: _upload_blobber_files 20:24:00 INFO - Blob upload gear active. 20:24:00 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:24:00 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 20:24:00 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'] 20:24:00 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 20:24:01 INFO - (blobuploader) - INFO - Open directory for files ... 20:24:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:24:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:24:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:02 INFO - (blobuploader) - INFO - Done attempting. 20:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:24:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:03 INFO - (blobuploader) - INFO - Done attempting. 20:24:03 INFO - (blobuploader) - INFO - Iteration through files over. 20:24:03 INFO - Return code: 0 20:24:03 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:24:03 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:24:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9732d72aeac5cc084f4e09cf8950e8ecbc8c4a17c791ffa20f921d863ed6ccebd400f3b7b324ba80a08e97f9586afe67259a5a43758339ebf71e623821682aed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/895899e6f8874d7b5315b65591b53934eddce14d58ae3a85e09932b3aa247f5a11b8fa7319ff91b9ee810b4a2e98268fc9e369ef17f25643d5b6bd3d8abc873b"} 20:24:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:24:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:24:03 INFO - Contents: 20:24:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9732d72aeac5cc084f4e09cf8950e8ecbc8c4a17c791ffa20f921d863ed6ccebd400f3b7b324ba80a08e97f9586afe67259a5a43758339ebf71e623821682aed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/895899e6f8874d7b5315b65591b53934eddce14d58ae3a85e09932b3aa247f5a11b8fa7319ff91b9ee810b4a2e98268fc9e369ef17f25643d5b6bd3d8abc873b"} 20:24:03 INFO - Copying logs to upload dir... 20:24:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1290.829003 ========= master_lag: 2.70 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-01-12 20:24:06.045470) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 20:24:06.049849) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453 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/9732d72aeac5cc084f4e09cf8950e8ecbc8c4a17c791ffa20f921d863ed6ccebd400f3b7b324ba80a08e97f9586afe67259a5a43758339ebf71e623821682aed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/895899e6f8874d7b5315b65591b53934eddce14d58ae3a85e09932b3aa247f5a11b8fa7319ff91b9ee810b4a2e98268fc9e369ef17f25643d5b6bd3d8abc873b"} build_url:https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/YeqdKkcuQFqWdquyYXZ79Q/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/9732d72aeac5cc084f4e09cf8950e8ecbc8c4a17c791ffa20f921d863ed6ccebd400f3b7b324ba80a08e97f9586afe67259a5a43758339ebf71e623821682aed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/895899e6f8874d7b5315b65591b53934eddce14d58ae3a85e09932b3aa247f5a11b8fa7319ff91b9ee810b4a2e98268fc9e369ef17f25643d5b6bd3d8abc873b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 20:24:06.078186) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:24:06.078538) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1452653706.341625-1285088453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 20:24:06.253330) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 20:24:06.253674) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 20:24:06.254010) ========= ========= Total master_lag: 3.03 =========