builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1451490806.9 results: success (0) buildid: 20151230053003 builduid: c03bbac5a7374cbb84c1d3eb64dc7562 revision: df0d060fbe6985324f7d797fe44c7c004c0241a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:26.896032) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:26.896546) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:26.896872) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006312 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:26.920809) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:26.921277) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:26.944164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:26.944607) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:27.053735) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:27.054122) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:27.054559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:27.054883) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 07:53:28-- 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% 64.5M=0s 2015-12-30 07:53:28 (64.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164151 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:27.235153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:27.235528) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020033 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:27.286518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:27.286914) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev df0d060fbe6985324f7d797fe44c7c004c0241a3 --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 df0d060fbe6985324f7d797fe44c7c004c0241a3 --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=bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 07:53:28,450 truncating revision to first 12 chars 2015-12-30 07:53:28,450 Setting DEBUG logging. 2015-12-30 07:53:28,451 attempt 1/10 2015-12-30 07:53:28,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/df0d060fbe69?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 07:53:28,706 unpacking tar archive at: fx-team-df0d060fbe69/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552514 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:27.854054) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:27.854579) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:27.876485) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:27.877122) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 07:53:27.877915) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-30 07:53:27.878512) ========= /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=bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:53:29 INFO - MultiFileLogger online at 20151230 07:53:29 in /builds/slave/test-pgo 07:53:29 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 07:53:29 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:53:29 INFO - {'append_to_log': False, 07:53:29 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:53:29 INFO - 'blob_upload_branch': 'Fx-Team', 07:53:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:53:29 INFO - 'branch': 'Fx-Team', 07:53:29 INFO - 'buildbot_json_path': 'buildprops.json', 07:53:29 INFO - 'config_files': ('talos/linux_config.py',), 07:53:29 INFO - 'default_actions': ('clobber', 07:53:29 INFO - 'read-buildbot-config', 07:53:29 INFO - 'download-and-extract', 07:53:29 INFO - 'populate-webroot', 07:53:29 INFO - 'create-virtualenv', 07:53:29 INFO - 'install', 07:53:29 INFO - 'run-tests'), 07:53:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:53:29 INFO - 'download_minidump_stackwalk': True, 07:53:29 INFO - 'download_symbols': 'ondemand', 07:53:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:53:29 INFO - 'tooltool.py': '/tools/tooltool.py', 07:53:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:53:29 INFO - '/tools/misc-python/virtualenv.py')}, 07:53:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:53:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:53:29 INFO - 'installer_path': 'installer.exe', 07:53:29 INFO - 'log_level': 'info', 07:53:29 INFO - 'log_name': 'talos', 07:53:29 INFO - 'log_to_console': True, 07:53:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:53:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:53:29 INFO - 'opt_config_files': (), 07:53:29 INFO - 'pip_index': False, 07:53:29 INFO - 'sps_profile': False, 07:53:29 INFO - 'sps_profile_interval': 0, 07:53:29 INFO - 'suite': 'dromaeojs-e10s', 07:53:29 INFO - 'system_bits': '32', 07:53:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:53:29 INFO - 'title': 'talos-linux64-ix-062', 07:53:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:53:29 INFO - 'use_talos_json': True, 07:53:29 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:53:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:53:29 INFO - 'work_dir': 'build'} 07:53:29 INFO - ##### 07:53:29 INFO - ##### Running clobber step. 07:53:29 INFO - ##### 07:53:29 INFO - Running pre-action listener: _resource_record_pre_action 07:53:29 INFO - Running main action method: clobber 07:53:29 INFO - rmtree: /builds/slave/test-pgo/build 07:53:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:53:30 INFO - Running post-action listener: _resource_record_post_action 07:53:30 INFO - ##### 07:53:30 INFO - ##### Running read-buildbot-config step. 07:53:30 INFO - ##### 07:53:30 INFO - Running pre-action listener: _resource_record_pre_action 07:53:30 INFO - Running main action method: read_buildbot_config 07:53:30 INFO - Using buildbot properties: 07:53:30 INFO - { 07:53:30 INFO - "project": "", 07:53:30 INFO - "product": "firefox", 07:53:30 INFO - "script_repo_revision": "production", 07:53:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:53:30 INFO - "repository": "", 07:53:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 07:53:30 INFO - "buildid": "20151230053003", 07:53:30 INFO - "pgo_build": "True", 07:53:30 INFO - "basedir": "/builds/slave/test-pgo", 07:53:30 INFO - "buildnumber": 415, 07:53:30 INFO - "slavename": "talos-linux64-ix-062", 07:53:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:53:30 INFO - "platform": "ubuntu64_hw", 07:53:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:53:30 INFO - "branch": "fx-team", 07:53:30 INFO - "repo_path": "integration/fx-team", 07:53:30 INFO - "revision": "df0d060fbe6985324f7d797fe44c7c004c0241a3", 07:53:30 INFO - "stage_platform": "linux64-pgo", 07:53:30 INFO - "builduid": "c03bbac5a7374cbb84c1d3eb64dc7562", 07:53:30 INFO - "slavebuilddir": "test" 07:53:30 INFO - } 07:53:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:53:30 INFO - Running post-action listener: _resource_record_post_action 07:53:30 INFO - ##### 07:53:30 INFO - ##### Running download-and-extract step. 07:53:30 INFO - ##### 07:53:30 INFO - Running pre-action listener: _resource_record_pre_action 07:53:30 INFO - Running main action method: download_and_extract 07:53:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:30 INFO - https://queue.taskcluster.net/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:53:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/test_packages.json 07:53:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/test_packages.json 07:53:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:53:35 INFO - Downloaded 1302 bytes. 07:53:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:53:35 INFO - Using the following test package requirements: 07:53:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:53:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:53:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:35 INFO - u'jsshell-linux-x86_64.zip'], 07:53:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:53:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:53:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:53:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:53:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:53:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:53:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:53:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:53:35 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')]} 07:53:35 INFO - https://queue.taskcluster.net/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:53:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/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 07:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/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 07:53:48 INFO - Downloaded 23201960 bytes. 07:53:48 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 07:53:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:48 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 07:53:49 INFO - Return code: 0 07:53:49 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 07:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:49 INFO - https://queue.taskcluster.net/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:53:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/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 07:53:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/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 07:53:50 INFO - Downloaded 23201960 bytes. 07:53:50 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 07:53:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:50 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 07:53:51 INFO - Return code: 0 07:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:51 INFO - https://queue.taskcluster.net/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:53:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/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 07:53:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/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 07:53:52 INFO - Downloaded 11132285 bytes. 07:53:52 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 07:53:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:52 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 07:53:52 INFO - Return code: 0 07:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:52 INFO - https://queue.taskcluster.net/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:53:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/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 07:53:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/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 07:53:54 INFO - Downloaded 54937847 bytes. 07:53:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:54 INFO - mkdir: /builds/slave/test-pgo/properties 07:53:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:53:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:53:54 INFO - Contents: 07:53:54 INFO - build_url:https://queue.taskcluster.net/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:54 INFO - Running post-action listener: _resource_record_post_action 07:53:54 INFO - Running post-action listener: set_extra_try_arguments 07:53:54 INFO - ##### 07:53:54 INFO - ##### Running populate-webroot step. 07:53:54 INFO - ##### 07:53:54 INFO - Running pre-action listener: _resource_record_pre_action 07:53:54 INFO - Running main action method: populate_webroot 07:53:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:53:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:53:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:53:54 INFO - '--tppagecycles', 07:53:54 INFO - '7'], 07:53:54 INFO - 'tests': ['tsvgm']}}, 07:53:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:53:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:53:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:53:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:53:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:53:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:53:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:54 INFO - 'talos_options': ['--e10s'], 07:53:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:54 INFO - 'tests': ['damp', 'tps']}, 07:53:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:54 INFO - 'talos_options': ['--e10s'], 07:53:54 INFO - 'tests': ['damp', 'tps']}, 07:53:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:53:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:53:54 INFO - 'other': {'tests': ['a11yr', 07:53:54 INFO - 'ts_paint', 07:53:54 INFO - 'tpaint', 07:53:54 INFO - 'sessionrestore', 07:53:54 INFO - 'sessionrestore_no_auto_restore']}, 07:53:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:53:54 INFO - 'tests': ['a11yr', 07:53:54 INFO - 'ts_paint', 07:53:54 INFO - 'tpaint', 07:53:54 INFO - 'sessionrestore', 07:53:54 INFO - 'sessionrestore_no_auto_restore']}, 07:53:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:53:54 INFO - 'tests': ['a11yr', 07:53:54 INFO - 'ts_paint', 07:53:54 INFO - 'tpaint', 07:53:54 INFO - 'sessionrestore', 07:53:54 INFO - 'sessionrestore_no_auto_restore']}, 07:53:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:53:54 INFO - 'tests': ['a11yr', 07:53:54 INFO - 'ts_paint', 07:53:54 INFO - 'tpaint', 07:53:54 INFO - 'sessionrestore', 07:53:54 INFO - 'sessionrestore_no_auto_restore']}, 07:53:54 INFO - 'other_l64': {'tests': ['a11yr', 07:53:54 INFO - 'ts_paint', 07:53:54 INFO - 'tpaint', 07:53:54 INFO - 'sessionrestore', 07:53:54 INFO - 'sessionrestore_no_auto_restore']}, 07:53:54 INFO - 'other_nol64': {'tests': ['a11yr', 07:53:54 INFO - 'ts_paint', 07:53:54 INFO - 'tpaint', 07:53:54 INFO - 'sessionrestore', 07:53:54 INFO - 'sessionrestore_no_auto_restore']}, 07:53:54 INFO - 'svgr': {'tests': ['tsvgx', 07:53:54 INFO - 'tsvgr_opacity', 07:53:54 INFO - 'tart', 07:53:54 INFO - 'tscrollx', 07:53:54 INFO - 'cart']}, 07:53:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:53:54 INFO - 'tests': ['tsvgx', 07:53:54 INFO - 'tsvgr_opacity', 07:53:54 INFO - 'tart', 07:53:54 INFO - 'tscrollx', 07:53:54 INFO - 'cart']}, 07:53:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:54 INFO - 'tests': ['tp5o']}, 07:53:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:54 INFO - 'talos_options': ['--e10s'], 07:53:54 INFO - 'tests': ['tp5o']}, 07:53:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:54 INFO - 'talos_options': ['--xperf_path', 07:53:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:54 INFO - 'tests': ['tp5n']}, 07:53:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:54 INFO - 'talos_options': ['--e10s', 07:53:54 INFO - '--xperf_path', 07:53:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:54 INFO - 'tests': ['tp5n']}}, 07:53:54 INFO - 'talos.zip': {'path': '', 07:53:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:53:54 INFO - Running post-action listener: _resource_record_post_action 07:53:54 INFO - ##### 07:53:54 INFO - ##### Running create-virtualenv step. 07:53:54 INFO - ##### 07:53:54 INFO - Running pre-action listener: _resource_record_pre_action 07:53:54 INFO - Running main action method: create_virtualenv 07:53:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:53:54 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 07:53:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:53:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:53:54 INFO - Using real prefix '/usr' 07:53:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:53:54 INFO - Installing distribute.............................................................................................................................................................................................done. 07:53:56 INFO - Installing pip.................done. 07:53:56 INFO - Return code: 0 07:53:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:53:56 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')]} 07:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:56 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')]} 07:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:56 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 0x7f77f10d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30660>, '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 0x2a31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', '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 07:53:56 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 07:53:56 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 07:53:56 INFO - Using env: {'DISPLAY': ':0', 07:53:56 INFO - 'HOME': '/home/cltbld', 07:53:56 INFO - 'LANG': 'en_US.UTF-8', 07:53:56 INFO - 'LANGUAGE': 'en_US:en', 07:53:56 INFO - 'LOGNAME': 'cltbld', 07:53:56 INFO - 'MAIL': '/var/mail/cltbld', 07:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:56 INFO - 'MOZ_NO_REMOTE': '1', 07:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:56 INFO - 'NO_EM_RESTART': '1', 07:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:56 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:56 INFO - 'SHELL': '/bin/bash', 07:53:56 INFO - 'SHLVL': '1', 07:53:56 INFO - 'TERM': 'linux', 07:53:56 INFO - 'TMOUT': '86400', 07:53:56 INFO - 'USER': 'cltbld', 07:53:56 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', 07:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:56 INFO - '_': '/tools/buildbot/bin/python'} 07:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:56 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 07:53:56 INFO - Cleaning up... 07:53:56 INFO - Return code: 0 07:53:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:53:56 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')]} 07:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:56 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')]} 07:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:56 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 0x7f77f10d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30660>, '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 0x2a31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', '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 07:53:56 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 07:53:56 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 07:53:56 INFO - Using env: {'DISPLAY': ':0', 07:53:56 INFO - 'HOME': '/home/cltbld', 07:53:56 INFO - 'LANG': 'en_US.UTF-8', 07:53:56 INFO - 'LANGUAGE': 'en_US:en', 07:53:56 INFO - 'LOGNAME': 'cltbld', 07:53:56 INFO - 'MAIL': '/var/mail/cltbld', 07:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:56 INFO - 'MOZ_NO_REMOTE': '1', 07:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:56 INFO - 'NO_EM_RESTART': '1', 07:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:56 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:56 INFO - 'SHELL': '/bin/bash', 07:53:56 INFO - 'SHLVL': '1', 07:53:56 INFO - 'TERM': 'linux', 07:53:56 INFO - 'TMOUT': '86400', 07:53:56 INFO - 'USER': 'cltbld', 07:53:56 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', 07:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:56 INFO - '_': '/tools/buildbot/bin/python'} 07:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:57 INFO - Downloading/unpacking psutil>=0.7.1 07:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:53:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:53:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:53:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:58 INFO - Installing collected packages: psutil 07:53:58 INFO - Running setup.py install for psutil 07:53:58 INFO - building 'psutil._psutil_linux' extension 07:53:58 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 07:53:59 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 07:53:59 INFO - building 'psutil._psutil_posix' extension 07:53:59 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 07:53:59 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 07:53:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:59 INFO - Successfully installed psutil 07:53:59 INFO - Cleaning up... 07:53:59 INFO - Return code: 0 07:53:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:59 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 0x7f77f10d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30660>, '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 0x2a31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', '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 07:53:59 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 07:53:59 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 07:53:59 INFO - Using env: {'DISPLAY': ':0', 07:53:59 INFO - 'HOME': '/home/cltbld', 07:53:59 INFO - 'LANG': 'en_US.UTF-8', 07:53:59 INFO - 'LANGUAGE': 'en_US:en', 07:53:59 INFO - 'LOGNAME': 'cltbld', 07:53:59 INFO - 'MAIL': '/var/mail/cltbld', 07:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:59 INFO - 'MOZ_NO_REMOTE': '1', 07:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:59 INFO - 'NO_EM_RESTART': '1', 07:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:59 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:59 INFO - 'SHELL': '/bin/bash', 07:53:59 INFO - 'SHLVL': '1', 07:53:59 INFO - 'TERM': 'linux', 07:53:59 INFO - 'TMOUT': '86400', 07:53:59 INFO - 'USER': 'cltbld', 07:53:59 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', 07:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:59 INFO - '_': '/tools/buildbot/bin/python'} 07:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:54:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:54:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:54:01 INFO - Installing collected packages: mozsystemmonitor 07:54:01 INFO - Running setup.py install for mozsystemmonitor 07:54:01 INFO - Successfully installed mozsystemmonitor 07:54:01 INFO - Cleaning up... 07:54:01 INFO - Return code: 0 07:54:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:54: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')]} 07:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f77f10d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30660>, '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 0x2a31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', '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 07:54:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:54:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:54:01 INFO - Using env: {'DISPLAY': ':0', 07:54:01 INFO - 'HOME': '/home/cltbld', 07:54:01 INFO - 'LANG': 'en_US.UTF-8', 07:54:01 INFO - 'LANGUAGE': 'en_US:en', 07:54:01 INFO - 'LOGNAME': 'cltbld', 07:54:01 INFO - 'MAIL': '/var/mail/cltbld', 07:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:01 INFO - 'MOZ_NO_REMOTE': '1', 07:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:01 INFO - 'NO_EM_RESTART': '1', 07:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:54:01 INFO - 'PWD': '/builds/slave/test-pgo', 07:54:01 INFO - 'SHELL': '/bin/bash', 07:54:01 INFO - 'SHLVL': '1', 07:54:01 INFO - 'TERM': 'linux', 07:54:01 INFO - 'TMOUT': '86400', 07:54:01 INFO - 'USER': 'cltbld', 07:54:01 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', 07:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:01 INFO - '_': '/tools/buildbot/bin/python'} 07:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:01 INFO - Downloading/unpacking blobuploader==1.2.4 07:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:03 INFO - Downloading blobuploader-1.2.4.tar.gz 07:54:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:54:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:54:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:54:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:54:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:04 INFO - Downloading docopt-0.6.1.tar.gz 07:54:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:54:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:54:04 INFO - Installing collected packages: blobuploader, requests, docopt 07:54:04 INFO - Running setup.py install for blobuploader 07:54:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:54:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:54:04 INFO - Running setup.py install for requests 07:54:04 INFO - Running setup.py install for docopt 07:54:04 INFO - Successfully installed blobuploader requests docopt 07:54:04 INFO - Cleaning up... 07:54:04 INFO - Return code: 0 07:54:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:04 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 0x7f77f10d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30660>, '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 0x2a31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', '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 07:54:04 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 07:54:04 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 07:54:04 INFO - Using env: {'DISPLAY': ':0', 07:54:04 INFO - 'HOME': '/home/cltbld', 07:54:04 INFO - 'LANG': 'en_US.UTF-8', 07:54:04 INFO - 'LANGUAGE': 'en_US:en', 07:54:04 INFO - 'LOGNAME': 'cltbld', 07:54:04 INFO - 'MAIL': '/var/mail/cltbld', 07:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:04 INFO - 'MOZ_NO_REMOTE': '1', 07:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:04 INFO - 'NO_EM_RESTART': '1', 07:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:54:04 INFO - 'PWD': '/builds/slave/test-pgo', 07:54:04 INFO - 'SHELL': '/bin/bash', 07:54:04 INFO - 'SHLVL': '1', 07:54:04 INFO - 'TERM': 'linux', 07:54:04 INFO - 'TMOUT': '86400', 07:54:04 INFO - 'USER': 'cltbld', 07:54:04 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', 07:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:04 INFO - '_': '/tools/buildbot/bin/python'} 07:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:54:04 INFO - Running setup.py (path:/tmp/pip-xSH2tm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:54:05 INFO - Running setup.py (path:/tmp/pip-9S4vMd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:54:05 INFO - Running setup.py (path:/tmp/pip-S_CV8r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:54:05 INFO - Running setup.py (path:/tmp/pip-ey2A28-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:54:05 INFO - Running setup.py (path:/tmp/pip-GVK8n8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:54:05 INFO - Running setup.py (path:/tmp/pip-giUVD_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:54:05 INFO - Running setup.py (path:/tmp/pip-3yACuc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:54:05 INFO - Running setup.py (path:/tmp/pip-GAO_y3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:54:05 INFO - Running setup.py (path:/tmp/pip-j9BCH1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:54:05 INFO - Running setup.py (path:/tmp/pip-kFOe2P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:54:05 INFO - Running setup.py (path:/tmp/pip-F3FRka-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:54:05 INFO - Running setup.py (path:/tmp/pip-6g25Qo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:54:05 INFO - Running setup.py (path:/tmp/pip-xLRYyS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:54:05 INFO - Running setup.py (path:/tmp/pip-U0oZie-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:54:05 INFO - Running setup.py (path:/tmp/pip-VlcdHD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:54:06 INFO - Running setup.py (path:/tmp/pip-CVxZjI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:54:06 INFO - Running setup.py (path:/tmp/pip-HVMeF_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:54:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:54:06 INFO - Running setup.py install for manifestparser 07:54:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:54:06 INFO - Running setup.py install for mozcrash 07:54:06 INFO - Running setup.py install for mozdebug 07:54:06 INFO - Running setup.py install for mozdevice 07:54:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:54:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:54:06 INFO - Running setup.py install for mozfile 07:54:06 INFO - Running setup.py install for mozhttpd 07:54:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:54:06 INFO - Running setup.py install for mozinfo 07:54:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:54:06 INFO - Running setup.py install for mozInstall 07:54:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:54:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:54:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:54:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:54:07 INFO - Running setup.py install for mozleak 07:54:07 INFO - Running setup.py install for mozlog 07:54:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:54:07 INFO - Running setup.py install for moznetwork 07:54:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:54:07 INFO - Running setup.py install for mozprocess 07:54:07 INFO - Running setup.py install for mozprofile 07:54:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:54:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:54:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:54:07 INFO - Running setup.py install for mozrunner 07:54:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:54:07 INFO - Running setup.py install for mozscreenshot 07:54:07 INFO - Running setup.py install for moztest 07:54:07 INFO - Running setup.py install for mozversion 07:54:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:54:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:54:07 INFO - Cleaning up... 07:54:08 INFO - Return code: 0 07:54:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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', '-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 0x7f77f10d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30660>, '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 0x2a31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', '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 07:54:08 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 07:54:08 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 07:54:08 INFO - Using env: {'DISPLAY': ':0', 07:54:08 INFO - 'HOME': '/home/cltbld', 07:54:08 INFO - 'LANG': 'en_US.UTF-8', 07:54:08 INFO - 'LANGUAGE': 'en_US:en', 07:54:08 INFO - 'LOGNAME': 'cltbld', 07:54:08 INFO - 'MAIL': '/var/mail/cltbld', 07:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:08 INFO - 'MOZ_NO_REMOTE': '1', 07:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:08 INFO - 'NO_EM_RESTART': '1', 07:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:54:08 INFO - 'PWD': '/builds/slave/test-pgo', 07:54:08 INFO - 'SHELL': '/bin/bash', 07:54:08 INFO - 'SHLVL': '1', 07:54:08 INFO - 'TERM': 'linux', 07:54:08 INFO - 'TMOUT': '86400', 07:54:08 INFO - 'USER': 'cltbld', 07:54:08 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', 07:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:08 INFO - '_': '/tools/buildbot/bin/python'} 07:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:54:08 INFO - Running setup.py (path:/tmp/pip-w20R1t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:54:08 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)) 07:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:54:08 INFO - Running setup.py (path:/tmp/pip-JfDSxo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:54:08 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)) 07:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:54:08 INFO - Running setup.py (path:/tmp/pip-slOL_T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:54:08 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)) 07:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:54:08 INFO - Running setup.py (path:/tmp/pip-C6ju79-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:54:08 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)) 07:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:54:08 INFO - Running setup.py (path:/tmp/pip-blKUnN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:54:08 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)) 07:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:54:08 INFO - Running setup.py (path:/tmp/pip-Lf9UWD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:54:08 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)) 07:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:54:08 INFO - Running setup.py (path:/tmp/pip-5qCTk2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:54:08 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)) 07:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:54:08 INFO - Running setup.py (path:/tmp/pip-T9vSjD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:54:08 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)) 07:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:54:08 INFO - Running setup.py (path:/tmp/pip-1TlPEd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:54:08 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)) 07:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:54:08 INFO - Running setup.py (path:/tmp/pip-jkUtL9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:54:08 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)) 07:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:54:08 INFO - Running setup.py (path:/tmp/pip-0zlaSQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:54:09 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)) 07:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:54:09 INFO - Running setup.py (path:/tmp/pip-RQrYsH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:54:09 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)) 07:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:54:09 INFO - Running setup.py (path:/tmp/pip-kWCswl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:54:09 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)) 07:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:54:09 INFO - Running setup.py (path:/tmp/pip-4EZGRr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:54:09 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)) 07:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:54:09 INFO - Running setup.py (path:/tmp/pip-ksjFU7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:54:09 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)) 07:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:54:09 INFO - Running setup.py (path:/tmp/pip-mKkjyN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:54:09 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)) 07:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:54:09 INFO - Running setup.py (path:/tmp/pip-9ziIN_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:54:09 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)) 07:54:09 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)) 07:54:09 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)) 07:54:09 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)) 07:54:09 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)) 07:54:09 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)) 07:54:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:54:09 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 07:54:09 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 07:54:09 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 07:54:09 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 07:54:09 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 07:54:09 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 07:54:11 INFO - Downloading blessings-1.5.1.tar.gz 07:54:11 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 07:54:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:54:11 INFO - Installing collected packages: blessings 07:54:11 INFO - Running setup.py install for blessings 07:54:11 INFO - Successfully installed blessings 07:54:11 INFO - Cleaning up... 07:54:11 INFO - Return code: 0 07:54:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:54:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:54:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:54:11 INFO - Reading from file tmpfile_stdout 07:54:11 INFO - Current package versions: 07:54:11 INFO - argparse == 1.2.1 07:54:11 INFO - blessings == 1.5.1 07:54:11 INFO - blobuploader == 1.2.4 07:54:11 INFO - docopt == 0.6.1 07:54:11 INFO - manifestparser == 1.1 07:54:11 INFO - mozInstall == 1.12 07:54:11 INFO - mozcrash == 0.16 07:54:11 INFO - mozdebug == 0.1 07:54:11 INFO - mozdevice == 0.47 07:54:11 INFO - mozfile == 1.2 07:54:11 INFO - mozhttpd == 0.7 07:54:11 INFO - mozinfo == 0.9 07:54:11 INFO - mozleak == 0.1 07:54:11 INFO - mozlog == 3.1 07:54:11 INFO - moznetwork == 0.27 07:54:11 INFO - mozprocess == 0.22 07:54:11 INFO - mozprofile == 0.28 07:54:11 INFO - mozrunner == 6.11 07:54:11 INFO - mozscreenshot == 0.1 07:54:11 INFO - mozsystemmonitor == 0.0 07:54:11 INFO - moztest == 0.7 07:54:11 INFO - mozversion == 1.4 07:54:11 INFO - psutil == 3.1.1 07:54:11 INFO - requests == 1.2.3 07:54:11 INFO - wsgiref == 0.1.2 07:54:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:54: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')]} 07:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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', '-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 0x7f77f10d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30660>, '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 0x2a31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', '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 07:54:11 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 07:54:11 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 07:54:11 INFO - Using env: {'DISPLAY': ':0', 07:54:11 INFO - 'HOME': '/home/cltbld', 07:54:11 INFO - 'LANG': 'en_US.UTF-8', 07:54:11 INFO - 'LANGUAGE': 'en_US:en', 07:54:11 INFO - 'LOGNAME': 'cltbld', 07:54:11 INFO - 'MAIL': '/var/mail/cltbld', 07:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:11 INFO - 'MOZ_NO_REMOTE': '1', 07:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:11 INFO - 'NO_EM_RESTART': '1', 07:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:54:11 INFO - 'PWD': '/builds/slave/test-pgo', 07:54:11 INFO - 'SHELL': '/bin/bash', 07:54:11 INFO - 'SHLVL': '1', 07:54:11 INFO - 'TERM': 'linux', 07:54:11 INFO - 'TMOUT': '86400', 07:54:11 INFO - 'USER': 'cltbld', 07:54:11 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', 07:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:11 INFO - '_': '/tools/buildbot/bin/python'} 07:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:11 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)) 07:54:11 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)) 07:54:11 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)) 07:54:11 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)) 07:54:11 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)) 07:54:11 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)) 07:54:11 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)) 07:54:11 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)) 07:54:11 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)) 07:54:11 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)) 07:54:11 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)) 07:54:11 INFO - Cleaning up... 07:54:11 INFO - Return code: 0 07:54:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:54: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')]} 07:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f77f10d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30660>, '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 0x2a31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', '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 07:54: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', 'jsonschema'] in /builds/slave/test-pgo/build 07:54: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 jsonschema 07:54:11 INFO - Using env: {'DISPLAY': ':0', 07:54:11 INFO - 'HOME': '/home/cltbld', 07:54:11 INFO - 'LANG': 'en_US.UTF-8', 07:54:11 INFO - 'LANGUAGE': 'en_US:en', 07:54:11 INFO - 'LOGNAME': 'cltbld', 07:54:11 INFO - 'MAIL': '/var/mail/cltbld', 07:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:11 INFO - 'MOZ_NO_REMOTE': '1', 07:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:11 INFO - 'NO_EM_RESTART': '1', 07:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:54:11 INFO - 'PWD': '/builds/slave/test-pgo', 07:54:11 INFO - 'SHELL': '/bin/bash', 07:54:11 INFO - 'SHLVL': '1', 07:54:11 INFO - 'TERM': 'linux', 07:54:11 INFO - 'TMOUT': '86400', 07:54:11 INFO - 'USER': 'cltbld', 07:54:11 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', 07:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:11 INFO - '_': '/tools/buildbot/bin/python'} 07:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:12 INFO - Downloading/unpacking jsonschema 07:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:54:13 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 07:54:13 INFO - Downloading/unpacking functools32 (from jsonschema) 07:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:13 INFO - Downloading functools32-3.2.3-2.tar.gz 07:54:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:54:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:54:13 INFO - warning: no files found matching '*.txt' 07:54:13 INFO - no previously-included directories found matching 'build' 07:54:13 INFO - no previously-included directories found matching 'dist' 07:54:13 INFO - no previously-included directories found matching '.git*' 07:54:13 INFO - Installing collected packages: jsonschema, functools32 07:54:14 INFO - Running setup.py install for functools32 07:54:14 INFO - warning: no files found matching '*.txt' 07:54:14 INFO - no previously-included directories found matching 'build' 07:54:14 INFO - no previously-included directories found matching 'dist' 07:54:14 INFO - no previously-included directories found matching '.git*' 07:54:14 INFO - Successfully installed jsonschema functools32 07:54:14 INFO - Cleaning up... 07:54:14 INFO - Return code: 0 07:54:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:54:14 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')]} 07:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:14 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')]} 07:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:14 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 0x7f77f10d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a30660>, '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 0x2a31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31a10>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', '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 07:54:14 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 07:54:14 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 07:54:14 INFO - Using env: {'DISPLAY': ':0', 07:54:14 INFO - 'HOME': '/home/cltbld', 07:54:14 INFO - 'LANG': 'en_US.UTF-8', 07:54:14 INFO - 'LANGUAGE': 'en_US:en', 07:54:14 INFO - 'LOGNAME': 'cltbld', 07:54:14 INFO - 'MAIL': '/var/mail/cltbld', 07:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:14 INFO - 'MOZ_NO_REMOTE': '1', 07:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:14 INFO - 'NO_EM_RESTART': '1', 07:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:54:14 INFO - 'PWD': '/builds/slave/test-pgo', 07:54:14 INFO - 'SHELL': '/bin/bash', 07:54:14 INFO - 'SHLVL': '1', 07:54:14 INFO - 'TERM': 'linux', 07:54:14 INFO - 'TMOUT': '86400', 07:54:14 INFO - 'USER': 'cltbld', 07:54:14 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', 07:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:14 INFO - '_': '/tools/buildbot/bin/python'} 07:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:14 INFO - Downloading/unpacking flake8 07:54:14 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 07:54:14 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 07:54:14 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 07:54:14 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 07:54:14 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 07:54:14 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 07:54:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:54:16 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 07:54:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:54:16 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 07:54:16 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 07:54:16 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 07:54:16 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 07:54:16 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 07:54:16 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 07:54:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:54:16 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 07:54:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:54:16 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 07:54:16 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 07:54:16 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 07:54:16 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 07:54:16 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 07:54:16 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 07:54:16 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 07:54:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:54:16 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 07:54:16 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 07:54:16 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 07:54:16 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 07:54:16 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 07:54:16 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 07:54:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:54:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:54:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:54:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:54:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:54:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:54:16 INFO - no previously-included directories found matching 'docs/_build' 07:54:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:54:16 INFO - Running setup.py install for pep8 07:54:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:54:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:54:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:54:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:54:16 INFO - no previously-included directories found matching 'docs/_build' 07:54:16 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:54:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:54:16 INFO - Cleaning up... 07:54:16 INFO - Return code: 0 07:54:16 INFO - Running post-action listener: _resource_record_post_action 07:54:16 INFO - Running post-action listener: _start_resource_monitoring 07:54:16 INFO - Starting resource monitoring. 07:54:16 INFO - ##### 07:54:16 INFO - ##### Running install step. 07:54:16 INFO - ##### 07:54:16 INFO - Running pre-action listener: _resource_record_pre_action 07:54:16 INFO - Running main action method: install 07:54:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:54:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:54:17 INFO - Reading from file tmpfile_stdout 07:54:17 INFO - Detecting whether we're running mozinstall >=1.0... 07:54:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:54:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:54:17 INFO - Reading from file tmpfile_stdout 07:54:17 INFO - Output received: 07:54:17 INFO - Usage: mozinstall [options] installer 07:54:17 INFO - Options: 07:54:17 INFO - -h, --help show this help message and exit 07:54:17 INFO - -d DEST, --destination=DEST 07:54:17 INFO - Directory to install application into. [default: 07:54:17 INFO - "/builds/slave/test-pgo"] 07:54:17 INFO - --app=APP Application being installed. [default: firefox] 07:54:17 INFO - mkdir: /builds/slave/test-pgo/build/application 07:54:17 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'] 07:54:17 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 07:54:33 INFO - Reading from file tmpfile_stdout 07:54:33 INFO - Output received: 07:54:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:54:33 INFO - Running post-action listener: _resource_record_post_action 07:54:33 INFO - ##### 07:54:33 INFO - ##### Running run-tests step. 07:54:33 INFO - ##### 07:54:33 INFO - Running pre-action listener: _resource_record_pre_action 07:54:33 INFO - Running main action method: run_tests 07:54:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:54:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:54:33 INFO - Python 2.7.3 07:54:33 INFO - Return code: 0 07:54:33 INFO - grabbing minidump binary from tooltool 07:54: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')]} 07:54:33 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 0x2a30660>, '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 0x2a31560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a31a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:54:33 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 07:54:33 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 07:54:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:54:33 INFO - Return code: 0 07:54:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:54:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:54:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:54:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:54:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:54:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:54:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:54:34 INFO - Return code: 0 07:54:34 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/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 07:54:34 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/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 07:54:34 INFO - Using env: {'DISPLAY': ':0', 07:54:34 INFO - 'HOME': '/home/cltbld', 07:54:34 INFO - 'LANG': 'en_US.UTF-8', 07:54:34 INFO - 'LANGUAGE': 'en_US:en', 07:54:34 INFO - 'LOGNAME': 'cltbld', 07:54:34 INFO - 'MAIL': '/var/mail/cltbld', 07:54:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:54:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:34 INFO - 'MOZ_NO_REMOTE': '1', 07:54:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:34 INFO - 'NO_EM_RESTART': '1', 07:54:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:54:34 INFO - 'PWD': '/builds/slave/test-pgo', 07:54:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:54:34 INFO - 'SHELL': '/bin/bash', 07:54:34 INFO - 'SHLVL': '1', 07:54:34 INFO - 'TERM': 'linux', 07:54:34 INFO - 'TMOUT': '86400', 07:54:34 INFO - 'USER': 'cltbld', 07:54:34 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703', 07:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:34 INFO - '_': '/tools/buildbot/bin/python'} 07:54:34 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/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 07:54:34 INFO - mozversion application_buildid: 20151230053003 07:54:34 INFO - mozversion application_changeset: df0d060fbe6985324f7d797fe44c7c004c0241a3 07:54:34 INFO - mozversion application_display_name: Nightly 07:54:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:54:34 INFO - mozversion application_name: Firefox 07:54:34 INFO - mozversion application_remotingname: firefox 07:54:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:54:34 INFO - mozversion application_vendor: Mozilla 07:54:34 INFO - mozversion application_version: 46.0a1 07:54:34 INFO - mozversion platform_buildid: 20151230053003 07:54:34 INFO - mozversion platform_changeset: df0d060fbe6985324f7d797fe44c7c004c0241a3 07:54:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:54:34 INFO - mozversion platform_version: 46.0a1 07:54:34 INFO - using testdate: 1451490874 07:54:34 INFO - actual date: 1451490874 07:54:34 INFO - starting webserver on 'localhost:43311' 07:54:34 INFO - SUITE-START | Running 3 tests 07:54:34 INFO - TEST-START | dromaeo_css 07:54:34 INFO - operating with platform_type : linux_ 07:54:34 INFO - Initialising browser for dromaeo_css test... 07:54:34 INFO - TEST-INFO | started process 28234 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyJJ1T7/profile http://localhost:43311/getInfo.html) 07:54:38 INFO - PROCESS | 28234 | __metrics Screen width/height:1600/1200 07:54:38 INFO - PROCESS | 28234 | colorDepth:24 07:54:38 INFO - PROCESS | 28234 | Browser inner width/height: 1024/697 07:54:38 INFO - PROCESS | 28234 | __metrics 07:54:38 INFO - PROCESS | 28234 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:54:39 INFO - TEST-INFO | 28234: exit 0 07:54:39 INFO - Browser initialized. 07:54:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:54:39 INFO - TEST-INFO | started process 28367 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyJJ1T7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:51 INFO - PROCESS | 28367 | RSS: Main: 150052864 07:54:51 INFO - PROCESS | 28367 | 07:55:41 INFO - PROCESS | 28367 | 1451490941253 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] 07:57:50 INFO - PROCESS | 28367 | Cycle 1(1): loaded http://localhost:43311/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43311/tests/dromaeo/cssquery-ext.html) 07:57:51 INFO - PROCESS | 28367 | RSS: Main: 157245440 07:57:51 INFO - PROCESS | 28367 | 08:00:53 INFO - PROCESS | 28367 | Cycle 1(1): loaded http://localhost:43311/tests/dromaeo/cssquery-ext.html (next: http://localhost:43311/tests/dromaeo/cssquery-jquery.html) 08:00:54 INFO - PROCESS | 28367 | RSS: Main: 151998464 08:00:54 INFO - PROCESS | 28367 | 08:03:55 INFO - PROCESS | 28367 | Cycle 1(1): loaded http://localhost:43311/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43311/tests/dromaeo/cssquery-mootools.html) 08:03:56 INFO - PROCESS | 28367 | RSS: Main: 153546752 08:03:56 INFO - PROCESS | 28367 | 08:06:58 INFO - PROCESS | 28367 | Cycle 1(1): loaded http://localhost:43311/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43311/tests/dromaeo/cssquery-prototype.html) 08:06:58 INFO - PROCESS | 28367 | RSS: Main: 152236032 08:06:58 INFO - PROCESS | 28367 | 08:10:01 INFO - PROCESS | 28367 | Cycle 1(1): loaded http://localhost:43311/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43311/tests/dromaeo/cssquery-yui.html) 08:10:01 INFO - PROCESS | 28367 | RSS: Main: 153104384 08:10:01 INFO - PROCESS | 28367 | 08:13:03 INFO - PROCESS | 28367 | Cycle 1(1): loaded http://localhost:43311/tests/dromaeo/cssquery-yui.html (next: http://localhost:43311/tests/dromaeo/cssquery-dojo.html) 08:13:04 INFO - PROCESS | 28367 | RSS: Main: 154574848 08:13:04 INFO - PROCESS | 28367 | 08:13:04 INFO - PROCESS | 28367 | __start_tp_report 08:13:04 INFO - PROCESS | 28367 | _x_x_mozilla_page_load 08:13:04 INFO - PROCESS | 28367 | _x_x_mozilla_page_load_details 08:13:04 INFO - PROCESS | 28367 | |i|pagename|runs| 08:13:04 INFO - PROCESS | 28367 | |0;dojo.html;3207.7113059824615;3246.577944867167;3293.2096296888753;3293.8023718576887;3295.5715756951595;5279.736013199344;5406.432324605918;5415.404305526394;5429.185622156679;5443.428440013796;5307.442718514559;5329.786808527654;5420.322459692538;5495.395506494292;5504.339479262484;5011.473795251501;5070;5124.743762811863;5156.484351564851;5156.845294641167;4981.37732783402;5049.520295571933;5057.645964782467;5065.7467126643705;5101.081805275049;4861.343718598015;4941.901161976776;4974.950250497485;5031.867829738316;5051.873703157414;5010.599152067826;5012.498750124995;5031.748412579356;5033.647644664875;5038.420581633086;4914.803407863681;4965.354503914504;4971.204607262821;5008.924866126975;5040.042391945519;5201.505856943584;5202.4277329493725;5279.392869819982;5339.119045357511;5349.625526213166;5908.97045514774;5919.112133180014;5946.07835785454;5947.583669143161;5965.13505541694;5958.940410595926;5966.910496342558;5973.163757074013;5980.581359304851;5986.580939334249;5369.650972686723;5412.107002344608;5458.590605704549;5506.311711036121;5554.250176226198;5928.229330187048;5950;5963.224780778558;5977.073553599199;5993.790217342372;5757.827265182052;5770.855728606818;5771.220885180531;5775;5777.740001699934;5695.088785794253;5727.828165155052;5783.624064435799;5829.679367634736;5890.263717035371;5867.2959244890035;5873.941260587425;5880.8235752927485;5896.086106653475;5898.1152827076285;5664.660120392789;5784.768609255582;5833.79581714638;5857.7949771757785;5875.29496460419;4421.955780442155;4430.446194225722;4446.755428451402;4464.15181115587;4523.344115103291;3954.268460334847;3959.1883663848844;3976.900577485528;3985.3822657488136;4013.337799263147;5311.442298558673;5448.346198456211;5456.645318054314;5468.043092458804;5474.288342515448;5750.2524671793235;5751;5751.741171647286;5765.04876695349;5769.394213607595;5313.840584782462;5324.334458192726;5363.249145119687;5372.489613486712;5531.419200983919;5051.924221136685;5063.1645778446145;5070.29015937769;5087.186050231945;5118.206677964921;6055.273367195965;6063.272407311151;6068.848278792977;6089.269287685506;6090.756369745249;5626.915596266142;5718.971405142947;5727.455891690282;5788.363280039276;5875.471207591338;6093.695315234309;6099.11562823397;6144.139820425234;6160.722767475385;6178.752849885954;5882.441168089024;5890.52875769946;5897.498712609477;5900.64596124234;5911.261092363455;5753.942460575341;5853.736581853912;5889.646621202742;5969.313528944227;5980.37206093354;5817.941820581909;5825.155352473952;5840.2991641003355;5847.152162936265;5859.677717725566;5777.884442311214;5792.420757924174;5798.188253644409;5806.129080637769;5833.329167145833;5489.780408783764;5579.414161513145;5599.468050535193;5669.206311116364;5710.800121995876;5675.971620142038;5691.260136182435;5714.714264286686;5728.054870946414;5766.769329226784;5550.7779688812;5568.359638641446;5568.832935011957;5609.74756135983;5623.690697011703 08:13:04 INFO - PROCESS | 28367 | |1;ext.html;503.28030915790407;524.9711265880376;533.7571405010721;533.9519443250107;557.5762420560375;28296;28654;36195.819020904855;36356.81821590888;36424;38648.22703545928;39059.41410878839;39158;39333.21333573327;39464.21071578574;8458.069612342653;8553.786155346135;8571.571421428935;8594.355423343242;8624.051354351048;8355.874661880076;8496.872546911802;8503.149685031509;8508.446950948199;8525.786855328635;8315.750527484186;8316.916830831675;8517.74446766598;8517.914820851805;8527.104654011333;8570.100139485357;8574.056853746082;8624.784380390478;8646.092160323138;8651.351148663813;8432.367572432093;8560.0583935767;8601.182887625666;8614.483131012159;8623.439476434074;38520.61479385226;38953.610463895566;38993.41509877354;39002.414963775285;39043.60956390428;3004.7746419018445;3057.143999680093;3086.36729470458;3210.9036728897936;3384.712299454525;28861.71138288611;28899.277518062005;29177.56233656497;29216;29669.70330296691;3678.3746763050344;3832.7891965941863;3848.3457812171996;3901.356276214421;3909.3745000799736;216520;218251;218489;219197;219217.90391048102;54142.729286353315;54760.72619636956;55157.724211379485;55219.44780552143;55224.72387638116;64471.35528644748;64917.350826492075;65328;65554.34445655577;65654.67172664106;15221.31504082319;15247.3901043957;15250.627443530135;15332.693346133015;15381.923265371317;11679.766404671858;11707.356095414663;11781.882181178078;11869.940650296694;11870.634876989257;19510;20022;20047.59904801925;20056;20109.39671809848;8074.677012919417;8213.439446505145;8249;8272.751817445485;8295.875561866576;896.7578753736585;898.7887846356101;942.4345392764286;946.4226821638795;1101.6309536305428;28165;28291.71708282891;28336.8583157087;28376.85811570929;28925.566116508267;1070.1759645073405;1135.0408904475705;1142.822862456304;1145.7937571237258;1196.6768972377583;14560.854391456161;14655.193964331851;14674;14943.476978305707;15004.774928376082;304811;307710;307941;308154;309148;49673.503264967614;50740;50883.745581271854;50890;50993;1363.4409891944256;1366.9658258543418;1369.6438925879145;1377.393946663465;1382.2950295349244;27001.594976074983;27873.860630697527;27967.58048629313;28156;28355.716442835306;44511.77744111259;45014.324785127596;45462;45476;45601;286763;287816;288767;289129;290296;31909;42728.78635606802;42984;43199;43761.78119109384;39735.602643974344;40260.39609405803;40292.3956140664;40369.1926161481;40591.1881762369;33827.3234535303;34183;34396.108214048465;34678.653213468555;34875.4768678465;35830.28339433249;36161.734339298;36436;37875.431868521446;39707.2058558833;34981.47527787136;37743.81128094342;37874.810625946695;38711.22577548377;38740.80629596834;27815.924177203928;32352;32802.67197327996;32808.34383312368;32964.835175823966;24891.675485713262;25216.369590760376;25242;25371.61942570826;25607.23178304654 08:13:04 INFO - PROCESS | 28367 | |2;jquery.html;351.4622627380109;352.10213954416247;355.5182727404367;357.88547664747284;358.2119337457594;15787.131707756069;16318.83681163188;16975.74536381955;17117.31530738769;18006.459806205803;10843;11376.772464550724;15776.368945242177;15823.84176158238;15930;4738.384010078685;4889.364382630253;5086.109930762121;5089.75301051243;5113.872153196163;4391.846285380012;5139.663687441255;5171;5193.16909294513;5200.453952335007;5028.069807085682;5102.693838369692;5115.104856650071;5187.6628019178825;5202.297689811884;5106.540411362977;5111.105556527611;5138.332016837825;5139.922901156486;5560.360558535739;5068.898622027539;5110.310108135392;5116.795328186868;5122.1036318644465;5125.589952803767;12141.519955389174;20014.79985200144;20119.497012574804;20611.072501737457;20870.686939695915;2119.480727221825;2133.125418578391;2148.140743702516;2159.373781603349;2222.5777102350503;11130.05394541465;12905.096643234978;12934.547290844775;12974.35128243584;13113.86886131136;1727.550836782433;1776.9022703751289;1812.9818701812944;1817.818218178185;1820.5084627150727;55017.1747423793;55308;55834;59053.91353037663;63055.68472157656;9839.901600984042;10400.739981500372;10451.425171615634;10456.058954693963;10518.631847885288;13539.66150846217;13608.38762255701;13648.454061837614;13671.86328136706;13703.588892333246;7372;7547.8113047173165;7802.960985195038;7826.295633393022;7861;7555.24447555251;7570.394368450511;7595;7613.733519326797;7620.466567340233;4496.392986946786;4510.797014134372;4556.886077848014;4598.563136502027;4611.5619016193405;1811.3117015534276;1864.3102052240758;1928.9035548222532;1937.3509874192303;1943.6112777444569;802.8875957365973;888.9022207557164;893.3657103456619;965.9951700241454;1047.5652604169184;16386;16392;16758.32966681319;16865.241064151898;17124.229409676595;885.0132102705437;885.4510203673635;894.2935081285711;944.8252073366449;1007.2948935745007;8502.872456913152;8693.043765185825;8717.869231961526;8917.955410222907;8949.686760963465;560625;569205;574070;580596;597830;55689.44310556923;77318.6134069326;79642;81582.18417815864;84530;1148.655403378983;1149;1162.6105254739757;1169.9590514331958;1177.7232350397649;14068.437262509386;14335.856641433453;14368.784468233194;14462.855371446572;14974.52175258413;33022.00933971984;33136.50295245525;33613.32773344568;34021;34475;39380.409293860044;42110.36834447547;42735;45049.77475112603;45830.77084614689;9204.815903682023;9208.802855628725;9242.537873106452;9424.434533927986;9521.238300936047;13379.866201337862;16561.25474353633;16634.58413539671;16719.582010449834;16849.41027064047;11310.717232068935;12288.938555307166;13856.168629882239;13994.65013374633;14111.506097286545;13810.240436776074;13852.515161969282;13990.300484975915;14056.859431405555;14418;13996.37016334247;14220.431182752574;14313.71372572522;14376.065555738844;14687.192204428859;9248.907510925073;9423.858642120511;9473.052694730472;9513.476758778334;9516.23870090405;14178.432862685377;14399.208043557705;14457.493987710379;14739.705205896036;14860.925695371454 08:13:04 INFO - PROCESS | 28367 | |3;mootools.html;1436.8347640021395;1467.1417220925755;1605.4942693051687;1742.0592879844885;1767.1605987156095;6510.153680021603;6573.276939536647;7065.929340706592;7214.819629509265;7233.927660723391;6872.381485666289;6985.336393042666;7030.402415794651;7046.330598593138;7096.042034325377;2143.3677065265706;2172.3482955113404;2180.4439867833757;2181.9454513637206;2184.9344519664355;2207.5143468437;2224.877631730254;2229.0860747093693;2235.765244649313;2240.10395841663;2116.2698868890284;2132.2856842957626;2145.410012246629;2170.403139136742;2174.554216385645;2196.7363916330064;2232.352617740861;2233.039792889057;2233.8101261392803;2240.137547044383;2162.6864104704887;2194.3855720398315;2197.7142971413773;2204.492966617671;2207.2164381644607;7245.673944672502;7299.270072992711;7302.160251571084;7323.304286092813;7409.147947985996;4425.7565833879125;4432.113577284524;4453.51011388747;4461.643068554507;4482.21561226784;2877.0505733108025;2903.3177203357195;2919.50368437364;2925.0054981306457;2927.224285564327;901.328510259854;917.7934964632971;936.2416442681382;959.299711210813;960.0798403193613;9657.46883921384;9812.018798120202;9821.852672209923;9827.754306142404;9834.360766550151;3868.767873927517;3970.940435893464;3980.124372638015;3996.620321069494;4017.879463616096;7752.147263800977;7761.573113478813;7794.844103117905;7846.293833555007;7867.567283799446;4331.155424692218;4346.434963454731;4356.3683265926265;4369.563043695605;4371.628411584988;3655.8354874030733;3704.8518059277326;3995.2409042282457;4045.150518391171;4075.653569446571;3324.7173990211104;3327.301266734013;3337.399268131711;3368.1579605098727;3372.072680012967;983.5180761426849;1020.2756043209256;1025.6102980461367;1026.3687831983277;1027.2039169643585;1258.52485512673;1294.1717300927414;1298.3248710670398;1337.1776357540236;1341.0277548777058;6935.895961560581;6947.89578156328;6981.79054628362;6987.510874238857;6988.475864310197;477.72530794793136;493.2157868988254;499.73763774018204;500.17720849202857;503.64996327552734;5522.723863806794;5563.13771365439;5575.275214222125;5580;5597.860053498695;8450.704225352083;8456.830863382698;8602.139786021473;8674.219320261207;8789.208971192624;8560.357973152039;8587.484750914966;8601.397902146915;8604.182602652738;8628.396012279205;6681.098051763047;6716.1604799400075;6726;6852.657367131624;6904.827379315457;6688.862893308246;6733.326667333227;6745.527813053235;6751.257361690112;6762.188537375547;7659.540427574363;7677.193894641206;7715.151333353215;7756.8448631028195;7833.49082309648;7781.26078022587;7866.331361834308;7964.800879978047;7967.800804979922;8173.468724532886;5548.528375088163;5597.328320601554;6008.279006519246;6038.969805150946;6080.513558915188;6735.898961515483;6810.6594670265295;6845.14435695538;6857.142857142857;6861.725530978705;6070.3929607038945;6150.815475535741;6196.194494715658;6244.875102498016;6265.216847894013;6372.458341041063;6374.776882809079;6391.808245752635;6497.512686548623;6515.087887695821;6278.277998030285;6312.526560508072;6336.334684858023;6442.065900444316;6454.838629034311;5865.061590145556;5891.852703682271;5895.20414744004;5932.733027013708;6026.90959635597;5927.051671732502;6030.306514750684;6033.215681961317;6056.121862329849;6059.939400606114 08:13:04 INFO - PROCESS | 28367 | |4;prototype.html;318.82942625695256;323.37104332074097;327.29794590603154;328.4252558023459;335.95464612277334;6323.430891219789;6363.0773537836985;6397.520185986046;6399.296077431491;6491.221053473578;6134.386561343875;6222.937770622292;6223.844403889905;6255.968720156393;6263.436290733833;4829.010052939139;4842.394700662418;4851.563359297663;4858.441279252896;4867.318575399447;4859.101066302727;4860.05228980349;4866.83196032953;4867.318575399447;4880.121578115938;4707.576318131368;4828.97585512072;4834.347363105989;4841.2012018016985;4849.587785038276;4780.020095880353;4781.187198176283;4782.976085119587;4822.5900798432;4840.927386089176;4180.393842892763;4194.328907374806;4206.936895946563;4207.242696314662;4221.345691417804;6030.849228769272;6031.336552979169;6040.063790112539;6047.667378294192;6049.5462840287155;5423.9694458052845;5601.047821870292;5616.66300022;5622.269105016363;5644.955683198621;6768.39084482394;6814.931850681529;6850.0752398426075;6859.9314006859795;6881.346272104192;4541.8410355637725;4542.568455996675;4574.6340292776495;4594.977025114853;4598.333241679938;6939.271376505495;6969.128858892638;7018.227994920555;7042.471814613873;7077.292270772933;4696.929546056812;4698.1778188816825;4707.270373092176;4712;4714.905701885943;4751.477337492873;4758.16732071893;4762.928556071662;4763.309320148559;4773.76131193439;5568.52667523257;5572.804951826666;5574.275344205227;5578.30271216098;5580.051391263495;6575.967120164369;6735.528513004043;6741.685371352637;6776.796696099125;6780.423663988518;1647.7198876191076;1668.3576822923262;1687.5190570687296;1692.246950107215;1699.17589968865;1087.217203613397;1098.3355070182583;1103.9558417663204;1111.766529028897;1121.6578943422335;6178.598391104564;6243.250809902841;6260.593061450991;6266.686665666698;6394.968025159845;6879.3120687930805;6905.274946130584;6922.203946546111;6950.3049695030095;6954.687039083254;6159.6140868305165;6299.842503937438;6307.96846015767;6354.618722876642;6379.202599675041;3752.249550089993;3774.9245015099546;3777.20678657485;3781.829817658212;3788.242351529705;7175.17485489165;7204.459665525106;7222.313880181375;7228.277172282729;7232.0959880015;7005.719771209095;7029.925482001312;7113.7510187144235;7152.642367881585;7159.713611455483;7040.331168538981;7155.785326440215;7173.282671732785;7187.31720486553;7208.423326133897;6940.271271516418;6940.930590694028;6942.652867356511;6961.61711105894;6971.895421568579;6789.93210067893;6864.897026544506;6877.3810357068105;6884.5180837342905;6951.8609627806145;7289.56262624223;7380.704771809067;7383.483156179016;7387.667554959932;7413.369863561657;4694.201985662514;4705.952940470552;4712.3873896394625;4744.572988431058;4748.525147485224;6864.21061577925;7077.787666370017;7086.858262834818;7119.288071192839;7136.9286307138345;6891.104156459829;6896.413804826646;6911.930880691129;6934.583924964519;6937.098177236927;6863.210730765826;6897.379235868796;6898.413634840894;6911.481638877004;6919.411849992807;6618.503612229006;6755.6622168892345;6759.391654751096;6763.222229443677;6772.0857684212;6879.931200687929;6905.102336696197;6911.412529935012;6912.896306555305;6943.722251110101;6556.639384833689;6714.83212919681;6717.966410167918;6739.898901516579;6774.153230846145 08:13:04 INFO - PROCESS | 28367 | |5;yui.html;684.6610927590843;807.3460496997433;817.5952903312859;825.4840724547158;839.46274384394;13124.737505249901;13245.735085298289;13327.867541193411;13423.93288033561;13471.932640336785;10554.366737995726;12669.448640671659;12740.745185096292;12794.936025319861;12828.230306181636;805.9838803223932;816.4325793573469;821.342925659473;823.4688625836332;824.5423789796661;830.6511265268572;831.6507067031831;833.5998720614109;841.6296829395077;841.9536925469097;868.9217970382664;871.0592560035178;876.701921346742;877.0177401310541;880.5993273060774;871.612132600996;874.6719980007497;875.4397185801092;875.4790899414838;879.4151888993812;638.0333794301637;640.8333833203401;642.6979319719771;644.5939058393229;648.251269783401;11611.07111431092;11621.651350459415;11659.825102623467;11725.70685732855;11741.647750567497;9818.950905245429;10059.748506287402;10470.214733894913;10961.56153753849;11035.668929932115;9345.495439210295;9469.479178645171;9525.952370238174;9526.809463810685;9615.615375384976;3553.7867727936405;3572.9464058039152;3576.5886923003927;3584.193556449804;3627.220147668264;44207;44547.55452445467;45191.54808451906;45914.31128533041;46659;8846.271892913954;8954.686585969459;9191.448513089235;9358.625654973725;9417.105374989365;16440.917795411187;16496;16588.336466541445;16596.419125330554;16943.068131252898;6963.9303606963285;7276.527025743309;7289.817754556072;7397.26027397256;7444.553326800409;4206.053637931441;4212.620864122183;4293.91412171761;4299.398084268205;4350.282203436397;2922.6054482644995;2923.5906973023793;2934.9434203686656;2935.0314396249187;2936.1044881310977;547.4963034008722;556.5436342199357;556.6020295488745;558.9413111623302;570.6262398129232;441.4944888103104;468.9648276379285;469.4132334581773;473.00668595948235;525.7634064670837;7588.81027974305;7848.803779905434;8046.0344758629335;8316.584170791437;8519.403641745143;453.78672024148597;453.80259587079723;531.6305167908266;549.3161014536927;567.5908591126571;3681.4661874028116;3780.3006443807985;3802.634668318558;3896.4350169225304;3929.7052721046034;51962;52440.73779631077;52617.47382526202;53019.34903254822;54682;47885.76057119692;49208.753956229986;49313.26030109551;49343;49431.75284123628;44308.11383772307;44988.55011449909;45141.774291128335;45974.310385344244;48351.758241209274;7650.885236721342;7655.425843061904;7784.065912090586;7812.453128280966;8163.959180204061;33753.32493350168;34200.82899585486;34398.65601343955;34787.826060870546;34843.128921776144;40812.59187408088;41896;44753.77623111994;45818;45977.77011114923;9026.368154229403;9105.954470227607;9315.673951411669;9340.626374944926;9446.952765236405;10184.287099902936;10445.097366602376;10579.32259392873;10614.469276536296;10673.57305707763;9922.503874806374;9962.900370996198;10373.377597344184;10374.27380083387;10578.735531611772;10134.797304054026;10283.537240824331;10297.53661085238;10374.118199952787;10499.895001050198;9145.542722863696;9813.656522021694;9828.803423931624;10013.39919604826;10209.132223760766;8592.312614990911;8656.437331573428;8697.565121744014;8983.685571004984;9084.545772711206;8244.216799404046;8319;8382;8385.580720963806;8716.60775265102 08:13:04 INFO - PROCESS | 28367 | __end_tp_report 08:13:04 INFO - PROCESS | 28367 | __start_cc_report 08:13:04 INFO - PROCESS | 28367 | _x_x_mozilla_cycle_collect,325 08:13:04 INFO - PROCESS | 28367 | __end_cc_report 08:13:04 INFO - PROCESS | 28367 | __startTimestamp1451491984016__endTimestamp 08:13:04 INFO - PROCESS | 28367 | 08:13:04 INFO - PROCESS | 28367 | ------- Summary: start ------- 08:13:04 INFO - PROCESS | 28367 | Number of tests: 6 08:13:04 INFO - PROCESS | 28367 | 08:13:04 INFO - PROCESS | 28367 | [#0] dojo.html Cycles:165 Average:5437.31 Median:5623.69 stddev:609.88 (10.8%) stddev-sans-first:586.13 08:13:04 INFO - PROCESS | 28367 | Values: 3207.7 3246.6 3293.2 3293.8 3295.6 5279.7 5406.4 5415.4 5429.2 5443.4 5307.4 5329.8 5420.3 5495.4 5504.3 5011.5 5070.0 5124.7 5156.5 5156.8 4981.4 5049.5 5057.6 5065.7 5101.1 4861.3 4941.9 4975.0 5031.9 5051.9 5010.6 5012.5 5031.7 5033.6 5038.4 4914.8 4965.4 4971.2 5008.9 5040.0 5201.5 5202.4 5279.4 5339.1 5349.6 5909.0 5919.1 5946.1 5947.6 5965.1 5958.9 5966.9 5973.2 5980.6 5986.6 5369.7 5412.1 5458.6 5506.3 5554.3 5928.2 5950.0 5963.2 5977.1 5993.8 5757.8 5770.9 5771.2 5775.0 5777.7 5695.1 5727.8 5783.6 5829.7 5890.3 5867.3 5873.9 5880.8 5896.1 5898.1 5664.7 5784.8 5833.8 5857.8 5875.3 4422.0 4430.4 4446.8 4464.2 4523.3 3954.3 3959.2 3976.9 3985.4 4013.3 5311.4 5448.3 5456.6 5468.0 5474.3 5750.3 5751.0 5751.7 5765.0 5769.4 5313.8 5324.3 5363.2 5372.5 5531.4 5051.9 5063.2 5070.3 5087.2 5118.2 6055.3 6063.3 6068.8 6089.3 6090.8 5626.9 5719.0 5727.5 5788.4 5875.5 6093.7 6099.1 6144.1 6160.7 6178.8 5882.4 5890.5 5897.5 5900.6 5911.3 5753.9 5853.7 5889.6 5969.3 5980.4 5817.9 5825.2 5840.3 5847.2 5859.7 5777.9 5792.4 5798.2 5806.1 5833.3 5489.8 5579.4 5599.5 5669.2 5710.8 5676.0 5691.3 5714.7 5728.1 5766.8 5550.8 5568.4 5568.8 5609.7 5623.7 08:13:04 INFO - PROCESS | 28367 | 08:13:04 INFO - PROCESS | 28367 | [#1] ext.html Cycles:180 Average:44391.19 Median:20057.19 stddev:71585.09 (356.9%) stddev-sans-first:71710.05 08:13:04 INFO - PROCESS | 28367 | Values: 503.3 525.0 533.8 534.0 557.6 28296.0 28654.0 36195.8 36356.8 36424.0 38648.2 39059.4 39158.0 39333.2 39464.2 8458.1 8553.8 8571.6 8594.4 8624.1 8355.9 8496.9 8503.1 8508.4 8525.8 8315.8 8316.9 8517.7 8517.9 8527.1 8570.1 8574.1 8624.8 8646.1 8651.4 8432.4 8560.1 8601.2 8614.5 8623.4 38520.6 38953.6 38993.4 39002.4 39043.6 3004.8 3057.1 3086.4 3210.9 3384.7 28861.7 28899.3 29177.6 29216.0 29669.7 3678.4 3832.8 3848.3 3901.4 3909.4 216520.0 218251.0 218489.0 219197.0 219217.9 54142.7 54760.7 55157.7 55219.4 55224.7 64471.4 64917.4 65328.0 65554.3 65654.7 15221.3 15247.4 15250.6 15332.7 15381.9 11679.8 11707.4 11781.9 11869.9 11870.6 19510.0 20022.0 20047.6 20056.0 20109.4 8074.7 8213.4 8249.0 8272.8 8295.9 896.8 898.8 942.4 946.4 1101.6 28165.0 28291.7 28336.9 28376.9 28925.6 1070.2 1135.0 1142.8 1145.8 1196.7 14560.9 14655.2 14674.0 14943.5 15004.8 304811.0 307710.0 307941.0 308154.0 309148.0 49673.5 50740.0 50883.7 50890.0 50993.0 1363.4 1367.0 1369.6 1377.4 1382.3 27001.6 27873.9 27967.6 28156.0 28355.7 44511.8 45014.3 45462.0 45476.0 45601.0 286763.0 287816.0 288767.0 289129.0 290296.0 31909.0 42728.8 42984.0 43199.0 43761.8 39735.6 40260.4 40292.4 40369.2 40591.2 33827.3 34183.0 34396.1 34678.7 34875.5 35830.3 36161.7 36436.0 37875.4 39707.2 34981.5 37743.8 37874.8 38711.2 38740.8 27815.9 32352.0 32802.7 32808.3 32964.8 24891.7 25216.4 25242.0 25371.6 25607.2 08:13:04 INFO - PROCESS | 28367 | 08:13:04 INFO - PROCESS | 28367 | [#2] jquery.html Cycles:180 Average:29383.95 Median:17413.23 stddev:94087.63 (540.3%) stddev-sans-first:94326.31 08:13:04 INFO - PROCESS | 28367 | Values: 351.5 352.1 355.5 357.9 358.2 15787.1 16318.8 16975.7 17117.3 18006.5 10843.0 11376.8 15776.4 15823.8 15930.0 4738.4 4889.4 5086.1 5089.8 5113.9 4391.8 5139.7 5171.0 5193.2 5200.5 5028.1 5102.7 5115.1 5187.7 5202.3 5106.5 5111.1 5138.3 5139.9 5560.4 5068.9 5110.3 5116.8 5122.1 5125.6 12141.5 20014.8 20119.5 20611.1 20870.7 2119.5 2133.1 2148.1 2159.4 2222.6 11130.1 12905.1 12934.5 12974.4 13113.9 1727.6 1776.9 1813.0 1817.8 1820.5 55017.2 55308.0 55834.0 59053.9 63055.7 9839.9 10400.7 10451.4 10456.1 10518.6 13539.7 13608.4 13648.5 13671.9 13703.6 7372.0 7547.8 7803.0 7826.3 7861.0 7555.2 7570.4 7595.0 7613.7 7620.5 4496.4 4510.8 4556.9 4598.6 4611.6 1811.3 1864.3 1928.9 1937.4 1943.6 802.9 888.9 893.4 966.0 1047.6 16386.0 16392.0 16758.3 16865.2 17124.2 885.0 885.5 894.3 944.8 1007.3 8502.9 8693.0 8717.9 8918.0 8949.7 560625.0 569205.0 574070.0 580596.0 597830.0 55689.4 77318.6 79642.0 81582.2 84530.0 1148.7 1149.0 1162.6 1170.0 1177.7 14068.4 14335.9 14368.8 14462.9 14974.5 33022.0 33136.5 33613.3 34021.0 34475.0 39380.4 42110.4 42735.0 45049.8 45830.8 9204.8 9208.8 9242.5 9424.4 9521.2 13379.9 16561.3 16634.6 16719.6 16849.4 11310.7 12288.9 13856.2 13994.7 14111.5 13810.2 13852.5 13990.3 14056.9 14418.0 13996.4 14220.4 14313.7 14376.1 14687.2 9248.9 9423.9 9473.1 9513.5 9516.2 14178.4 14399.2 14457.5 14739.7 14860.9 08:13:04 INFO - PROCESS | 28367 | 08:13:04 INFO - PROCESS | 28367 | [#3] mootools.html Cycles:180 Average:5016.82 Median:6047.55 stddev:2562.96 (42.4%) stddev-sans-first:2556.03 08:13:04 INFO - PROCESS | 28367 | Values: 1436.8 1467.1 1605.5 1742.1 1767.2 6510.2 6573.3 7065.9 7214.8 7233.9 6872.4 6985.3 7030.4 7046.3 7096.0 2143.4 2172.3 2180.4 2181.9 2184.9 2207.5 2224.9 2229.1 2235.8 2240.1 2116.3 2132.3 2145.4 2170.4 2174.6 2196.7 2232.4 2233.0 2233.8 2240.1 2162.7 2194.4 2197.7 2204.5 2207.2 7245.7 7299.3 7302.2 7323.3 7409.1 4425.8 4432.1 4453.5 4461.6 4482.2 2877.1 2903.3 2919.5 2925.0 2927.2 901.3 917.8 936.2 959.3 960.1 9657.5 9812.0 9821.9 9827.8 9834.4 3868.8 3970.9 3980.1 3996.6 4017.9 7752.1 7761.6 7794.8 7846.3 7867.6 4331.2 4346.4 4356.4 4369.6 4371.6 3655.8 3704.9 3995.2 4045.2 4075.7 3324.7 3327.3 3337.4 3368.2 3372.1 983.5 1020.3 1025.6 1026.4 1027.2 1258.5 1294.2 1298.3 1337.2 1341.0 6935.9 6947.9 6981.8 6987.5 6988.5 477.7 493.2 499.7 500.2 503.6 5522.7 5563.1 5575.3 5580.0 5597.9 8450.7 8456.8 8602.1 8674.2 8789.2 8560.4 8587.5 8601.4 8604.2 8628.4 6681.1 6716.2 6726.0 6852.7 6904.8 6688.9 6733.3 6745.5 6751.3 6762.2 7659.5 7677.2 7715.2 7756.8 7833.5 7781.3 7866.3 7964.8 7967.8 8173.5 5548.5 5597.3 6008.3 6039.0 6080.5 6735.9 6810.7 6845.1 6857.1 6861.7 6070.4 6150.8 6196.2 6244.9 6265.2 6372.5 6374.8 6391.8 6497.5 6515.1 6278.3 6312.5 6336.3 6442.1 6454.8 5865.1 5891.9 5895.2 5932.7 6026.9 5927.1 6030.3 6033.2 6056.1 6059.9 08:13:04 INFO - PROCESS | 28367 | 08:13:04 INFO - PROCESS | 28367 | [#4] prototype.html Cycles:180 Average:5636.51 Median:6303.91 stddev:1725.85 (27.4%) stddev-sans-first:1683.90 08:13:04 INFO - PROCESS | 28367 | Values: 318.8 323.4 327.3 328.4 336.0 6323.4 6363.1 6397.5 6399.3 6491.2 6134.4 6222.9 6223.8 6256.0 6263.4 4829.0 4842.4 4851.6 4858.4 4867.3 4859.1 4860.1 4866.8 4867.3 4880.1 4707.6 4829.0 4834.3 4841.2 4849.6 4780.0 4781.2 4783.0 4822.6 4840.9 4180.4 4194.3 4206.9 4207.2 4221.3 6030.8 6031.3 6040.1 6047.7 6049.5 5424.0 5601.0 5616.7 5622.3 5645.0 6768.4 6814.9 6850.1 6859.9 6881.3 4541.8 4542.6 4574.6 4595.0 4598.3 6939.3 6969.1 7018.2 7042.5 7077.3 4696.9 4698.2 4707.3 4712.0 4714.9 4751.5 4758.2 4762.9 4763.3 4773.8 5568.5 5572.8 5574.3 5578.3 5580.1 6576.0 6735.5 6741.7 6776.8 6780.4 1647.7 1668.4 1687.5 1692.2 1699.2 1087.2 1098.3 1104.0 1111.8 1121.7 6178.6 6243.3 6260.6 6266.7 6395.0 6879.3 6905.3 6922.2 6950.3 6954.7 6159.6 6299.8 6308.0 6354.6 6379.2 3752.2 3774.9 3777.2 3781.8 3788.2 7175.2 7204.5 7222.3 7228.3 7232.1 7005.7 7029.9 7113.8 7152.6 7159.7 7040.3 7155.8 7173.3 7187.3 7208.4 6940.3 6940.9 6942.7 6961.6 6971.9 6789.9 6864.9 6877.4 6884.5 6951.9 7289.6 7380.7 7383.5 7387.7 7413.4 4694.2 4706.0 4712.4 4744.6 4748.5 6864.2 7077.8 7086.9 7119.3 7136.9 6891.1 6896.4 6911.9 6934.6 6937.1 6863.2 6897.4 6898.4 6911.5 6919.4 6618.5 6755.7 6759.4 6763.2 6772.1 6879.9 6905.1 6911.4 6912.9 6943.7 6556.6 6714.8 6718.0 6739.9 6774.2 08:13:04 INFO - PROCESS | 28367 | 08:13:04 INFO - PROCESS | 28367 | [#5] yui.html Cycles:180 Average:12938.64 Median:52201.37 stddev:15278.96 (29.3%) stddev-sans-first:15294.11 08:13:04 INFO - PROCESS | 28367 | Values: 684.7 807.3 817.6 825.5 839.5 13124.7 13245.7 13327.9 13423.9 13471.9 10554.4 12669.4 12740.7 12794.9 12828.2 806.0 816.4 821.3 823.5 824.5 830.7 831.7 833.6 841.6 842.0 868.9 871.1 876.7 877.0 880.6 871.6 874.7 875.4 875.5 879.4 638.0 640.8 642.7 644.6 648.3 11611.1 11621.7 11659.8 11725.7 11741.6 9819.0 10059.7 10470.2 10961.6 11035.7 9345.5 9469.5 9526.0 9526.8 9615.6 3553.8 3572.9 3576.6 3584.2 3627.2 44207.0 44547.6 45191.5 45914.3 46659.0 8846.3 8954.7 9191.4 9358.6 9417.1 16440.9 16496.0 16588.3 16596.4 16943.1 6963.9 7276.5 7289.8 7397.3 7444.6 4206.1 4212.6 4293.9 4299.4 4350.3 2922.6 2923.6 2934.9 2935.0 2936.1 547.5 556.5 556.6 558.9 570.6 441.5 469.0 469.4 473.0 525.8 7588.8 7848.8 8046.0 8316.6 8519.4 453.8 453.8 531.6 549.3 567.6 3681.5 3780.3 3802.6 3896.4 3929.7 51962.0 52440.7 52617.5 53019.3 54682.0 47885.8 49208.8 49313.3 49343.0 49431.8 44308.1 44988.6 45141.8 45974.3 48351.8 7650.9 7655.4 7784.1 7812.5 8164.0 33753.3 34200.8 34398.7 34787.8 34843.1 40812.6 41896.0 44753.8 45818.0 45977.8 9026.4 9106.0 9315.7 9340.6 9447.0 10184.3 10445.1 10579.3 10614.5 10673.6 9922.5 9962.9 10373.4 10374.3 10578.7 10134.8 10283.5 10297.5 10374.1 10499.9 9145.5 9813.7 9828.8 10013.4 10209.1 8592.3 8656.4 8697.6 8983.7 9084.5 8244.2 8319.0 8382.0 8385.6 8716.6 08:13:04 INFO - PROCESS | 28367 | -------- Summary: end -------- 08:13:04 INFO - PROCESS | 28367 | 08:13:04 INFO - TEST-INFO | 28367: exit 0 08:13:04 INFO - TEST-OK | dromaeo_css | took 1110385ms 08:13:04 INFO - TEST-START | kraken 08:13:04 INFO - operating with platform_type : linux_ 08:13:04 INFO - Initialising browser for kraken test... 08:13:04 INFO - TEST-INFO | started process 28611 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3o8gQJ/profile http://localhost:43311/getInfo.html) 08:13:09 INFO - PROCESS | 28611 | __metrics Screen width/height:1600/1200 08:13:09 INFO - PROCESS | 28611 | colorDepth:24 08:13:09 INFO - PROCESS | 28611 | Browser inner width/height: 1024/697 08:13:09 INFO - PROCESS | 28611 | __metrics 08:13:09 INFO - PROCESS | 28611 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:13:10 INFO - TEST-INFO | 28611: exit 0 08:13:10 INFO - Browser initialized. 08:13:10 INFO - Running cycle 1/1 for kraken test... 08:13:10 INFO - TEST-INFO | started process 28730 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3o8gQJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:21 INFO - PROCESS | 28730 | RSS: Main: 150003712 08:13:21 INFO - PROCESS | 28730 | 08:13:24 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43311/tests/kraken/driver.html?testName=audio-beat-detection) 08:13:24 INFO - PROCESS | 28730 | RSS: Main: 151789568 08:13:24 INFO - PROCESS | 28730 | 08:13:27 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43311/tests/kraken/driver.html?testName=audio-dft) 08:13:28 INFO - PROCESS | 28730 | RSS: Main: 151785472 08:13:28 INFO - PROCESS | 28730 | 08:13:31 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43311/tests/kraken/driver.html?testName=audio-fft) 08:13:31 INFO - PROCESS | 28730 | RSS: Main: 146268160 08:13:31 INFO - PROCESS | 28730 | 08:13:33 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43311/tests/kraken/driver.html?testName=audio-oscillator) 08:13:34 INFO - PROCESS | 28730 | RSS: Main: 146210816 08:13:34 INFO - PROCESS | 28730 | 08:13:36 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43311/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:13:37 INFO - PROCESS | 28730 | RSS: Main: 146419712 08:13:37 INFO - PROCESS | 28730 | 08:13:40 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43311/tests/kraken/driver.html?testName=imaging-darkroom) 08:13:41 INFO - PROCESS | 28730 | RSS: Main: 146706432 08:13:41 INFO - PROCESS | 28730 | 08:13:44 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43311/tests/kraken/driver.html?testName=imaging-desaturate) 08:13:45 INFO - PROCESS | 28730 | RSS: Main: 148045824 08:13:45 INFO - PROCESS | 28730 | 08:13:47 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43311/tests/kraken/driver.html?testName=json-parse-financial) 08:13:48 INFO - PROCESS | 28730 | RSS: Main: 148602880 08:13:48 INFO - PROCESS | 28730 | 08:13:50 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43311/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:13:50 INFO - PROCESS | 28730 | RSS: Main: 149082112 08:13:50 INFO - PROCESS | 28730 | 08:13:52 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43311/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:13:53 INFO - PROCESS | 28730 | RSS: Main: 147845120 08:13:53 INFO - PROCESS | 28730 | 08:13:55 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43311/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:13:55 INFO - PROCESS | 28730 | RSS: Main: 149778432 08:13:55 INFO - PROCESS | 28730 | 08:13:58 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:13:58 INFO - PROCESS | 28730 | RSS: Main: 149041152 08:13:58 INFO - PROCESS | 28730 | 08:14:01 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:14:02 INFO - PROCESS | 28730 | RSS: Main: 149970944 08:14:02 INFO - PROCESS | 28730 | 08:14:03 INFO - PROCESS | 28730 | Cycle 1(1): loaded http://localhost:43311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43311/tests/kraken/driver.html?testName=ai-astar) 08:14:04 INFO - PROCESS | 28730 | RSS: Main: 150269952 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | __start_tp_report 08:14:04 INFO - PROCESS | 28730 | _x_x_mozilla_page_load 08:14:04 INFO - PROCESS | 28730 | _x_x_mozilla_page_load_details 08:14:04 INFO - PROCESS | 28730 | |i|pagename|runs| 08:14:04 INFO - PROCESS | 28730 | |0;ai-astar;111;107;113;112;112;122;111;111;111;113 08:14:04 INFO - PROCESS | 28730 | |1;audio-beat-detection;159;128;160;161;130;159;151;127;167;128 08:14:04 INFO - PROCESS | 28730 | |2;audio-dft;165;164;163;167;164;163;162;176;166;164 08:14:04 INFO - PROCESS | 28730 | |3;audio-fft;71;75;74;75;73;74;137;76;73;72 08:14:04 INFO - PROCESS | 28730 | |4;audio-oscillator;97;98;138;97;97;97;149;96;97;149 08:14:04 INFO - PROCESS | 28730 | |5;imaging-gaussian-blur;109;111;111;110;110;111;111;110;110;110 08:14:04 INFO - PROCESS | 28730 | |6;imaging-darkroom;147;147;147;147;148;148;146;147;148;146 08:14:04 INFO - PROCESS | 28730 | |7;imaging-desaturate;97;97;98;96;99;96;98;97;96;97 08:14:04 INFO - PROCESS | 28730 | |8;json-parse-financial;60;61;60;69;59;63;60;60;60;59 08:14:04 INFO - PROCESS | 28730 | |9;json-stringify-tinderbox;68;70;76;69;69;69;68;68;69;70 08:14:04 INFO - PROCESS | 28730 | |10;stanford-crypto-aes;87;89;88;87;94;88;87;88;90;92 08:14:04 INFO - PROCESS | 28730 | |11;stanford-crypto-ccm;131;117;120;122;120;128;120;126;118;134 08:14:04 INFO - PROCESS | 28730 | |12;stanford-crypto-pbkdf2;140;151;152;148;151;141;151;151;144;140 08:14:04 INFO - PROCESS | 28730 | |13;stanford-crypto-sha256-iterative;69;68;69;69;68;67;69;67;67;68 08:14:04 INFO - PROCESS | 28730 | __end_tp_report 08:14:04 INFO - PROCESS | 28730 | __start_cc_report 08:14:04 INFO - PROCESS | 28730 | _x_x_mozilla_cycle_collect,752 08:14:04 INFO - PROCESS | 28730 | __end_cc_report 08:14:04 INFO - PROCESS | 28730 | __startTimestamp1451492044037__endTimestamp 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | ------- Summary: start ------- 08:14:04 INFO - PROCESS | 28730 | Number of tests: 14 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:3.80 (3.4%) stddev-sans-first:4.00 08:14:04 INFO - PROCESS | 28730 | Values: 111.0 107.0 113.0 112.0 112.0 122.0 111.0 111.0 111.0 113.0 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:159.00 stddev:16.60 (10.4%) stddev-sans-first:17.03 08:14:04 INFO - PROCESS | 28730 | Values: 159.0 128.0 160.0 161.0 130.0 159.0 151.0 127.0 167.0 128.0 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.50 stddev:4.01 (2.4%) stddev-sans-first:4.25 08:14:04 INFO - PROCESS | 28730 | Values: 165.0 164.0 163.0 167.0 164.0 163.0 162.0 176.0 166.0 164.0 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#3] audio-fft Cycles:10 Average:80.00 Median:74.00 stddev:20.08 (27.1%) stddev-sans-first:21.04 08:14:04 INFO - PROCESS | 28730 | Values: 71.0 75.0 74.0 75.0 73.0 74.0 137.0 76.0 73.0 72.0 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:97.00 stddev:23.54 (24.3%) stddev-sans-first:24.38 08:14:04 INFO - PROCESS | 28730 | Values: 97.0 98.0 138.0 97.0 97.0 97.0 149.0 96.0 97.0 149.0 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.50 stddev:0.67 (0.6%) stddev-sans-first:0.53 08:14:04 INFO - PROCESS | 28730 | Values: 109.0 111.0 111.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:14:04 INFO - PROCESS | 28730 | Values: 147.0 147.0 147.0 147.0 148.0 148.0 146.0 147.0 148.0 146.0 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:0.99 (1.0%) stddev-sans-first:1.05 08:14:04 INFO - PROCESS | 28730 | Values: 97.0 97.0 98.0 96.0 99.0 96.0 98.0 97.0 96.0 97.0 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:60.00 stddev:3.00 (5.0%) stddev-sans-first:3.15 08:14:04 INFO - PROCESS | 28730 | Values: 60.0 61.0 60.0 69.0 59.0 63.0 60.0 60.0 60.0 59.0 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.00 stddev:2.37 (3.4%) stddev-sans-first:2.44 08:14:04 INFO - PROCESS | 28730 | Values: 68.0 70.0 76.0 69.0 69.0 69.0 68.0 68.0 69.0 70.0 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:88.50 stddev:2.36 (2.7%) stddev-sans-first:2.39 08:14:04 INFO - PROCESS | 28730 | Values: 87.0 89.0 88.0 87.0 94.0 88.0 87.0 88.0 90.0 92.0 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:124.00 stddev:5.82 (4.7%) stddev-sans-first:5.52 08:14:04 INFO - PROCESS | 28730 | Values: 131.0 117.0 120.0 122.0 120.0 128.0 120.0 126.0 118.0 134.0 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:151.00 stddev:5.09 (3.4%) stddev-sans-first:4.74 08:14:04 INFO - PROCESS | 28730 | Values: 140.0 151.0 152.0 148.0 151.0 141.0 151.0 151.0 144.0 140.0 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - PROCESS | 28730 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:0.88 (1.3%) stddev-sans-first:0.87 08:14:04 INFO - PROCESS | 28730 | Values: 69.0 68.0 69.0 69.0 68.0 67.0 69.0 67.0 67.0 68.0 08:14:04 INFO - PROCESS | 28730 | -------- Summary: end -------- 08:14:04 INFO - PROCESS | 28730 | 08:14:04 INFO - TEST-INFO | 28730: exit 0 08:14:04 INFO - TEST-OK | kraken | took 60305ms 08:14:04 INFO - TEST-START | v8_7 08:14:04 INFO - operating with platform_type : linux_ 08:14:04 INFO - Initialising browser for v8_7 test... 08:14:05 INFO - TEST-INFO | started process 29017 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptWVzAP/profile http://localhost:43311/getInfo.html) 08:14:09 INFO - PROCESS | 29017 | __metrics Screen width/height:1600/1200 08:14:09 INFO - PROCESS | 29017 | colorDepth:24 08:14:09 INFO - PROCESS | 29017 | Browser inner width/height: 1024/697 08:14:09 INFO - PROCESS | 29017 | __metrics 08:14:09 INFO - PROCESS | 29017 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:14:10 INFO - TEST-INFO | 29017: exit 0 08:14:10 INFO - Browser initialized. 08:14:10 INFO - Running cycle 1/1 for v8_7 test... 08:14:10 INFO - TEST-INFO | started process 29139 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptWVzAP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:22 INFO - PROCESS | 29139 | RSS: Main: 150142976 08:14:22 INFO - PROCESS | 29139 | 08:14:43 INFO - PROCESS | 29139 | Cycle 1(1): loaded http://localhost:43311/tests/v8_7/run.html (next: http://localhost:43311/tests/v8_7/run.html) 08:14:43 INFO - PROCESS | 29139 | RSS: Main: 145530880 08:14:43 INFO - PROCESS | 29139 | 08:14:43 INFO - PROCESS | 29139 | __start_tp_report 08:14:43 INFO - PROCESS | 29139 | _x_x_mozilla_page_load 08:14:43 INFO - PROCESS | 29139 | _x_x_mozilla_page_load_details 08:14:43 INFO - PROCESS | 29139 | |i|pagename|runs| 08:14:43 INFO - PROCESS | 29139 | |0;Richards;170.01020061203673 08:14:43 INFO - PROCESS | 29139 | |1;DeltaBlue;190.4036557501904 08:14:43 INFO - PROCESS | 29139 | |2;Encrypt;280.662363177098 08:14:43 INFO - PROCESS | 29139 | |3;Decrypt;5202.072538860104 08:14:43 INFO - PROCESS | 29139 | |4;RayTrace;1063.8297872340424 08:14:43 INFO - PROCESS | 29139 | |5;Earley;713.7758743754462 08:14:43 INFO - PROCESS | 29139 | |6;Boyer;12506.172839506173 08:14:43 INFO - PROCESS | 29139 | |7;RegExp;27594.594594594593 08:14:43 INFO - PROCESS | 29139 | |8;Splay;683.9945280437756 08:14:43 INFO - PROCESS | 29139 | |9;NavierStokes;4873.78640776699 08:14:43 INFO - PROCESS | 29139 | __end_tp_report 08:14:43 INFO - PROCESS | 29139 | __startTimestamp1451492083898__endTimestamp 08:14:43 INFO - PROCESS | 29139 | 08:14:43 INFO - PROCESS | 29139 | ------- Summary: start ------- 08:14:43 INFO - PROCESS | 29139 | Number of tests: 10 08:14:43 INFO - PROCESS | 29139 | 08:14:43 INFO - PROCESS | 29139 | [#0] Richards Cycles:1 Average:170.01 Median:170.01 stddev:0.00 (0.0%) 08:14:43 INFO - PROCESS | 29139 | Values: 170.0 08:14:43 INFO - PROCESS | 29139 | 08:14:43 INFO - PROCESS | 29139 | [#1] DeltaBlue Cycles:1 Average:190.40 Median:190.40 stddev:0.00 (0.0%) 08:14:43 INFO - PROCESS | 29139 | Values: 190.4 08:14:43 INFO - PROCESS | 29139 | 08:14:43 INFO - PROCESS | 29139 | [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 08:14:43 INFO - PROCESS | 29139 | Values: 280.7 08:14:43 INFO - PROCESS | 29139 | 08:14:43 INFO - PROCESS | 29139 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 08:14:43 INFO - PROCESS | 29139 | Values: 5202.1 08:14:43 INFO - PROCESS | 29139 | 08:14:43 INFO - PROCESS | 29139 | [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 08:14:43 INFO - PROCESS | 29139 | Values: 1063.8 08:14:43 INFO - PROCESS | 29139 | 08:14:43 INFO - PROCESS | 29139 | [#5] Earley Cycles:1 Average:713.78 Median:713.78 stddev:0.00 (0.0%) 08:14:43 INFO - PROCESS | 29139 | Values: 713.8 08:14:43 INFO - PROCESS | 29139 | 08:14:43 INFO - PROCESS | 29139 | [#6] Boyer Cycles:1 Average:12506.17 Median:12506.17 stddev:0.00 (0.0%) 08:14:43 INFO - PROCESS | 29139 | Values: 12506.2 08:14:43 INFO - PROCESS | 29139 | 08:14:43 INFO - PROCESS | 29139 | [#7] RegExp Cycles:1 Average:27594.59 Median:27594.59 stddev:0.00 (0.0%) 08:14:43 INFO - PROCESS | 29139 | Values: 27594.6 08:14:43 INFO - PROCESS | 29139 | 08:14:43 INFO - PROCESS | 29139 | [#8] Splay Cycles:1 Average:683.99 Median:683.99 stddev:0.00 (0.0%) 08:14:43 INFO - PROCESS | 29139 | Values: 684.0 08:14:43 INFO - PROCESS | 29139 | 08:14:43 INFO - PROCESS | 29139 | [#9] NavierStokes Cycles:1 Average:4873.79 Median:4873.79 stddev:0.00 (0.0%) 08:14:43 INFO - PROCESS | 29139 | Values: 4873.8 08:14:43 INFO - PROCESS | 29139 | -------- Summary: end -------- 08:14:43 INFO - PROCESS | 29139 | 08:14:44 INFO - TEST-INFO | 29139: exit 0 08:14:44 INFO - TEST-OK | v8_7 | took 39781ms 08:14:44 INFO - SUITE-END | took 1210s 08:14:44 INFO - Completed test suite (00:20:10) 08:14:44 INFO - Working with test: dromaeo_css 08:14:44 INFO - Generating results file: dromaeo_css 08:14:44 INFO - Working with test: kraken 08:14:44 INFO - Generating results file: kraken 08:14:44 INFO - javascript benchmark 08:14:44 INFO - Working with test: v8_7 08:14:44 INFO - Generating results file: v8_7 08:14:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:14:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 08:14:44 INFO - process_Request line: dromaeo_css 6864.57 graph.html#tests=[[72,64,43]] 08:14:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:14:44 INFO - process_Request line: kraken 1529.00 graph.html#tests=[[232,64,43]] 08:14:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:14:45 INFO - process_Request line: v8_7 20797.14 graph.html#tests=[[230,64,43]] 08:14:45 INFO - RETURN: dromaeo_css: 6864.57 08:14:45 INFO - RETURN: kraken: 1529.00 08:14:45 INFO - RETURN: v8_7: 20797.14 08:14:45 INFO - javascript benchmark 08:14:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3207.7113059824615, 3246.577944867167, 3293.2096296888753, 3293.8023718576887, 3295.5715756951595, 5279.736013199344, 5406.432324605918, 5415.404305526394, 5429.185622156679, 5443.428440013796, 5307.442718514559, 5329.786808527654, 5420.322459692538, 5495.395506494292, 5504.339479262484, 5011.473795251501, 5070.0, 5124.743762811863, 5156.484351564851, 5156.845294641167, 4981.37732783402, 5049.520295571933, 5057.645964782467, 5065.7467126643705, 5101.081805275049, 4861.343718598015, 4941.901161976776, 4974.950250497485, 5031.867829738316, 5051.873703157414, 5010.599152067826, 5012.498750124995, 5031.748412579356, 5033.647644664875, 5038.420581633086, 4914.803407863681, 4965.354503914504, 4971.204607262821, 5008.924866126975, 5040.042391945519, 5201.505856943584, 5202.4277329493725, 5279.392869819982, 5339.119045357511, 5349.625526213166, 5908.97045514774, 5919.112133180014, 5946.07835785454, 5947.583669143161, 5965.13505541694, 5958.940410595926, 5966.910496342558, 5973.163757074013, 5980.581359304851, 5986.580939334249, 5369.650972686723, 5412.107002344608, 5458.590605704549, 5506.311711036121, 5554.250176226198, 5928.229330187048, 5950.0, 5963.224780778558, 5977.073553599199, 5993.790217342372, 5757.827265182052, 5770.855728606818, 5771.220885180531, 5775.0, 5777.740001699934, 5695.088785794253, 5727.828165155052, 5783.624064435799, 5829.679367634736, 5890.263717035371, 5867.2959244890035, 5873.941260587425, 5880.8235752927485, 5896.086106653475, 5898.1152827076285, 5664.660120392789, 5784.768609255582, 5833.79581714638, 5857.7949771757785, 5875.29496460419, 4421.955780442155, 4430.446194225722, 4446.755428451402, 4464.15181115587, 4523.344115103291, 3954.268460334847, 3959.1883663848844, 3976.900577485528, 3985.3822657488136, 4013.337799263147, 5311.442298558673, 5448.346198456211, 5456.645318054314, 5468.043092458804, 5474.288342515448, 5750.2524671793235, 5751.0, 5751.741171647286, 5765.04876695349, 5769.394213607595, 5313.840584782462, 5324.334458192726, 5363.249145119687, 5372.489613486712, 5531.419200983919, 5051.924221136685, 5063.1645778446145, 5070.29015937769, 5087.186050231945, 5118.206677964921, 6055.273367195965, 6063.272407311151, 6068.848278792977, 6089.269287685506, 6090.756369745249, 5626.915596266142, 5718.971405142947, 5727.455891690282, 5788.363280039276, 5875.471207591338, 6093.695315234309, 6099.11562823397, 6144.139820425234, 6160.722767475385, 6178.752849885954, 5882.441168089024, 5890.52875769946, 5897.498712609477, 5900.64596124234, 5911.261092363455, 5753.942460575341, 5853.736581853912, 5889.646621202742, 5969.313528944227, 5980.37206093354, 5817.941820581909, 5825.155352473952, 5840.2991641003355, 5847.152162936265, 5859.677717725566, 5777.884442311214, 5792.420757924174, 5798.188253644409, 5806.129080637769, 5833.329167145833, 5489.780408783764, 5579.414161513145, 5599.468050535193, 5669.206311116364, 5710.800121995876, 5675.971620142038, 5691.260136182435, 5714.714264286686, 5728.054870946414, 5766.769329226784, 5550.7779688812, 5568.359638641446, 5568.832935011957, 5609.74756135983, 5623.690697011703], "unit": "score", "name": "dojo.html", "value": 5397.3118788779075}, {"lowerIsBetter": false, "replicates": [503.28030915790407, 524.9711265880376, 533.7571405010721, 533.9519443250107, 557.5762420560375, 28296.0, 28654.0, 36195.819020904855, 36356.81821590888, 36424.0, 38648.22703545928, 39059.41410878839, 39158.0, 39333.21333573327, 39464.21071578574, 8458.069612342653, 8553.786155346135, 8571.571421428935, 8594.355423343242, 8624.051354351048, 8355.874661880076, 8496.872546911802, 8503.149685031509, 8508.446950948199, 8525.786855328635, 8315.750527484186, 8316.916830831675, 8517.74446766598, 8517.914820851805, 8527.104654011333, 8570.100139485357, 8574.056853746082, 8624.784380390478, 8646.092160323138, 8651.351148663813, 8432.367572432093, 8560.0583935767, 8601.182887625666, 8614.483131012159, 8623.439476434074, 38520.61479385226, 38953.610463895566, 38993.41509877354, 39002.414963775285, 39043.60956390428, 3004.7746419018445, 3057.143999680093, 3086.36729470458, 3210.9036728897936, 3384.712299454525, 28861.71138288611, 28899.277518062005, 29177.56233656497, 29216.0, 29669.70330296691, 3678.3746763050344, 3832.7891965941863, 3848.3457812171996, 3901.356276214421, 3909.3745000799736, 216520.0, 218251.0, 218489.0, 219197.0, 219217.90391048102, 54142.729286353315, 54760.72619636956, 55157.724211379485, 55219.44780552143, 55224.72387638116, 64471.35528644748, 64917.350826492075, 65328.0, 65554.34445655577, 65654.67172664106, 15221.31504082319, 15247.3901043957, 15250.627443530135, 15332.693346133015, 15381.923265371317, 11679.766404671858, 11707.356095414663, 11781.882181178078, 11869.940650296694, 11870.634876989257, 19510.0, 20022.0, 20047.59904801925, 20056.0, 20109.39671809848, 8074.677012919417, 8213.439446505145, 8249.0, 8272.751817445485, 8295.875561866576, 896.7578753736585, 898.7887846356101, 942.4345392764286, 946.4226821638795, 1101.6309536305428, 28165.0, 28291.71708282891, 28336.8583157087, 28376.85811570929, 28925.566116508267, 1070.1759645073405, 1135.0408904475705, 1142.822862456304, 1145.7937571237258, 1196.6768972377583, 14560.854391456161, 14655.193964331851, 14674.0, 14943.476978305707, 15004.774928376082, 304811.0, 307710.0, 307941.0, 308154.0, 309148.0, 49673.503264967614, 50740.0, 50883.745581271854, 50890.0, 50993.0, 1363.4409891944256, 1366.9658258543418, 1369.6438925879145, 1377.393946663465, 1382.2950295349244, 27001.594976074983, 27873.860630697527, 27967.58048629313, 28156.0, 28355.716442835306, 44511.77744111259, 45014.324785127596, 45462.0, 45476.0, 45601.0, 286763.0, 287816.0, 288767.0, 289129.0, 290296.0, 31909.0, 42728.78635606802, 42984.0, 43199.0, 43761.78119109384, 39735.602643974344, 40260.39609405803, 40292.3956140664, 40369.1926161481, 40591.1881762369, 33827.3234535303, 34183.0, 34396.108214048465, 34678.653213468555, 34875.4768678465, 35830.28339433249, 36161.734339298, 36436.0, 37875.431868521446, 39707.2058558833, 34981.47527787136, 37743.81128094342, 37874.810625946695, 38711.22577548377, 38740.80629596834, 27815.924177203928, 32352.0, 32802.67197327996, 32808.34383312368, 32964.835175823966, 24891.675485713262, 25216.369590760376, 25242.0, 25371.61942570826, 25607.23178304654], "unit": "score", "name": "ext.html", "value": 18184.187710134658}, {"lowerIsBetter": false, "replicates": [351.4622627380109, 352.10213954416247, 355.5182727404367, 357.88547664747284, 358.2119337457594, 15787.131707756069, 16318.83681163188, 16975.74536381955, 17117.31530738769, 18006.459806205803, 10843.0, 11376.772464550724, 15776.368945242177, 15823.84176158238, 15930.0, 4738.384010078685, 4889.364382630253, 5086.109930762121, 5089.75301051243, 5113.872153196163, 4391.846285380012, 5139.663687441255, 5171.0, 5193.16909294513, 5200.453952335007, 5028.069807085682, 5102.693838369692, 5115.104856650071, 5187.6628019178825, 5202.297689811884, 5106.540411362977, 5111.105556527611, 5138.332016837825, 5139.922901156486, 5560.360558535739, 5068.898622027539, 5110.310108135392, 5116.795328186868, 5122.1036318644465, 5125.589952803767, 12141.519955389174, 20014.79985200144, 20119.497012574804, 20611.072501737457, 20870.686939695915, 2119.480727221825, 2133.125418578391, 2148.140743702516, 2159.373781603349, 2222.5777102350503, 11130.05394541465, 12905.096643234978, 12934.547290844775, 12974.35128243584, 13113.86886131136, 1727.550836782433, 1776.9022703751289, 1812.9818701812944, 1817.818218178185, 1820.5084627150727, 55017.1747423793, 55308.0, 55834.0, 59053.91353037663, 63055.68472157656, 9839.901600984042, 10400.739981500372, 10451.425171615634, 10456.058954693963, 10518.631847885288, 13539.66150846217, 13608.38762255701, 13648.454061837614, 13671.86328136706, 13703.588892333246, 7372.0, 7547.8113047173165, 7802.960985195038, 7826.295633393022, 7861.0, 7555.24447555251, 7570.394368450511, 7595.0, 7613.733519326797, 7620.466567340233, 4496.392986946786, 4510.797014134372, 4556.886077848014, 4598.563136502027, 4611.5619016193405, 1811.3117015534276, 1864.3102052240758, 1928.9035548222532, 1937.3509874192303, 1943.6112777444569, 802.8875957365973, 888.9022207557164, 893.3657103456619, 965.9951700241454, 1047.5652604169184, 16386.0, 16392.0, 16758.32966681319, 16865.241064151898, 17124.229409676595, 885.0132102705437, 885.4510203673635, 894.2935081285711, 944.8252073366449, 1007.2948935745007, 8502.872456913152, 8693.043765185825, 8717.869231961526, 8917.955410222907, 8949.686760963465, 560625.0, 569205.0, 574070.0, 580596.0, 597830.0, 55689.44310556923, 77318.6134069326, 79642.0, 81582.18417815864, 84530.0, 1148.655403378983, 1149.0, 1162.6105254739757, 1169.9590514331958, 1177.7232350397649, 14068.437262509386, 14335.856641433453, 14368.784468233194, 14462.855371446572, 14974.52175258413, 33022.00933971984, 33136.50295245525, 33613.32773344568, 34021.0, 34475.0, 39380.409293860044, 42110.36834447547, 42735.0, 45049.77475112603, 45830.77084614689, 9204.815903682023, 9208.802855628725, 9242.537873106452, 9424.434533927986, 9521.238300936047, 13379.866201337862, 16561.25474353633, 16634.58413539671, 16719.582010449834, 16849.41027064047, 11310.717232068935, 12288.938555307166, 13856.168629882239, 13994.65013374633, 14111.506097286545, 13810.240436776074, 13852.515161969282, 13990.300484975915, 14056.859431405555, 14418.0, 13996.37016334247, 14220.431182752574, 14313.71372572522, 14376.065555738844, 14687.192204428859, 9248.907510925073, 9423.858642120511, 9473.052694730472, 9513.476758778334, 9516.23870090405, 14178.432862685377, 14399.208043557705, 14457.493987710379, 14739.705205896036, 14860.925695371454], "unit": "score", "name": "jquery.html", "value": 8732.753262012604}, {"lowerIsBetter": false, "replicates": [1436.8347640021395, 1467.1417220925755, 1605.4942693051687, 1742.0592879844885, 1767.1605987156095, 6510.153680021603, 6573.276939536647, 7065.929340706592, 7214.819629509265, 7233.927660723391, 6872.381485666289, 6985.336393042666, 7030.402415794651, 7046.330598593138, 7096.042034325377, 2143.3677065265706, 2172.3482955113404, 2180.4439867833757, 2181.9454513637206, 2184.9344519664355, 2207.5143468437, 2224.877631730254, 2229.0860747093693, 2235.765244649313, 2240.10395841663, 2116.2698868890284, 2132.2856842957626, 2145.410012246629, 2170.403139136742, 2174.554216385645, 2196.7363916330064, 2232.352617740861, 2233.039792889057, 2233.8101261392803, 2240.137547044383, 2162.6864104704887, 2194.3855720398315, 2197.7142971413773, 2204.492966617671, 2207.2164381644607, 7245.673944672502, 7299.270072992711, 7302.160251571084, 7323.304286092813, 7409.147947985996, 4425.7565833879125, 4432.113577284524, 4453.51011388747, 4461.643068554507, 4482.21561226784, 2877.0505733108025, 2903.3177203357195, 2919.50368437364, 2925.0054981306457, 2927.224285564327, 901.328510259854, 917.7934964632971, 936.2416442681382, 959.299711210813, 960.0798403193613, 9657.46883921384, 9812.018798120202, 9821.852672209923, 9827.754306142404, 9834.360766550151, 3868.767873927517, 3970.940435893464, 3980.124372638015, 3996.620321069494, 4017.879463616096, 7752.147263800977, 7761.573113478813, 7794.844103117905, 7846.293833555007, 7867.567283799446, 4331.155424692218, 4346.434963454731, 4356.3683265926265, 4369.563043695605, 4371.628411584988, 3655.8354874030733, 3704.8518059277326, 3995.2409042282457, 4045.150518391171, 4075.653569446571, 3324.7173990211104, 3327.301266734013, 3337.399268131711, 3368.1579605098727, 3372.072680012967, 983.5180761426849, 1020.2756043209256, 1025.6102980461367, 1026.3687831983277, 1027.2039169643585, 1258.52485512673, 1294.1717300927414, 1298.3248710670398, 1337.1776357540236, 1341.0277548777058, 6935.895961560581, 6947.89578156328, 6981.79054628362, 6987.510874238857, 6988.475864310197, 477.72530794793136, 493.2157868988254, 499.73763774018204, 500.17720849202857, 503.64996327552734, 5522.723863806794, 5563.13771365439, 5575.275214222125, 5580.0, 5597.860053498695, 8450.704225352083, 8456.830863382698, 8602.139786021473, 8674.219320261207, 8789.208971192624, 8560.357973152039, 8587.484750914966, 8601.397902146915, 8604.182602652738, 8628.396012279205, 6681.098051763047, 6716.1604799400075, 6726.0, 6852.657367131624, 6904.827379315457, 6688.862893308246, 6733.326667333227, 6745.527813053235, 6751.257361690112, 6762.188537375547, 7659.540427574363, 7677.193894641206, 7715.151333353215, 7756.8448631028195, 7833.49082309648, 7781.26078022587, 7866.331361834308, 7964.800879978047, 7967.800804979922, 8173.468724532886, 5548.528375088163, 5597.328320601554, 6008.279006519246, 6038.969805150946, 6080.513558915188, 6735.898961515483, 6810.6594670265295, 6845.14435695538, 6857.142857142857, 6861.725530978705, 6070.3929607038945, 6150.815475535741, 6196.194494715658, 6244.875102498016, 6265.216847894013, 6372.458341041063, 6374.776882809079, 6391.808245752635, 6497.512686548623, 6515.087887695821, 6278.277998030285, 6312.526560508072, 6336.334684858023, 6442.065900444316, 6454.838629034311, 5865.061590145556, 5891.852703682271, 5895.20414744004, 5932.733027013708, 6026.90959635597, 5927.051671732502, 6030.306514750684, 6033.215681961317, 6056.121862329849, 6059.939400606114], "unit": "score", "name": "mootools.html", "value": 4100.14829108727}, {"lowerIsBetter": false, "replicates": [318.82942625695256, 323.37104332074097, 327.29794590603154, 328.4252558023459, 335.95464612277334, 6323.430891219789, 6363.0773537836985, 6397.520185986046, 6399.296077431491, 6491.221053473578, 6134.386561343875, 6222.937770622292, 6223.844403889905, 6255.968720156393, 6263.436290733833, 4829.010052939139, 4842.394700662418, 4851.563359297663, 4858.441279252896, 4867.318575399447, 4859.101066302727, 4860.05228980349, 4866.83196032953, 4867.318575399447, 4880.121578115938, 4707.576318131368, 4828.97585512072, 4834.347363105989, 4841.2012018016985, 4849.587785038276, 4780.020095880353, 4781.187198176283, 4782.976085119587, 4822.5900798432, 4840.927386089176, 4180.393842892763, 4194.328907374806, 4206.936895946563, 4207.242696314662, 4221.345691417804, 6030.849228769272, 6031.336552979169, 6040.063790112539, 6047.667378294192, 6049.5462840287155, 5423.9694458052845, 5601.047821870292, 5616.66300022, 5622.269105016363, 5644.955683198621, 6768.39084482394, 6814.931850681529, 6850.0752398426075, 6859.9314006859795, 6881.346272104192, 4541.8410355637725, 4542.568455996675, 4574.6340292776495, 4594.977025114853, 4598.333241679938, 6939.271376505495, 6969.128858892638, 7018.227994920555, 7042.471814613873, 7077.292270772933, 4696.929546056812, 4698.1778188816825, 4707.270373092176, 4712.0, 4714.905701885943, 4751.477337492873, 4758.16732071893, 4762.928556071662, 4763.309320148559, 4773.76131193439, 5568.52667523257, 5572.804951826666, 5574.275344205227, 5578.30271216098, 5580.051391263495, 6575.967120164369, 6735.528513004043, 6741.685371352637, 6776.796696099125, 6780.423663988518, 1647.7198876191076, 1668.3576822923262, 1687.5190570687296, 1692.246950107215, 1699.17589968865, 1087.217203613397, 1098.3355070182583, 1103.9558417663204, 1111.766529028897, 1121.6578943422335, 6178.598391104564, 6243.250809902841, 6260.593061450991, 6266.686665666698, 6394.968025159845, 6879.3120687930805, 6905.274946130584, 6922.203946546111, 6950.3049695030095, 6954.687039083254, 6159.6140868305165, 6299.842503937438, 6307.96846015767, 6354.618722876642, 6379.202599675041, 3752.249550089993, 3774.9245015099546, 3777.20678657485, 3781.829817658212, 3788.242351529705, 7175.17485489165, 7204.459665525106, 7222.313880181375, 7228.277172282729, 7232.0959880015, 7005.719771209095, 7029.925482001312, 7113.7510187144235, 7152.642367881585, 7159.713611455483, 7040.331168538981, 7155.785326440215, 7173.282671732785, 7187.31720486553, 7208.423326133897, 6940.271271516418, 6940.930590694028, 6942.652867356511, 6961.61711105894, 6971.895421568579, 6789.93210067893, 6864.897026544506, 6877.3810357068105, 6884.5180837342905, 6951.8609627806145, 7289.56262624223, 7380.704771809067, 7383.483156179016, 7387.667554959932, 7413.369863561657, 4694.201985662514, 4705.952940470552, 4712.3873896394625, 4744.572988431058, 4748.525147485224, 6864.21061577925, 7077.787666370017, 7086.858262834818, 7119.288071192839, 7136.9286307138345, 6891.104156459829, 6896.413804826646, 6911.930880691129, 6934.583924964519, 6937.098177236927, 6863.210730765826, 6897.379235868796, 6898.413634840894, 6911.481638877004, 6919.411849992807, 6618.503612229006, 6755.6622168892345, 6759.391654751096, 6763.222229443677, 6772.0857684212, 6879.931200687929, 6905.102336696197, 6911.412529935012, 6912.896306555305, 6943.722251110101, 6556.639384833689, 6714.83212919681, 6717.966410167918, 6739.898901516579, 6774.153230846145], "unit": "score", "name": "prototype.html", "value": 5061.753264365833}, {"lowerIsBetter": false, "replicates": [684.6610927590843, 807.3460496997433, 817.5952903312859, 825.4840724547158, 839.46274384394, 13124.737505249901, 13245.735085298289, 13327.867541193411, 13423.93288033561, 13471.932640336785, 10554.366737995726, 12669.448640671659, 12740.745185096292, 12794.936025319861, 12828.230306181636, 805.9838803223932, 816.4325793573469, 821.342925659473, 823.4688625836332, 824.5423789796661, 830.6511265268572, 831.6507067031831, 833.5998720614109, 841.6296829395077, 841.9536925469097, 868.9217970382664, 871.0592560035178, 876.701921346742, 877.0177401310541, 880.5993273060774, 871.612132600996, 874.6719980007497, 875.4397185801092, 875.4790899414838, 879.4151888993812, 638.0333794301637, 640.8333833203401, 642.6979319719771, 644.5939058393229, 648.251269783401, 11611.07111431092, 11621.651350459415, 11659.825102623467, 11725.70685732855, 11741.647750567497, 9818.950905245429, 10059.748506287402, 10470.214733894913, 10961.56153753849, 11035.668929932115, 9345.495439210295, 9469.479178645171, 9525.952370238174, 9526.809463810685, 9615.615375384976, 3553.7867727936405, 3572.9464058039152, 3576.5886923003927, 3584.193556449804, 3627.220147668264, 44207.0, 44547.55452445467, 45191.54808451906, 45914.31128533041, 46659.0, 8846.271892913954, 8954.686585969459, 9191.448513089235, 9358.625654973725, 9417.105374989365, 16440.917795411187, 16496.0, 16588.336466541445, 16596.419125330554, 16943.068131252898, 6963.9303606963285, 7276.527025743309, 7289.817754556072, 7397.26027397256, 7444.553326800409, 4206.053637931441, 4212.620864122183, 4293.91412171761, 4299.398084268205, 4350.282203436397, 2922.6054482644995, 2923.5906973023793, 2934.9434203686656, 2935.0314396249187, 2936.1044881310977, 547.4963034008722, 556.5436342199357, 556.6020295488745, 558.9413111623302, 570.6262398129232, 441.4944888103104, 468.9648276379285, 469.4132334581773, 473.00668595948235, 525.7634064670837, 7588.81027974305, 7848.803779905434, 8046.0344758629335, 8316.584170791437, 8519.403641745143, 453.78672024148597, 453.80259587079723, 531.6305167908266, 549.3161014536927, 567.5908591126571, 3681.4661874028116, 3780.3006443807985, 3802.634668318558, 3896.4350169225304, 3929.7052721046034, 51962.0, 52440.73779631077, 52617.47382526202, 53019.34903254822, 54682.0, 47885.76057119692, 49208.753956229986, 49313.26030109551, 49343.0, 49431.75284123628, 44308.11383772307, 44988.55011449909, 45141.774291128335, 45974.310385344244, 48351.758241209274, 7650.885236721342, 7655.425843061904, 7784.065912090586, 7812.453128280966, 8163.959180204061, 33753.32493350168, 34200.82899585486, 34398.65601343955, 34787.826060870546, 34843.128921776144, 40812.59187408088, 41896.0, 44753.77623111994, 45818.0, 45977.77011114923, 9026.368154229403, 9105.954470227607, 9315.673951411669, 9340.626374944926, 9446.952765236405, 10184.287099902936, 10445.097366602376, 10579.32259392873, 10614.469276536296, 10673.57305707763, 9922.503874806374, 9962.900370996198, 10373.377597344184, 10374.27380083387, 10578.735531611772, 10134.797304054026, 10283.537240824331, 10297.53661085238, 10374.118199952787, 10499.895001050198, 9145.542722863696, 9813.656522021694, 9828.803423931624, 10013.39919604826, 10209.132223760766, 8592.312614990911, 8656.437331573428, 8697.565121744014, 8983.685571004984, 9084.545772711206, 8244.216799404046, 8319.0, 8382.0, 8385.580720963806, 8716.60775265102], "unit": "score", "name": "yui.html", "value": 5881.866974910358}], "name": "dromaeo_css", "value": 6864.565639145449}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 113.0, 112.0, 112.0, 122.0, 111.0, 111.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [159.0, 128.0, 160.0, 161.0, 130.0, 159.0, 151.0, 127.0, 167.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [165.0, 164.0, 163.0, 167.0, 164.0, 163.0, 162.0, 176.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 165.4}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 74.0, 75.0, 73.0, 74.0, 137.0, 76.0, 73.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 138.0, 97.0, 97.0, 97.0, 149.0, 96.0, 97.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 111.5}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 111.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 146.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 98.0, 96.0, 99.0, 96.0, 98.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 60.0, 69.0, 59.0, 63.0, 60.0, 60.0, 60.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 61.1}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 76.0, 69.0, 69.0, 69.0, 68.0, 68.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [87.0, 89.0, 88.0, 87.0, 94.0, 88.0, 87.0, 88.0, 90.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.0}, {"lowerIsBetter": true, "replicates": [131.0, 117.0, 120.0, 122.0, 120.0, 128.0, 120.0, 126.0, 118.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [140.0, 151.0, 152.0, 148.0, 151.0, 141.0, 151.0, 151.0, 144.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.9}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 69.0, 68.0, 67.0, 69.0, 67.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1528.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.01020061203673], "unit": "score", "name": "Richards", "value": 207.64636399999995}, {"lowerIsBetter": false, "replicates": [190.4036557501904], "unit": "score", "name": "DeltaBlue", "value": 347.251736}, {"lowerIsBetter": false, "replicates": [280.662363177098], "unit": "score", "name": "Encrypt", "value": 948.4029029999999}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [713.7758743754462], "unit": "score", "name": "Earley", "value": 933.7146630000002}, {"lowerIsBetter": false, "replicates": [12506.172839506173], "unit": "score", "name": "Boyer", "value": 53.29072359328728}, {"lowerIsBetter": false, "replicates": [27594.594594594593], "unit": "score", "name": "RegExp", "value": 33.01316846229187}, {"lowerIsBetter": false, "replicates": [683.9945280437756], "unit": "score", "name": "Splay", "value": 119.13984200000004}, {"lowerIsBetter": false, "replicates": [4873.78640776699], "unit": "score", "name": "NavierStokes", "value": 304.48605577689233}], "name": "v8_7", "value": 20797.13875740386}]} 08:14:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20797.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1529.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6864.57"}}} 08:14:45 INFO - Return code: 0 08:14:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:14:45 INFO - # TBPL SUCCESS # 08:14:45 INFO - Running post-action listener: _resource_record_post_action 08:14:45 INFO - Running post-run listener: _resource_record_post_run 08:14:46 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 555601920; Read time: 0; Write time: 525420 08:14:46 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235212800; Read time: 0; Write time: 327864 08:14:46 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 320188416; Read time: 0; Write time: 197532 08:14:46 INFO - Running post-run listener: _upload_blobber_files 08:14:46 INFO - Blob upload gear active. 08:14:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:14:46 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:14:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:14:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:14:46 INFO - (blobuploader) - INFO - Open directory for files ... 08:14:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:14:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:14:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:47 INFO - (blobuploader) - INFO - Done attempting. 08:14:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:14:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:14:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:48 INFO - (blobuploader) - INFO - Done attempting. 08:14:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:14:48 INFO - Return code: 0 08:14:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:14:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:14:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3321bb61dd60330a307457a346c682c4a9fc7ab4330eaaba0627cc77b54bd6b4d343d726267554102af98f373d736535e576f136a0709edd710e607f61ae7d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/beb869361c888da652b0ccd4420690d0d490fc57aec58516212b9e2f4607324b8da4891b82c40057b1a8c62ace01a7881d9e64f02678aea48b56db4ce3d58d0e"} 08:14:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:14:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:14:48 INFO - Contents: 08:14:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3321bb61dd60330a307457a346c682c4a9fc7ab4330eaaba0627cc77b54bd6b4d343d726267554102af98f373d736535e576f136a0709edd710e607f61ae7d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/beb869361c888da652b0ccd4420690d0d490fc57aec58516212b9e2f4607324b8da4891b82c40057b1a8c62ace01a7881d9e64f02678aea48b56db4ce3d58d0e"} 08:14:48 INFO - Copying logs to upload dir... 08:14:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.283085 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-30 08:14:47.176266) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 08:14:47.179443) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703 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/f3321bb61dd60330a307457a346c682c4a9fc7ab4330eaaba0627cc77b54bd6b4d343d726267554102af98f373d736535e576f136a0709edd710e607f61ae7d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/beb869361c888da652b0ccd4420690d0d490fc57aec58516212b9e2f4607324b8da4891b82c40057b1a8c62ace01a7881d9e64f02678aea48b56db4ce3d58d0e"} build_url:https://queue.taskcluster.net/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011513 build_url: 'https://queue.taskcluster.net/v1/task/cWdBaVa0QB2eiIXTlI1ZsA/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/f3321bb61dd60330a307457a346c682c4a9fc7ab4330eaaba0627cc77b54bd6b4d343d726267554102af98f373d736535e576f136a0709edd710e607f61ae7d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/beb869361c888da652b0ccd4420690d0d490fc57aec58516212b9e2f4607324b8da4891b82c40057b1a8c62ace01a7881d9e64f02678aea48b56db4ce3d58d0e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 08:14:47.204625) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:14:47.204956) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451488938.813432-814201703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:14:47.290028) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 08:14:47.290355) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 08:14:47.290698) ========= ========= Total master_lag: 0.29 =========