builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1453353018.75 results: success (0) buildid: 20160120185004 builduid: 92f548a05d6e4c959339d5b9fa7abbe6 revision: 493d6820745e4e3ed22e48a5f9229ea033a64a3a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.746683) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.747163) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.747459) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006316 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.770775) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.771114) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.784631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.784920) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.833616) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.833909) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.834303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.834583) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 21:10:19-- 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% 224M=0s 2016-01-20 21:10:19 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128476 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.980668) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.981010) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022281 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:19.170872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:19.171214) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 493d6820745e4e3ed22e48a5f9229ea033a64a3a --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 493d6820745e4e3ed22e48a5f9229ea033a64a3a --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=516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 21:10:19,744 truncating revision to first 12 chars 2016-01-20 21:10:19,744 Setting DEBUG logging. 2016-01-20 21:10:19,744 attempt 1/10 2016-01-20 21:10:19,744 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/493d6820745e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 21:10:20,017 unpacking tar archive at: fx-team-493d6820745e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562754 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:19.747501) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:19.747873) ========= echo 493d6820745e4e3ed22e48a5f9229ea033a64a3a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'493d6820745e4e3ed22e48a5f9229ea033a64a3a'] 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=516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 493d6820745e4e3ed22e48a5f9229ea033a64a3a program finished with exit code 0 elapsedTime=0.003774 script_repo_revision: '493d6820745e4e3ed22e48a5f9229ea033a64a3a' ========= master_lag: 0.23 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:19.982912) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2016-01-20 21:10:19.983271) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2016-01-20 21:10:22.186169) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:22.186479) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/493d6820745e4e3ed22e48a5f9229ea033a64a3a ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:22.186909) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-20 21:10:22.187226) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:10:22 INFO - MultiFileLogger online at 20160120 21:10:22 in /builds/slave/test-pgo 21:10:22 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 21:10:22 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:10:22 INFO - {'append_to_log': False, 21:10:22 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:10:22 INFO - 'blob_upload_branch': 'Fx-Team', 21:10:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:10:22 INFO - 'branch': 'Fx-Team', 21:10:22 INFO - 'buildbot_json_path': 'buildprops.json', 21:10:22 INFO - 'config_files': ('talos/linux_config.py',), 21:10:22 INFO - 'default_actions': ('clobber', 21:10:22 INFO - 'read-buildbot-config', 21:10:22 INFO - 'download-and-extract', 21:10:22 INFO - 'populate-webroot', 21:10:22 INFO - 'create-virtualenv', 21:10:22 INFO - 'install', 21:10:22 INFO - 'run-tests'), 21:10:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:10:22 INFO - 'download_minidump_stackwalk': True, 21:10:22 INFO - 'download_symbols': 'ondemand', 21:10:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:10:22 INFO - 'tooltool.py': '/tools/tooltool.py', 21:10:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:10:22 INFO - '/tools/misc-python/virtualenv.py')}, 21:10:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:10:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:10:22 INFO - 'installer_path': 'installer.exe', 21:10:22 INFO - 'log_level': 'info', 21:10:22 INFO - 'log_name': 'talos', 21:10:22 INFO - 'log_to_console': True, 21:10:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:10:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:10:22 INFO - 'opt_config_files': (), 21:10:22 INFO - 'pip_index': False, 21:10:22 INFO - 'sps_profile': False, 21:10:22 INFO - 'sps_profile_interval': 0, 21:10:22 INFO - 'suite': 'dromaeojs-e10s', 21:10:22 INFO - 'system_bits': '32', 21:10:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:10:22 INFO - 'title': 'talos-linux64-ix-061', 21:10:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:10:22 INFO - 'use_talos_json': True, 21:10:22 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:10:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:10:22 INFO - 'work_dir': 'build'} 21:10:22 INFO - ##### 21:10:22 INFO - ##### Running clobber step. 21:10:22 INFO - ##### 21:10:22 INFO - Running pre-action listener: _resource_record_pre_action 21:10:22 INFO - Running main action method: clobber 21:10:22 INFO - rmtree: /builds/slave/test-pgo/build 21:10:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:10:23 INFO - Running post-action listener: _resource_record_post_action 21:10:23 INFO - ##### 21:10:23 INFO - ##### Running read-buildbot-config step. 21:10:23 INFO - ##### 21:10:23 INFO - Running pre-action listener: _resource_record_pre_action 21:10:23 INFO - Running main action method: read_buildbot_config 21:10:23 INFO - Using buildbot properties: 21:10:23 INFO - { 21:10:23 INFO - "project": "", 21:10:23 INFO - "product": "firefox", 21:10:23 INFO - "script_repo_revision": "production", 21:10:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:10:23 INFO - "repository": "", 21:10:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 21:10:23 INFO - "buildid": "20160120185004", 21:10:23 INFO - "pgo_build": "True", 21:10:23 INFO - "basedir": "/builds/slave/test-pgo", 21:10:23 INFO - "buildnumber": 131, 21:10:23 INFO - "slavename": "talos-linux64-ix-061", 21:10:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:10:23 INFO - "platform": "ubuntu64_hw", 21:10:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:10:23 INFO - "branch": "fx-team", 21:10:23 INFO - "repo_path": "integration/fx-team", 21:10:23 INFO - "revision": "493d6820745e4e3ed22e48a5f9229ea033a64a3a", 21:10:23 INFO - "stage_platform": "linux64-pgo", 21:10:23 INFO - "builduid": "92f548a05d6e4c959339d5b9fa7abbe6", 21:10:23 INFO - "slavebuilddir": "test" 21:10:23 INFO - } 21:10:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:10:23 INFO - Running post-action listener: _resource_record_post_action 21:10:23 INFO - ##### 21:10:23 INFO - ##### Running download-and-extract step. 21:10:23 INFO - ##### 21:10:23 INFO - Running pre-action listener: _resource_record_pre_action 21:10:23 INFO - Running main action method: download_and_extract 21:10:23 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:23 INFO - https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:10:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/test_packages.json 21:10:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/test_packages.json 21:10:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:10:28 INFO - Downloaded 1448 bytes. 21:10:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:10:28 INFO - Using the following test package requirements: 21:10:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:10:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:10:28 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:10:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:28 INFO - u'jsshell-linux-x86_64.zip'], 21:10:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:10:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:10:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:10:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:10:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:10:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:10:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:10:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:28 INFO - https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:10:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:10:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:10:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/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 21:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/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 21:10:30 INFO - Downloaded 22486116 bytes. 21:10:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:10:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:10:31 INFO - Return code: 0 21:10:31 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 21:10:31 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')]} 21:10:31 INFO - https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:10:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:10:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:10:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/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 21:10:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/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 21:10:41 INFO - Downloaded 22486116 bytes. 21:10:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:10:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:10:42 INFO - Return code: 0 21:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:42 INFO - https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:10:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:10:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:10:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/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 21:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/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 21:10:44 INFO - Downloaded 11132144 bytes. 21:10:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:10:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 21:10:44 INFO - Return code: 0 21:10:44 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')]} 21:10:44 INFO - https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:10:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:10:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:10:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/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 21:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/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 21:10:47 INFO - Downloaded 55947012 bytes. 21:10:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:10:47 INFO - mkdir: /builds/slave/test-pgo/properties 21:10:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:10:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:10:47 INFO - Contents: 21:10:47 INFO - build_url:https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:10:47 INFO - Running post-action listener: _resource_record_post_action 21:10:47 INFO - Running post-action listener: set_extra_try_arguments 21:10:47 INFO - ##### 21:10:47 INFO - ##### Running populate-webroot step. 21:10:47 INFO - ##### 21:10:47 INFO - Running pre-action listener: _resource_record_pre_action 21:10:47 INFO - Running main action method: populate_webroot 21:10:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:10:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:10:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:10:47 INFO - '--tppagecycles', 21:10:47 INFO - '7'], 21:10:47 INFO - 'tests': ['tsvgm']}}, 21:10:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:10:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:10:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:10:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:10:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:10:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:10:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:10:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:47 INFO - 'talos_options': ['--e10s'], 21:10:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:10:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:47 INFO - 'tests': ['damp', 'tps']}, 21:10:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:47 INFO - 'talos_options': ['--e10s'], 21:10:47 INFO - 'tests': ['damp', 'tps']}, 21:10:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:10:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:10:47 INFO - 'other': {'tests': ['a11yr', 21:10:47 INFO - 'ts_paint', 21:10:47 INFO - 'tpaint', 21:10:47 INFO - 'sessionrestore', 21:10:47 INFO - 'sessionrestore_no_auto_restore']}, 21:10:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:10:47 INFO - 'tests': ['a11yr', 21:10:47 INFO - 'ts_paint', 21:10:47 INFO - 'tpaint', 21:10:47 INFO - 'sessionrestore', 21:10:47 INFO - 'sessionrestore_no_auto_restore']}, 21:10:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:10:47 INFO - 'tests': ['a11yr', 21:10:47 INFO - 'ts_paint', 21:10:47 INFO - 'tpaint', 21:10:47 INFO - 'sessionrestore', 21:10:47 INFO - 'sessionrestore_no_auto_restore']}, 21:10:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:10:47 INFO - 'tests': ['a11yr', 21:10:47 INFO - 'ts_paint', 21:10:47 INFO - 'tpaint', 21:10:47 INFO - 'sessionrestore', 21:10:47 INFO - 'sessionrestore_no_auto_restore']}, 21:10:47 INFO - 'other_l64': {'tests': ['a11yr', 21:10:47 INFO - 'ts_paint', 21:10:47 INFO - 'tpaint', 21:10:47 INFO - 'sessionrestore', 21:10:47 INFO - 'sessionrestore_no_auto_restore']}, 21:10:47 INFO - 'other_nol64': {'tests': ['a11yr', 21:10:47 INFO - 'ts_paint', 21:10:47 INFO - 'tpaint', 21:10:47 INFO - 'sessionrestore', 21:10:47 INFO - 'sessionrestore_no_auto_restore']}, 21:10:47 INFO - 'svgr': {'tests': ['tsvgx', 21:10:47 INFO - 'tsvgr_opacity', 21:10:47 INFO - 'tart', 21:10:47 INFO - 'tscrollx', 21:10:47 INFO - 'cart']}, 21:10:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:10:47 INFO - 'tests': ['tsvgx', 21:10:47 INFO - 'tsvgr_opacity', 21:10:47 INFO - 'tart', 21:10:47 INFO - 'tscrollx', 21:10:47 INFO - 'cart']}, 21:10:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:47 INFO - 'tests': ['tp5o']}, 21:10:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:47 INFO - 'talos_options': ['--e10s'], 21:10:47 INFO - 'tests': ['tp5o']}, 21:10:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:47 INFO - 'talos_options': ['--xperf_path', 21:10:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:10:47 INFO - 'tests': ['tp5n']}, 21:10:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:47 INFO - 'talos_options': ['--e10s', 21:10:47 INFO - '--xperf_path', 21:10:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:10:47 INFO - 'tests': ['tp5n']}}, 21:10:47 INFO - 'talos.zip': {'path': '', 21:10:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:10:47 INFO - Running post-action listener: _resource_record_post_action 21:10:47 INFO - ##### 21:10:47 INFO - ##### Running create-virtualenv step. 21:10:47 INFO - ##### 21:10:47 INFO - Running pre-action listener: _resource_record_pre_action 21:10:47 INFO - Running main action method: create_virtualenv 21:10:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:10:47 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 21:10:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:10:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:10:47 INFO - Using real prefix '/usr' 21:10:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:10:47 INFO - Installing distribute.............................................................................................................................................................................................done. 21:10:49 INFO - Installing pip.................done. 21:10:49 INFO - Return code: 0 21:10:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:10: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')]} 21:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f561444cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262b840>, '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 0x25986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2598b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', '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 21:10:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:10:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:10:49 INFO - Using env: {'DISPLAY': ':0', 21:10:49 INFO - 'HOME': '/home/cltbld', 21:10:49 INFO - 'LANG': 'en_US.UTF-8', 21:10:49 INFO - 'LANGUAGE': 'en_US:en', 21:10:49 INFO - 'LOGNAME': 'cltbld', 21:10:49 INFO - 'MAIL': '/var/mail/cltbld', 21:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:49 INFO - 'MOZ_NO_REMOTE': '1', 21:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:49 INFO - 'NO_EM_RESTART': '1', 21:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:10:49 INFO - 'PWD': '/builds/slave/test-pgo', 21:10:49 INFO - 'SHELL': '/bin/bash', 21:10:49 INFO - 'SHLVL': '1', 21:10:49 INFO - 'TERM': 'linux', 21:10:49 INFO - 'TMOUT': '86400', 21:10:49 INFO - 'USER': 'cltbld', 21:10:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', 21:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:49 INFO - '_': '/tools/buildbot/bin/python'} 21:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:49 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 21:10:49 INFO - Cleaning up... 21:10:49 INFO - Return code: 0 21:10:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:10: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')]} 21:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f561444cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262b840>, '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 0x25986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2598b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', '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 21:10:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:10:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:10:49 INFO - Using env: {'DISPLAY': ':0', 21:10:49 INFO - 'HOME': '/home/cltbld', 21:10:49 INFO - 'LANG': 'en_US.UTF-8', 21:10:49 INFO - 'LANGUAGE': 'en_US:en', 21:10:49 INFO - 'LOGNAME': 'cltbld', 21:10:49 INFO - 'MAIL': '/var/mail/cltbld', 21:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:49 INFO - 'MOZ_NO_REMOTE': '1', 21:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:49 INFO - 'NO_EM_RESTART': '1', 21:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:10:49 INFO - 'PWD': '/builds/slave/test-pgo', 21:10:49 INFO - 'SHELL': '/bin/bash', 21:10:49 INFO - 'SHLVL': '1', 21:10:49 INFO - 'TERM': 'linux', 21:10:49 INFO - 'TMOUT': '86400', 21:10:49 INFO - 'USER': 'cltbld', 21:10:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', 21:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:49 INFO - '_': '/tools/buildbot/bin/python'} 21:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:50 INFO - Downloading/unpacking psutil>=0.7.1 21:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:10:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:10:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:10:51 INFO - Installing collected packages: psutil 21:10:51 INFO - Running setup.py install for psutil 21:10:51 INFO - building 'psutil._psutil_linux' extension 21:10:51 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 21:10:52 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 21:10:52 INFO - building 'psutil._psutil_posix' extension 21:10:52 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 21:10:52 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 21:10:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:10:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:10:52 INFO - Successfully installed psutil 21:10:52 INFO - Cleaning up... 21:10:52 INFO - Return code: 0 21:10:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:10: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')]} 21:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f561444cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262b840>, '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 0x25986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2598b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', '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 21:10:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21:10:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:10:52 INFO - Using env: {'DISPLAY': ':0', 21:10:52 INFO - 'HOME': '/home/cltbld', 21:10:52 INFO - 'LANG': 'en_US.UTF-8', 21:10:52 INFO - 'LANGUAGE': 'en_US:en', 21:10:52 INFO - 'LOGNAME': 'cltbld', 21:10:52 INFO - 'MAIL': '/var/mail/cltbld', 21:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:52 INFO - 'MOZ_NO_REMOTE': '1', 21:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:52 INFO - 'NO_EM_RESTART': '1', 21:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:10:52 INFO - 'PWD': '/builds/slave/test-pgo', 21:10:52 INFO - 'SHELL': '/bin/bash', 21:10:52 INFO - 'SHLVL': '1', 21:10:52 INFO - 'TERM': 'linux', 21:10:52 INFO - 'TMOUT': '86400', 21:10:52 INFO - 'USER': 'cltbld', 21:10:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', 21:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:52 INFO - '_': '/tools/buildbot/bin/python'} 21:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:10:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:10:54 INFO - Installing collected packages: mozsystemmonitor 21:10:54 INFO - Running setup.py install for mozsystemmonitor 21:10:54 INFO - Successfully installed mozsystemmonitor 21:10:54 INFO - Cleaning up... 21:10:54 INFO - Return code: 0 21:10:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f561444cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262b840>, '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 0x25986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2598b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', '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 21:10:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:10:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:10:54 INFO - Using env: {'DISPLAY': ':0', 21:10:54 INFO - 'HOME': '/home/cltbld', 21:10:54 INFO - 'LANG': 'en_US.UTF-8', 21:10:54 INFO - 'LANGUAGE': 'en_US:en', 21:10:54 INFO - 'LOGNAME': 'cltbld', 21:10:54 INFO - 'MAIL': '/var/mail/cltbld', 21:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:54 INFO - 'MOZ_NO_REMOTE': '1', 21:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:54 INFO - 'NO_EM_RESTART': '1', 21:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:10:54 INFO - 'PWD': '/builds/slave/test-pgo', 21:10:54 INFO - 'SHELL': '/bin/bash', 21:10:54 INFO - 'SHLVL': '1', 21:10:54 INFO - 'TERM': 'linux', 21:10:54 INFO - 'TMOUT': '86400', 21:10:54 INFO - 'USER': 'cltbld', 21:10:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', 21:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:54 INFO - '_': '/tools/buildbot/bin/python'} 21:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:54 INFO - Downloading/unpacking blobuploader==1.2.4 21:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:56 INFO - Downloading blobuploader-1.2.4.tar.gz 21:10:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:10:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:10:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:57 INFO - Downloading docopt-0.6.1.tar.gz 21:10:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:10:57 INFO - Installing collected packages: blobuploader, requests, docopt 21:10:57 INFO - Running setup.py install for blobuploader 21:10:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:10:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:10:57 INFO - Running setup.py install for requests 21:10:57 INFO - Running setup.py install for docopt 21:10:57 INFO - Successfully installed blobuploader requests docopt 21:10:57 INFO - Cleaning up... 21:10:57 INFO - Return code: 0 21:10:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f561444cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262b840>, '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 0x25986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2598b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', '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 21:10:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:10:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:10:57 INFO - Using env: {'DISPLAY': ':0', 21:10:57 INFO - 'HOME': '/home/cltbld', 21:10:57 INFO - 'LANG': 'en_US.UTF-8', 21:10:57 INFO - 'LANGUAGE': 'en_US:en', 21:10:57 INFO - 'LOGNAME': 'cltbld', 21:10:57 INFO - 'MAIL': '/var/mail/cltbld', 21:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:57 INFO - 'MOZ_NO_REMOTE': '1', 21:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:57 INFO - 'NO_EM_RESTART': '1', 21:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:10:57 INFO - 'PWD': '/builds/slave/test-pgo', 21:10:57 INFO - 'SHELL': '/bin/bash', 21:10:57 INFO - 'SHLVL': '1', 21:10:57 INFO - 'TERM': 'linux', 21:10:57 INFO - 'TMOUT': '86400', 21:10:57 INFO - 'USER': 'cltbld', 21:10:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', 21:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:57 INFO - '_': '/tools/buildbot/bin/python'} 21:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:10:58 INFO - Running setup.py (path:/tmp/pip-1QenkE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:10:58 INFO - Running setup.py (path:/tmp/pip-lX1xlP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:10:58 INFO - Running setup.py (path:/tmp/pip-IgvOw3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:10:58 INFO - Running setup.py (path:/tmp/pip-S7HPPH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:10:58 INFO - Running setup.py (path:/tmp/pip-rAuVTU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:10:58 INFO - Running setup.py (path:/tmp/pip-3ZtUqS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:10:58 INFO - Running setup.py (path:/tmp/pip-K_CaNt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:10:58 INFO - Running setup.py (path:/tmp/pip-sso8h4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:10:58 INFO - Running setup.py (path:/tmp/pip-T7YLhy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:10:58 INFO - Running setup.py (path:/tmp/pip-9DIgKD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:10:58 INFO - Running setup.py (path:/tmp/pip-xcXOSI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:10:58 INFO - Running setup.py (path:/tmp/pip-aXdMXh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:10:59 INFO - Running setup.py (path:/tmp/pip-68b4MO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:10:59 INFO - Running setup.py (path:/tmp/pip-HQzo57-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:10:59 INFO - Running setup.py (path:/tmp/pip-2vsKWH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:10:59 INFO - Running setup.py (path:/tmp/pip-FJ4ze3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:10:59 INFO - Running setup.py (path:/tmp/pip-Deyc25-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:10:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:10:59 INFO - Running setup.py install for manifestparser 21:10:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:10:59 INFO - Running setup.py install for mozcrash 21:10:59 INFO - Running setup.py install for mozdebug 21:10:59 INFO - Running setup.py install for mozdevice 21:10:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:10:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:10:59 INFO - Running setup.py install for mozfile 21:10:59 INFO - Running setup.py install for mozhttpd 21:11:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:11:00 INFO - Running setup.py install for mozinfo 21:11:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:11:00 INFO - Running setup.py install for mozInstall 21:11:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:11:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:11:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:11:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:11:00 INFO - Running setup.py install for mozleak 21:11:00 INFO - Running setup.py install for mozlog 21:11:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:11:00 INFO - Running setup.py install for moznetwork 21:11:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:11:00 INFO - Running setup.py install for mozprocess 21:11:00 INFO - Running setup.py install for mozprofile 21:11:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:11:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:11:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:11:00 INFO - Running setup.py install for mozrunner 21:11:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:11:00 INFO - Running setup.py install for mozscreenshot 21:11:00 INFO - Running setup.py install for moztest 21:11:01 INFO - Running setup.py install for mozversion 21:11:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:11:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:11:01 INFO - Cleaning up... 21:11:01 INFO - Return code: 0 21:11:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:11: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')]} 21:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11: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')]} 21:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f561444cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262b840>, '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 0x25986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2598b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', '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 21:11:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:11:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:11:01 INFO - Using env: {'DISPLAY': ':0', 21:11:01 INFO - 'HOME': '/home/cltbld', 21:11:01 INFO - 'LANG': 'en_US.UTF-8', 21:11:01 INFO - 'LANGUAGE': 'en_US:en', 21:11:01 INFO - 'LOGNAME': 'cltbld', 21:11:01 INFO - 'MAIL': '/var/mail/cltbld', 21:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:01 INFO - 'MOZ_NO_REMOTE': '1', 21:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:01 INFO - 'NO_EM_RESTART': '1', 21:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:11:01 INFO - 'PWD': '/builds/slave/test-pgo', 21:11:01 INFO - 'SHELL': '/bin/bash', 21:11:01 INFO - 'SHLVL': '1', 21:11:01 INFO - 'TERM': 'linux', 21:11:01 INFO - 'TMOUT': '86400', 21:11:01 INFO - 'USER': 'cltbld', 21:11:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', 21:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:01 INFO - '_': '/tools/buildbot/bin/python'} 21:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:11:01 INFO - Running setup.py (path:/tmp/pip-tAPa_F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:11:01 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)) 21:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:11:01 INFO - Running setup.py (path:/tmp/pip-oa2if4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:11:01 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)) 21:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:11:01 INFO - Running setup.py (path:/tmp/pip-0QNBsT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:11:01 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)) 21:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:11:01 INFO - Running setup.py (path:/tmp/pip-TndH_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:11:01 INFO - Running setup.py (path:/tmp/pip-EeKpsS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:11:01 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)) 21:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:11:01 INFO - Running setup.py (path:/tmp/pip-Xb2XcB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:11:01 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)) 21:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:11:01 INFO - Running setup.py (path:/tmp/pip-R4yKCO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:11:01 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)) 21:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:11:01 INFO - Running setup.py (path:/tmp/pip-_P2YJf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:11:01 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)) 21:11:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:11:01 INFO - Running setup.py (path:/tmp/pip-7bMtIh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:11:02 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)) 21:11:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:11:02 INFO - Running setup.py (path:/tmp/pip-TOEVGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:11:02 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)) 21:11:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:11:02 INFO - Running setup.py (path:/tmp/pip-bw8ds4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:11:02 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)) 21:11:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:11:02 INFO - Running setup.py (path:/tmp/pip-xixEbF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:11:02 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)) 21:11:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:11:02 INFO - Running setup.py (path:/tmp/pip-mt7b2t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:11:02 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)) 21:11:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:11:02 INFO - Running setup.py (path:/tmp/pip-ld58d9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:11:02 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)) 21:11:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:11:02 INFO - Running setup.py (path:/tmp/pip-6HPIIp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:11:02 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)) 21:11:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:11:02 INFO - Running setup.py (path:/tmp/pip-XQWLqN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:11:02 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)) 21:11:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:11:02 INFO - Running setup.py (path:/tmp/pip-7vSGkB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:11:02 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)) 21:11:02 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)) 21:11:02 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)) 21:11:02 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)) 21:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:11:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:11:02 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 21:11:02 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 21:11:02 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 21:11:02 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 21:11:02 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 21:11:02 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 21:11:04 INFO - Downloading blessings-1.6.tar.gz 21:11:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:11:04 INFO - Installing collected packages: blessings 21:11:04 INFO - Running setup.py install for blessings 21:11:04 INFO - Successfully installed blessings 21:11:04 INFO - Cleaning up... 21:11:04 INFO - Return code: 0 21:11:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:11:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:11:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:11:04 INFO - Reading from file tmpfile_stdout 21:11:04 INFO - Current package versions: 21:11:04 INFO - argparse == 1.2.1 21:11:04 INFO - blessings == 1.6 21:11:04 INFO - blobuploader == 1.2.4 21:11:04 INFO - docopt == 0.6.1 21:11:04 INFO - manifestparser == 1.1 21:11:04 INFO - mozInstall == 1.12 21:11:04 INFO - mozcrash == 0.16 21:11:04 INFO - mozdebug == 0.1 21:11:04 INFO - mozdevice == 0.48 21:11:04 INFO - mozfile == 1.2 21:11:04 INFO - mozhttpd == 0.7 21:11:04 INFO - mozinfo == 0.9 21:11:04 INFO - mozleak == 0.1 21:11:04 INFO - mozlog == 3.1 21:11:04 INFO - moznetwork == 0.27 21:11:04 INFO - mozprocess == 0.22 21:11:04 INFO - mozprofile == 0.28 21:11:04 INFO - mozrunner == 6.11 21:11:04 INFO - mozscreenshot == 0.1 21:11:04 INFO - mozsystemmonitor == 0.0 21:11:04 INFO - moztest == 0.7 21:11:04 INFO - mozversion == 1.4 21:11:04 INFO - psutil == 3.1.1 21:11:04 INFO - requests == 1.2.3 21:11:04 INFO - wsgiref == 0.1.2 21:11:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:11: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')]} 21:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11: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')]} 21:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f561444cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262b840>, '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 0x25986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2598b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', '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 21:11:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 21:11:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:11:04 INFO - Using env: {'DISPLAY': ':0', 21:11:04 INFO - 'HOME': '/home/cltbld', 21:11:04 INFO - 'LANG': 'en_US.UTF-8', 21:11:04 INFO - 'LANGUAGE': 'en_US:en', 21:11:04 INFO - 'LOGNAME': 'cltbld', 21:11:04 INFO - 'MAIL': '/var/mail/cltbld', 21:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:04 INFO - 'MOZ_NO_REMOTE': '1', 21:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:04 INFO - 'NO_EM_RESTART': '1', 21:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:11:04 INFO - 'PWD': '/builds/slave/test-pgo', 21:11:04 INFO - 'SHELL': '/bin/bash', 21:11:04 INFO - 'SHLVL': '1', 21:11:04 INFO - 'TERM': 'linux', 21:11:04 INFO - 'TMOUT': '86400', 21:11:04 INFO - 'USER': 'cltbld', 21:11:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', 21:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:04 INFO - '_': '/tools/buildbot/bin/python'} 21:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:05 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)) 21:11:05 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)) 21:11:05 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)) 21:11:05 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)) 21:11:05 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)) 21:11:05 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)) 21:11:05 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)) 21:11:05 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)) 21:11:05 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)) 21:11:05 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)) 21:11:05 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)) 21:11:05 INFO - Cleaning up... 21:11:05 INFO - Return code: 0 21:11:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f561444cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262b840>, '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 0x25986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2598b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', '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 21:11:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 21:11:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:11:05 INFO - Using env: {'DISPLAY': ':0', 21:11:05 INFO - 'HOME': '/home/cltbld', 21:11:05 INFO - 'LANG': 'en_US.UTF-8', 21:11:05 INFO - 'LANGUAGE': 'en_US:en', 21:11:05 INFO - 'LOGNAME': 'cltbld', 21:11:05 INFO - 'MAIL': '/var/mail/cltbld', 21:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:05 INFO - 'MOZ_NO_REMOTE': '1', 21:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:05 INFO - 'NO_EM_RESTART': '1', 21:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:11:05 INFO - 'PWD': '/builds/slave/test-pgo', 21:11:05 INFO - 'SHELL': '/bin/bash', 21:11:05 INFO - 'SHLVL': '1', 21:11:05 INFO - 'TERM': 'linux', 21:11:05 INFO - 'TMOUT': '86400', 21:11:05 INFO - 'USER': 'cltbld', 21:11:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', 21:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:05 INFO - '_': '/tools/buildbot/bin/python'} 21:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:05 INFO - Downloading/unpacking jsonschema 21:11:05 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 21:11:05 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 21:11:05 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 21:11:05 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 21:11:05 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 21:11:05 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 21:11:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:11:07 INFO - Downloading/unpacking functools32 (from jsonschema) 21:11:07 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 21:11:07 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 21:11:07 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 21:11:07 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 21:11:07 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 21:11:07 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 21:11:07 INFO - Downloading functools32-3.2.3-2.tar.gz 21:11:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:11:07 INFO - warning: no files found matching '*.txt' 21:11:07 INFO - no previously-included directories found matching 'build' 21:11:07 INFO - no previously-included directories found matching 'dist' 21:11:07 INFO - no previously-included directories found matching '.git*' 21:11:07 INFO - Installing collected packages: jsonschema, functools32 21:11:07 INFO - Running setup.py install for functools32 21:11:07 INFO - warning: no files found matching '*.txt' 21:11:07 INFO - no previously-included directories found matching 'build' 21:11:07 INFO - no previously-included directories found matching 'dist' 21:11:07 INFO - no previously-included directories found matching '.git*' 21:11:07 INFO - Successfully installed jsonschema functools32 21:11:07 INFO - Cleaning up... 21:11:07 INFO - Return code: 0 21:11:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:11:07 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')]} 21:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:07 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')]} 21:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f561444cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262b840>, '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 0x25986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2598b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', '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 21:11:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 21:11:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:11:07 INFO - Using env: {'DISPLAY': ':0', 21:11:07 INFO - 'HOME': '/home/cltbld', 21:11:07 INFO - 'LANG': 'en_US.UTF-8', 21:11:07 INFO - 'LANGUAGE': 'en_US:en', 21:11:07 INFO - 'LOGNAME': 'cltbld', 21:11:07 INFO - 'MAIL': '/var/mail/cltbld', 21:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:07 INFO - 'MOZ_NO_REMOTE': '1', 21:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:07 INFO - 'NO_EM_RESTART': '1', 21:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:11:07 INFO - 'PWD': '/builds/slave/test-pgo', 21:11:07 INFO - 'SHELL': '/bin/bash', 21:11:07 INFO - 'SHLVL': '1', 21:11:07 INFO - 'TERM': 'linux', 21:11:07 INFO - 'TMOUT': '86400', 21:11:07 INFO - 'USER': 'cltbld', 21:11:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', 21:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:07 INFO - '_': '/tools/buildbot/bin/python'} 21:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:07 INFO - Downloading/unpacking flake8 21:11:07 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 21:11:07 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 21:11:07 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 21:11:07 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 21:11:07 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 21:11:07 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 21:11:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:11:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:11:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:11:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:11:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:11:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:11:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:11:10 INFO - no previously-included directories found matching 'docs/_build' 21:11:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:11:10 INFO - Running setup.py install for pep8 21:11:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:11:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:11:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:11:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:11:10 INFO - no previously-included directories found matching 'docs/_build' 21:11:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:11:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:11:10 INFO - Cleaning up... 21:11:10 INFO - Return code: 0 21:11:10 INFO - Running post-action listener: _resource_record_post_action 21:11:10 INFO - Running post-action listener: _start_resource_monitoring 21:11:10 INFO - Starting resource monitoring. 21:11:10 INFO - ##### 21:11:10 INFO - ##### Running install step. 21:11:10 INFO - ##### 21:11:10 INFO - Running pre-action listener: _resource_record_pre_action 21:11:10 INFO - Running main action method: install 21:11:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:11:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:11:10 INFO - Reading from file tmpfile_stdout 21:11:10 INFO - Detecting whether we're running mozinstall >=1.0... 21:11:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:11:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:11:10 INFO - Reading from file tmpfile_stdout 21:11:10 INFO - Output received: 21:11:10 INFO - Usage: mozinstall [options] installer 21:11:10 INFO - Options: 21:11:10 INFO - -h, --help show this help message and exit 21:11:10 INFO - -d DEST, --destination=DEST 21:11:10 INFO - Directory to install application into. [default: 21:11:10 INFO - "/builds/slave/test-pgo"] 21:11:10 INFO - --app=APP Application being installed. [default: firefox] 21:11:10 INFO - mkdir: /builds/slave/test-pgo/build/application 21:11:10 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'] 21:11:10 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 21:11:26 INFO - Reading from file tmpfile_stdout 21:11:26 INFO - Output received: 21:11:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:11:26 INFO - Running post-action listener: _resource_record_post_action 21:11:26 INFO - ##### 21:11:26 INFO - ##### Running run-tests step. 21:11:26 INFO - ##### 21:11:26 INFO - Running pre-action listener: _resource_record_pre_action 21:11:26 INFO - Running main action method: run_tests 21:11:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:11:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:11:26 INFO - Python 2.7.3 21:11:26 INFO - Return code: 0 21:11:26 INFO - grabbing minidump binary from tooltool 21:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:11:26 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 0x262b840>, '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 0x25986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2598b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:11:26 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 21:11:26 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 21:11:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:11:26 INFO - Return code: 0 21:11:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:11:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:11:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:11:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:11:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:11:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:11:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:11:27 INFO - Return code: 0 21:11:27 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/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 21:11:27 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/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 21:11:27 INFO - Using env: {'DISPLAY': ':0', 21:11:27 INFO - 'HOME': '/home/cltbld', 21:11:27 INFO - 'LANG': 'en_US.UTF-8', 21:11:27 INFO - 'LANGUAGE': 'en_US:en', 21:11:27 INFO - 'LOGNAME': 'cltbld', 21:11:27 INFO - 'MAIL': '/var/mail/cltbld', 21:11:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:11:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:27 INFO - 'MOZ_NO_REMOTE': '1', 21:11:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:27 INFO - 'NO_EM_RESTART': '1', 21:11:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:11:27 INFO - 'PWD': '/builds/slave/test-pgo', 21:11:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:11:27 INFO - 'SHELL': '/bin/bash', 21:11:27 INFO - 'SHLVL': '1', 21:11:27 INFO - 'TERM': 'linux', 21:11:27 INFO - 'TMOUT': '86400', 21:11:27 INFO - 'USER': 'cltbld', 21:11:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258', 21:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:27 INFO - '_': '/tools/buildbot/bin/python'} 21:11:27 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/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 21:11:27 INFO - mozversion application_buildid: 20160120185004 21:11:27 INFO - mozversion application_changeset: 493d6820745e4e3ed22e48a5f9229ea033a64a3a 21:11:27 INFO - mozversion application_display_name: Nightly 21:11:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:11:27 INFO - mozversion application_name: Firefox 21:11:27 INFO - mozversion application_remotingname: firefox 21:11:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:11:27 INFO - mozversion application_vendor: Mozilla 21:11:27 INFO - mozversion application_version: 46.0a1 21:11:27 INFO - mozversion platform_buildid: 20160120185004 21:11:27 INFO - mozversion platform_changeset: 493d6820745e4e3ed22e48a5f9229ea033a64a3a 21:11:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:11:27 INFO - mozversion platform_version: 46.0a1 21:11:27 INFO - using testdate: 1453353087 21:11:27 INFO - actual date: 1453353087 21:11:27 INFO - starting webserver on 'localhost:57176' 21:11:27 INFO - SUITE-START | Running 3 tests 21:11:27 INFO - TEST-START | dromaeo_css 21:11:27 INFO - operating with platform_type : linux_ 21:11:27 INFO - Initialising browser for dromaeo_css test... 21:11:27 INFO - TEST-INFO | started process 16934 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkWSitC/profile http://localhost:57176/getInfo.html) 21:11:31 INFO - PROCESS | 16934 | 21:11:31 INFO - PROCESS | 16934 | (process:17015): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:11:32 INFO - PROCESS | 16934 | __metrics Screen width/height:1600/1200 21:11:32 INFO - PROCESS | 16934 | colorDepth:24 21:11:32 INFO - PROCESS | 16934 | Browser inner width/height: 1024/697 21:11:32 INFO - PROCESS | 16934 | __metrics 21:11:32 INFO - PROCESS | 16934 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:11:33 INFO - TEST-INFO | 16934: exit 0 21:11:33 INFO - Browser initialized. 21:11:33 INFO - Running cycle 1/1 for dromaeo_css test... 21:11:33 INFO - TEST-INFO | started process 17064 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkWSitC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:11:34 INFO - PROCESS | 17064 | -- checkerboarding starts below -- 21:11:34 INFO - PROCESS | 17064 | RENDERTRACE 0.138076 rect red 0 0 10 10 // viewport 21:11:34 INFO - PROCESS | 17064 | RENDERTRACE 16.9057 rect brown 0 0 10 10 // page 21:11:34 INFO - PROCESS | 17064 | RENDERTRACE 16.9462 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 21:11:34 INFO - PROCESS | 17064 | Checkerboarded for 1 frames (17.0142 ms), 100 peak, 5 severity. 21:11:34 INFO - PROCESS | 17064 | 21:11:34 INFO - PROCESS | 17064 | (process:17124): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:11:45 INFO - PROCESS | 17064 | RSS: Main: 150691840 21:11:45 INFO - PROCESS | 17064 | 21:12:35 INFO - PROCESS | 17064 | 1453353155094 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] 21:14:44 INFO - PROCESS | 17064 | Cycle 1(1): loaded http://localhost:57176/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57176/tests/dromaeo/cssquery-ext.html) 21:14:45 INFO - PROCESS | 17064 | RSS: Main: 156413952 21:14:45 INFO - PROCESS | 17064 | 21:17:47 INFO - PROCESS | 17064 | Cycle 1(1): loaded http://localhost:57176/tests/dromaeo/cssquery-ext.html (next: http://localhost:57176/tests/dromaeo/cssquery-jquery.html) 21:17:48 INFO - PROCESS | 17064 | RSS: Main: 151588864 21:17:48 INFO - PROCESS | 17064 | 21:20:49 INFO - PROCESS | 17064 | Cycle 1(1): loaded http://localhost:57176/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57176/tests/dromaeo/cssquery-mootools.html) 21:20:50 INFO - PROCESS | 17064 | RSS: Main: 150794240 21:20:50 INFO - PROCESS | 17064 | 21:23:52 INFO - PROCESS | 17064 | Cycle 1(1): loaded http://localhost:57176/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57176/tests/dromaeo/cssquery-prototype.html) 21:23:52 INFO - PROCESS | 17064 | RSS: Main: 150089728 21:23:52 INFO - PROCESS | 17064 | 21:26:55 INFO - PROCESS | 17064 | Cycle 1(1): loaded http://localhost:57176/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57176/tests/dromaeo/cssquery-yui.html) 21:26:55 INFO - PROCESS | 17064 | RSS: Main: 151035904 21:26:55 INFO - PROCESS | 17064 | 21:29:58 INFO - PROCESS | 17064 | Cycle 1(1): loaded http://localhost:57176/tests/dromaeo/cssquery-yui.html (next: http://localhost:57176/tests/dromaeo/cssquery-dojo.html) 21:29:58 INFO - PROCESS | 17064 | RSS: Main: 154009600 21:29:58 INFO - PROCESS | 17064 | 21:29:58 INFO - PROCESS | 17064 | __start_tp_report 21:29:58 INFO - PROCESS | 17064 | _x_x_mozilla_page_load 21:29:58 INFO - PROCESS | 17064 | _x_x_mozilla_page_load_details 21:29:58 INFO - PROCESS | 17064 | |i|pagename|runs| 21:29:58 INFO - PROCESS | 17064 | |0;dojo.html;3148.9685103148977;3173.8571764270605;3209.390215858986;3222.3877463281974;3228.3381906709124;5298.867528311785;5409.729513524323;5451.37309209441;5466.535344495717;5468.617196796221;5381.461853814617;5448.700321482317;5470.316210473691;5491.450854914507;5508.256385387971;4903.9754801225945;4910.116179087763;4944.530269624398;4987.17711577591;5008.2738002989545;4972.428170760355;4985.6759310644875;5007.624428167902;5027.874303142414;5037.874053148664;4840.709557426548;4872.78072486739;4914.21372580389;4942;4983.8504844854715;4923.80304787808;4929.556339929388;4930.186519224324;4949.975250123726;4976.576990955773;4904.5831104356175;4912.8526144215375;4933.679310844784;4940.827071052532;4953.405591329064;5217.295665085241;5236.083685355047;5280.445553216895;5363.088274993261;5419.078756611386;5780.104083867007;5832.24180856486;5834.4165583441745;5838.854028649275;5863.2670916135485;5703;5889.116632505158;5903.114532820068;5915.940840591582;5917.408259174092;5297.046531624344;5299.31108955841;5359.196120581905;5366.973165134188;5375.704336261504;5906.438888305604;6030.6080104793045;6034.849128771728;6038.728257228435;6097.817065488042;5729.7708091676695;5733.512651424592;5748.19525266463;5790.507806836466;5791.565632577489;5750.942490575125;5840.88318233633;5901.822945311562;5901.822945311647;5914.9112763308585;5738.971305143447;5779.3642699303045;5780.595358324961;5797.681127538026;5830.795922142789;5688.943110568925;5696.088625819932;5706.629069110494;5725.08398656213;5739.942600574024;4428.645708343325;4473.351364052194;4478.596926276651;4480.955190448119;4506.752128632957;3980.86066987654;3982.482277303932;3983.6813054955533;3988.142549351903;4008.8396464141692;5373.301470808769;5388.326459192601;5416.674999500043;5419.376771671229;5440.619156659075;5770.596058275881;5774.711264436845;5812.505936995318;5836.182934389189;5901.822945311647;5420.53925416344;5448.891022179534;5464.9453505464435;5502.367227768857;5528.612997090165;4959.181735013754;4985.451600323961;5000.024995125916;5004.899902001939;5037.647364684437;5916.467517923407;5939.673317967467;5978.372270911578;6053.334133245339;6082.878342433127;5843.328017278068;5903.881922361615;5919.467247947706;5934.317553481233;5960.5827592068135;6017.969910150421;6037.335893051849;6053.182820319201;6064.878702426015;6101.267847858286;5709.115087161496;5710.771569137354;5775.595708300547;5777.422257774357;5842.444967728059;5833.737481813244;5835.620684655484;5836.095405212199;5840.328362238397;5871.031279838779;5667.829965101054;5674.517665998436;5698.088305871041;5699.629524080921;5721.942780572141;5648.661080335193;5665.405132461032;5699.487046165865;5722.0272553665145;5823.097419899922;5592.189132575672;5593.440655934374;5623.662580245198;5649.68926709035;5677.630953987978;5720.8283751487525;5722.542196624343;5730.054541000688;5738.311402631711;5821.94178058214;5514.283143191359;5599.888002239851;5670.262865827416;5674.120511320752;5743.483086522233 21:29:58 INFO - PROCESS | 17064 | |1;ext.html;522.9346331708537;524.7848382163312;529.7218960045975;547.8850539152824;554.1189508681196;35027;35746.64253357465;35755.28489430216;35930.461043084375;35944;38647;39390.60609393905;39487.802560987155;39500.80249598748;39583.20833583327;8475.618597163128;8557.144285571425;8626.3098952084;8638;8676.089010653885;8313.667453301861;8468.407211495198;8480.66077356905;8498.065212826585;8538.146185381474;8694.56527173642;8777.42946708465;8783.47299162049;8801.383903126783;8808.691695790649;8545.700900468484;8615.267702245254;8674.956625216864;8722.171393717586;8757.2994160467;8558.400911936167;8649.610767515414;8659.696910608098;8660.393772435931;8691.478511289342;38153.0461738456;38318.42522362139;38481.80759096215;38660.806695966625;38703;3280.934381312384;3296.8186749728757;3366.629670736217;3466.0988143082727;3663.5786884508357;28738.425231495254;28764;29095.854520727262;29408.705912941026;29912.10263692093;3875.5930627284292;3958.1094253792953;3982.721209515335;4062.0454193264854;4116.629503344713;245691.99999999822;245751;245857;246143;247531;53567.464325357025;53668.73165634225;53712.73143634257;53803;53811.695064395535;56351;56498;56596.43403565994;56613.71693141508;56672.14991775127;12575.5598554052;12846.807297890538;12853.871461285455;12888.871111288954;12941.547045853538;9976.152027077635;10052.095311421861;10053.994600540034;10062.496875156214;10070.899291007143;17781;17890.194941227415;18101.547461313574;18117.547061323574;18152;6935.202451718016;7151.642417879085;7263.636818159071;7268.309510596485;7318.377937875233;944.2257348973912;979.6326377608397;1052.3843551522293;1069.844872493484;1078.9082927951213;27111.1866644001;27717.722822771917;27758.3060423487;28046.579301310496;28052.158435246976;934.4860326820221;988.421773262635;999.1008092716468;1001.1690297053428;1080.4327727942893;12981.870181298065;13341.399637016357;13386.330683465787;15051.322690478955;15314.923425382802;342296;342701;342814;342873;343390;46580;47021.5297847024;47071.76464117726;47107.29339059917;47343.76328118406;1324.5628942448968;1350.122420426711;1360.5986234060977;1361.7616917039281;1365.2286458151113;27711.30721731973;27999.74001169993;28047.298817529725;28559.714402855705;28598;42661.14677706367;42732.78633606812;42901.570984289756;43077.3538396918;43239.56760432355;241104;242061;244301.12042717167;313156;314095;29041.7095829039;29468.463784346015;29518.55722164212;29630.259243519085;29759.85120074386;40666;40884;40916;40921.79539102285;40988.79505602453;34367.82816085903;34941.825290873385;35033.29933401369;35372.86884311779;35603.46594801132;33976.66023339735;34239;34806.65193348034;35240.295194096485;35605.46591801177;30791.2302192447;31155.37689246157;31159.37681246317;31301.686983129875;34435.65564344425;27923.860380697966;28034.71965280321;28922.855385722938;28967.420651586428;29639.851800741722;22694.886525567268;23617.527649446572;24017.712764634456;24201.51596968086;24228.757712422652 21:29:58 INFO - PROCESS | 17064 | |2;jquery.html;362.40022762328357;363.041570254528;364.30963324500067;366.836757642849;367.3662931443259;16068.51794446167;16889.662206755856;16967.745483817736;17587.120643967814;17846.553836154104;10053.346532475402;10402.63590774323;15637.218139093056;16085.356585736556;16196.623287020617;4883.438404583474;5179.8446046618665;5382.6232163748555;5391.838244852641;5394.406615272317;5346.27825243593;5374.543163831079;5379.542738867201;5551.72241387931;5599.41206173352;5553.333599967989;5581.469760372778;6407.679616019203;6787.728490860384;6793.490488213379;6523.967380163116;6672.266050734415;6684.164479440045;6727;6794.490413218979;6290.9685451572905;6503.479721622259;6503.7073331700185;6513.511486638521;6522.902156467657;21124.577508449744;21211.78788212129;21551.67672484914;22701.43246418853;22867.542649146922;2215.3796936857707;2224.8442609017375;2265.716785401825;2294.6099163142308;2332.288651961151;13568.253746043963;13826.585202443943;13864.792028119586;14063.43746250159;14197.716045679028;1909.4844392014218;1927.7108433734911;1932.9323473678494;1994.7107669388004;2003.2888324644687;59430.702846485925;60288;61361;61659.38340616581;63371;14453.49412770569;14898.702025959421;14905.68961810921;14927.776083358542;15006.62483437901;22837.31488055361;22845.543089138126;22950.42623934415;23253.302400927998;23264.65103023456;7739.7678069658;7848.803779905548;7955.721549745731;8030.277275045274;8071.919280807117;6378;6471.385218404244;6478.838029049311;6480.4815614750705;6493.967530162319;7524.887126693104;7528.397728181732;7550.735724249735;7570.318671319607;7579.090509138939;1813.737008133813;1827.1412436155251;2946.2781618503604;3020.969790302113;3037.650670172914;935;964.344245912786;984.5028260728286;1003.6988903328972;1036.4972988100765;15894.9205253973;16012.759808602881;16099.758503622455;16302.755458668129;16437.83562164387;926.5089502563652;942.641796117471;988.4859872866214;1000.4688139008321;1033.0289527843802;7959.522428654299;9389.154976052188;9902.405855648683;9930.851037234448;10325.948370258251;495114;505874;510864;544562;547578;66325;67251.3274867245;69080.6545967267;70887.64556177186;75012.62493687606;1112.6550769261555;1145.0610499390586;1158.623447379605;1158.8030034894089;1170.7014711248578;14882.553523394316;14986.100833949999;15013.099214047192;15259.542213733606;15358.539243822703;31679;31911;32195.195120122185;32273.51589726203;32809.671903280665;40484.59515404808;41436.792816035726;41516.58483415127;42731.786341068095;42811.35782963196;7032.437405007485;7267.236940121423;7437.958685783887;7459.515131516434;7507.924920750941;7822.687087535799;9884.604615815575;10583.153347732317;10735.302205356627;11222.438878056228;8150.9184908150155;8641.740747777576;9289.814203715752;9697;9750.902490974999;9158.358914875895;9487.857682134636;9513.762155946157;9546.522673866419;9559.139677429064;8986;9166.22087122602;9231.723048308562;9380;9420.576074076545;7267.854642907007;7384.224656410999;7394.704211831467;7442.404607631268;7505.136909255505;8298.917010830057;8760.342974277082;9106.453612782989;9138.954305228432;9168.54157292146 21:29:58 INFO - PROCESS | 17064 | |3;mootools.html;1455.1414665347445;1480.3486465954982;1631.3066946547715;1760.471858442467;1786.8302511261434;7671.271229233221;7841.882371764414;7951.204879512046;7977.481463704862;7979.960100199491;7968.641411136498;7973.720919767809;7998.560079195642;8051.792231165328;8061.274485296322;2239.85440946338;2259.401258666455;2260.4235919840416;2272.988635056822;2277.6583512473094;2296.8392212545127;2320.3619004773655;2337.614293641547;2338.8830558472096;2341.180586794617;2209.4807720185822;2292.6561015847674;2302.355340504653;2302.435903203709;2335.8131349492;2264.9660255096187;2282.075759317479;2306.400335912658;2315.0392587076426;2316.2819525946843;2310.1798861404127;2332.07882886259;2338.09983156486;2338.1232037985756;2342.672025916373;7741.57421341826;7839.294463498256;7845;7857.1749966253865;7857.410694197958;4755.405574303212;4941.135301322254;4941.308216849644;4942.258661200813;4950.504949505057;3098.860551275198;3130.827804470753;3205;3206.567113439679;3222.6455089940087;1041.5261056219401;1046.8325067989085;1050.8633877595864;1059.9523021463976;1065.339489516497;11000.724981875437;11022.063124634416;11061;11089.112870970384;11128.554857805759;4138.503379594468;4221.261279276176;4251.915761480803;4265.4241677373775;4316.179925814085;8926.375153739305;8944.105589441004;8968;8984.55077246135;8990.505522196341;4832.661713680079;4835.395575553056;4840.394950631171;4859.927101093486;4862.222044472867;4394.582514661102;4399.5380485049245;4425.579569940915;4425.889352766142;4443.044745379759;3361.2941282330494;3380.560527131457;3398.116489712643;3406.5060566217758;3426.1777173478185;1020.1430798129607;1020.9744756381001;1023.7133602591286;1027.6968294353185;1029.1766586730585;1058.2063452410691;1072.303003048025;1074.957001719938;1206.1737709668905;1333.919964802115;7052.894206586802;7114.822129446702;7140;7157.964210178916;7357.374623157091;1040.2770074798093;1050.669039252633;1059.057438879398;1118.552578968403;1138.5616537632905;5480.972595137078;5550.7779688812;5554.028045092093;5558.805441809517;5564.944350556523;8976.147266009719;9629.951850240845;9789.608415663437;10016.54925528353;10036.347637403545;9750.414975101517;9756.219502439788;9774.951125244328;9815.36200146988;9828.115469607626;7452.515586486861;7604.733834315773;7620.733274335372;7682.1549629540705;7715.498492597963;7173.42612590981;7316.9634151828905;7342.853142937218;7383.261673832574;7404.074490688664;8465.153484651486;8635.481871087755;8723.171298726611;8858.557072146237;8929.821403572023;8474.27968622674;8906.332025098272;9054.41146325513;9126.5436728162;9163.725088247364;6818.249992500921;6889.069975553236;6896.137982752156;6899.344562266577;6916.619585922823;7614.733484328022;7642.65608047628;7727.536347819148;7744.1094274159195;7769.456138070281;6957.582545047313;7315.561066336037;7331.560106393634;7391.852162956819;7606.733764318223;6890.965545172242;7086.433085353263;7123.608201548965;7169.892451613126;7210.819729506804;7024.754133605299;7038.964805175941;7065.858682826418;7068.081149450744;7071.611061391673;6365.61806291624;6427.1002059710745;6440.066190402459;6450.774222902363;6457.515686323451;6174.228221472316;6452.161219041494;6521.673916304071;6556.18047744032;6575.112359831362 21:29:58 INFO - PROCESS | 17064 | |4;prototype.html;324.681811824412;327.8885179039126;331.14894720568134;335.24736965512426;339.92521645238037;6203.410675985785;6303.243610766709;6327.209098862642;6372.458341041017;6407.167068281123;6067.726952287147;6132.773445310944;6158.261008678954;6179.876402471948;6208.099825525296;4691.882702932428;4730.172219861511;4730.243161094226;4741.5495527924795;4742.857714268577;4740.76296185191;4748.121597504455;4748.857534273978;4749.952500474986;4758.952410475886;4607.539246075399;4636.072785442908;4664.230401983668;4714.104320179172;4718.90562188756;4675.438947326308;4687.0625874825;4693.155232058211;4704.858854234379;4706;4043.2115737431213;4072.857449989236;4098.282800509929;4104.1381309924955;4110.876673699794;5857.6778277194735;5899.970500147472;5903.675297858616;5910.67491287979;5924.081767326072;5279.260903473517;5429.945700542983;5433.538149257279;5446.346438427375;5457.672539647594;6484.902726459107;6564.21229452464;6580.4406625436895;6583.637899915503;6584.341565843425;4458.1306645204195;4461.754603496806;4463.33050042493;4465.486469056068;4465.68740188187;6706.5640733352175;6860.5197636165485;6901.068355772007;6908.447324214051;6922.41159501443;4541.364209010741;4560.270356742905;4566.88582785433;4571.885702857388;4578.198815207325;4604.815807367735;4628.514006029319;4640.814367425265;4654.464736555339;4666.2767271073035;5437.918431223535;5439.347278326547;5442.156465747816;5442.374126975369;5447;6464.709088091047;6688.331166883273;6693.79918602433;6707.664616769142;6714.597124172566;1610.8630766384988;1615.4588212948559;1657.6187476880384;1659.203582280488;1659.6929568029952;1052.4527245832278;1075.876274228458;1079.0396547073112;1081.7944590527775;1084.5553323137476;6215.12988181655;6224.688765561704;6255.24937007562;6255.40573645503;6259.4679452246155;6780.864382712417;6791.049253104569;6798.252192258848;6801.761938332134;6803.2856550062525;6011.008183649649;6250.343713910065;6254.74981000764;6258.374162583706;6265.185525881698;3684.502592150079;3685.9631403686158;3704.7406681532034;3706.5181526401393;3707.8331475083687;7075.787726368218;7096.183938847099;7097.254788247263;7097.538659987084;7113.288671132846;6892.931070689229;6896.000079988374;6922.5154239202775;6925.238223795379;6932.410745086623;7212.639368031578;7225.494215404976;7230.855382892312;7291.781246562611;7322.926770732331;6937.306269373023;6980.720771169096;6990.021397004525;7002.649867506706;7003.229644739176;6790.219124800711;6843.7604683835825;6858.074159988537;6914.101166848278;6917.13535808024;7193.748218812317;7198.49610527258;7202.927970720226;7212.74755383559;7251.274872512707;4648.302754586839;4665.346851440869;4706.199946009255;4708.434987801349;4709.3642358281195;6817.181938167451;7005.719771209095;7009.474289428415;7017.614031228331;7022.859542809218;6770.4922130839395;6778.8983165251575;6779.491538134561;6779.72881084751;6784.796456106127;6759.797206083826;6775.390214880685;6786.049953006484;6792.422644075309;6793.626350550767;6476.935230647633;6621.33786621334;6645.60126392418;6650.501212408992;6654.201495820533;6794.388505034571;6797.048413222054;6803.047573339637;6810;6821.420179284816;6650.501212409185;6666.133402657623;6670.733170673118;6673.132492775908;6676.332366763285 21:29:58 INFO - PROCESS | 17064 | |5;yui.html;822.2024487117668;846.1749793950895;847.8685803700424;854.4915775113809;863.7797361672773;13305.866941330583;13352;13407.7318453631;13416.329183540809;13526.661833454156;12284.078694097934;12573.559925402613;12600.802923722254;12630.873691263085;12673;780.5979920341;785.2343964634479;796.6056801883076;805.2350267246139;807.9151689072651;792.5482474989259;798.4291231769283;800.4916877782621;801.3068695578312;803.5058439059965;827.0984626756834;833.3250067445358;834.9165083491663;836.3894357119307;837.426362941384;833.6457005772553;834.1950018232404;835.9373047021437;837.1795640272567;839.4879123734547;610.7190692281556;610.7923306075955;614.1310046284502;614.7786796753165;615.2278889993074;13702.725945481034;13822.723545529034;13840.723185536233;13842.930785346009;13866.376013079436;12277.877221227764;12499.937500312531;12620.936895315557;12678.983374433215;12722.427490762939;9750.561224744904;9928.056834600702;9941.65204217856;9954.502274886227;9969.202463802878;3553.875614353485;3560.661737134968;3596.5504311961004;3682.410814269731;3707.4253490708984;48323.27515087277;48963.51036489661;49551;49661;49791;8884.422512536665;8971.327150463741;9048.321375896834;9841.45871977048;9915.504224788732;14561.78157327641;14565.781513277308;14597;14604.12375257488;14701.926490367694;7291.197968223491;7311.89032164518;7381.077365329334;7406.629668516553;7420.257974202645;4240.173166232555;4291.871243862689;4304.139172165579;4354.934675979863;4404.163208990281;2957.231119908839;2965.3476235228213;2967.5548667699586;2968.5992391026934;2988.2230620038513;582.6882617799457;591.6479694581803;597.7877853361994;599.8800239951939;608.7930103764742;566.1960016776188;668.2248591633681;680.1939701453794;703.1632357494667;705.2031204738715;8479.364047696448;8548.487090774574;8598.699045533376;8672.002719687316;8695.347848911357;606.8604221029188;627.6830200748684;687.814290141659;719.5790462579345;734.8383355661746;4000.7799571023875;4223;4251.4685664291965;4293.849715259951;4300.78496075195;55687.164692529645;56861.14708279379;56918.71540642353;57012.71493642588;57651.42348576461;47766.522334776906;48974.510254896995;49407.50592494101;49734.75132624314;49968.25047624289;44185.779071105084;44391.55608443939;44605.33092003623;45307.320390194174;46252.53747462482;8293.087760346478;8483.83032339362;8597.18326758957;8652.870206947027;9003.90996090057;33155;33161;33651.83174084114;34299.314013719086;34609.48085778665;41660.58339416688;42628.78685606676;42729.5727042738;42837.57162428336;42874.356884646135;10196.898031019595;10211.489425528545;11032;11080;11161.553537858395;12196.57311994076;12221.450034748636;12349.506019759468;12356.752864942471;12779.488820447077;11221.66335009951;11222.046126079375;11246.83129753038;11359.772804543698;11794.115441342105;11398.886011139783;11452.885471145182;11516.53933842637;11821.172517924007;11990.40047997614;11067.209470765938;11224.382658953837;11707.765844683228;11865.940670296593;12086;9769.560369783234;9868.901310986797;9962.900370996487;10062.245331600014;10166.491675416348;9540.236781057638;10417.583296668048;10454.477276136011;10455.215858810467;10513.842292365774 21:29:58 INFO - PROCESS | 17064 | __end_tp_report 21:29:58 INFO - PROCESS | 17064 | __start_cc_report 21:29:58 INFO - PROCESS | 17064 | _x_x_mozilla_cycle_collect,311 21:29:58 INFO - PROCESS | 17064 | __end_cc_report 21:29:58 INFO - PROCESS | 17064 | __startTimestamp1453354198344__endTimestamp 21:29:58 INFO - PROCESS | 17064 | 21:29:58 INFO - PROCESS | 17064 | ------- Summary: start ------- 21:29:58 INFO - PROCESS | 17064 | Number of tests: 6 21:29:58 INFO - PROCESS | 17064 | 21:29:58 INFO - PROCESS | 17064 | [#0] dojo.html Cycles:165 Average:5407.22 Median:5665.41 stddev:612.77 (10.8%) stddev-sans-first:588.48 21:29:58 INFO - PROCESS | 17064 | Values: 3149.0 3173.9 3209.4 3222.4 3228.3 5298.9 5409.7 5451.4 5466.5 5468.6 5381.5 5448.7 5470.3 5491.5 5508.3 4904.0 4910.1 4944.5 4987.2 5008.3 4972.4 4985.7 5007.6 5027.9 5037.9 4840.7 4872.8 4914.2 4942.0 4983.9 4923.8 4929.6 4930.2 4950.0 4976.6 4904.6 4912.9 4933.7 4940.8 4953.4 5217.3 5236.1 5280.4 5363.1 5419.1 5780.1 5832.2 5834.4 5838.9 5863.3 5703.0 5889.1 5903.1 5915.9 5917.4 5297.0 5299.3 5359.2 5367.0 5375.7 5906.4 6030.6 6034.8 6038.7 6097.8 5729.8 5733.5 5748.2 5790.5 5791.6 5750.9 5840.9 5901.8 5901.8 5914.9 5739.0 5779.4 5780.6 5797.7 5830.8 5688.9 5696.1 5706.6 5725.1 5739.9 4428.6 4473.4 4478.6 4481.0 4506.8 3980.9 3982.5 3983.7 3988.1 4008.8 5373.3 5388.3 5416.7 5419.4 5440.6 5770.6 5774.7 5812.5 5836.2 5901.8 5420.5 5448.9 5464.9 5502.4 5528.6 4959.2 4985.5 5000.0 5004.9 5037.6 5916.5 5939.7 5978.4 6053.3 6082.9 5843.3 5903.9 5919.5 5934.3 5960.6 6018.0 6037.3 6053.2 6064.9 6101.3 5709.1 5710.8 5775.6 5777.4 5842.4 5833.7 5835.6 5836.1 5840.3 5871.0 5667.8 5674.5 5698.1 5699.6 5721.9 5648.7 5665.4 5699.5 5722.0 5823.1 5592.2 5593.4 5623.7 5649.7 5677.6 5720.8 5722.5 5730.1 5738.3 5821.9 5514.3 5599.9 5670.3 5674.1 5743.5 21:29:58 INFO - PROCESS | 17064 | 21:29:58 INFO - PROCESS | 17064 | [#1] ext.html Cycles:180 Average:44435.63 Median:35306.58 stddev:76067.87 (215.4%) stddev-sans-first:76209.81 21:29:58 INFO - PROCESS | 17064 | Values: 522.9 524.8 529.7 547.9 554.1 35027.0 35746.6 35755.3 35930.5 35944.0 38647.0 39390.6 39487.8 39500.8 39583.2 8475.6 8557.1 8626.3 8638.0 8676.1 8313.7 8468.4 8480.7 8498.1 8538.1 8694.6 8777.4 8783.5 8801.4 8808.7 8545.7 8615.3 8675.0 8722.2 8757.3 8558.4 8649.6 8659.7 8660.4 8691.5 38153.0 38318.4 38481.8 38660.8 38703.0 3280.9 3296.8 3366.6 3466.1 3663.6 28738.4 28764.0 29095.9 29408.7 29912.1 3875.6 3958.1 3982.7 4062.0 4116.6 245692.0 245751.0 245857.0 246143.0 247531.0 53567.5 53668.7 53712.7 53803.0 53811.7 56351.0 56498.0 56596.4 56613.7 56672.1 12575.6 12846.8 12853.9 12888.9 12941.5 9976.2 10052.1 10054.0 10062.5 10070.9 17781.0 17890.2 18101.5 18117.5 18152.0 6935.2 7151.6 7263.6 7268.3 7318.4 944.2 979.6 1052.4 1069.8 1078.9 27111.2 27717.7 27758.3 28046.6 28052.2 934.5 988.4 999.1 1001.2 1080.4 12981.9 13341.4 13386.3 15051.3 15314.9 342296.0 342701.0 342814.0 342873.0 343390.0 46580.0 47021.5 47071.8 47107.3 47343.8 1324.6 1350.1 1360.6 1361.8 1365.2 27711.3 27999.7 28047.3 28559.7 28598.0 42661.1 42732.8 42901.6 43077.4 43239.6 241104.0 242061.0 244301.1 313156.0 314095.0 29041.7 29468.5 29518.6 29630.3 29759.9 40666.0 40884.0 40916.0 40921.8 40988.8 34367.8 34941.8 35033.3 35372.9 35603.5 33976.7 34239.0 34806.7 35240.3 35605.5 30791.2 31155.4 31159.4 31301.7 34435.7 27923.9 28034.7 28922.9 28967.4 29639.9 22694.9 23617.5 24017.7 24201.5 24228.8 21:29:58 INFO - PROCESS | 17064 | 21:29:58 INFO - PROCESS | 17064 | [#2] jquery.html Cycles:180 Average:27627.22 Median:5381.08 stddev:85058.39 (1580.7%) stddev-sans-first:85272.36 21:29:58 INFO - PROCESS | 17064 | Values: 362.4 363.0 364.3 366.8 367.4 16068.5 16889.7 16967.7 17587.1 17846.6 10053.3 10402.6 15637.2 16085.4 16196.6 4883.4 5179.8 5382.6 5391.8 5394.4 5346.3 5374.5 5379.5 5551.7 5599.4 5553.3 5581.5 6407.7 6787.7 6793.5 6524.0 6672.3 6684.2 6727.0 6794.5 6291.0 6503.5 6503.7 6513.5 6522.9 21124.6 21211.8 21551.7 22701.4 22867.5 2215.4 2224.8 2265.7 2294.6 2332.3 13568.3 13826.6 13864.8 14063.4 14197.7 1909.5 1927.7 1932.9 1994.7 2003.3 59430.7 60288.0 61361.0 61659.4 63371.0 14453.5 14898.7 14905.7 14927.8 15006.6 22837.3 22845.5 22950.4 23253.3 23264.7 7739.8 7848.8 7955.7 8030.3 8071.9 6378.0 6471.4 6478.8 6480.5 6494.0 7524.9 7528.4 7550.7 7570.3 7579.1 1813.7 1827.1 2946.3 3021.0 3037.7 935.0 964.3 984.5 1003.7 1036.5 15894.9 16012.8 16099.8 16302.8 16437.8 926.5 942.6 988.5 1000.5 1033.0 7959.5 9389.2 9902.4 9930.9 10325.9 495114.0 505874.0 510864.0 544562.0 547578.0 66325.0 67251.3 69080.7 70887.6 75012.6 1112.7 1145.1 1158.6 1158.8 1170.7 14882.6 14986.1 15013.1 15259.5 15358.5 31679.0 31911.0 32195.2 32273.5 32809.7 40484.6 41436.8 41516.6 42731.8 42811.4 7032.4 7267.2 7438.0 7459.5 7507.9 7822.7 9884.6 10583.2 10735.3 11222.4 8150.9 8641.7 9289.8 9697.0 9750.9 9158.4 9487.9 9513.8 9546.5 9559.1 8986.0 9166.2 9231.7 9380.0 9420.6 7267.9 7384.2 7394.7 7442.4 7505.1 8298.9 8760.3 9106.5 9139.0 9168.5 21:29:58 INFO - PROCESS | 17064 | 21:29:58 INFO - PROCESS | 17064 | [#3] mootools.html Cycles:180 Average:5552.39 Median:5561.87 stddev:2914.19 (52.4%) stddev-sans-first:2906.09 21:29:58 INFO - PROCESS | 17064 | Values: 1455.1 1480.3 1631.3 1760.5 1786.8 7671.3 7841.9 7951.2 7977.5 7980.0 7968.6 7973.7 7998.6 8051.8 8061.3 2239.9 2259.4 2260.4 2273.0 2277.7 2296.8 2320.4 2337.6 2338.9 2341.2 2209.5 2292.7 2302.4 2302.4 2335.8 2265.0 2282.1 2306.4 2315.0 2316.3 2310.2 2332.1 2338.1 2338.1 2342.7 7741.6 7839.3 7845.0 7857.2 7857.4 4755.4 4941.1 4941.3 4942.3 4950.5 3098.9 3130.8 3205.0 3206.6 3222.6 1041.5 1046.8 1050.9 1060.0 1065.3 11000.7 11022.1 11061.0 11089.1 11128.6 4138.5 4221.3 4251.9 4265.4 4316.2 8926.4 8944.1 8968.0 8984.6 8990.5 4832.7 4835.4 4840.4 4859.9 4862.2 4394.6 4399.5 4425.6 4425.9 4443.0 3361.3 3380.6 3398.1 3406.5 3426.2 1020.1 1021.0 1023.7 1027.7 1029.2 1058.2 1072.3 1075.0 1206.2 1333.9 7052.9 7114.8 7140.0 7158.0 7357.4 1040.3 1050.7 1059.1 1118.6 1138.6 5481.0 5550.8 5554.0 5558.8 5564.9 8976.1 9630.0 9789.6 10016.5 10036.3 9750.4 9756.2 9775.0 9815.4 9828.1 7452.5 7604.7 7620.7 7682.2 7715.5 7173.4 7317.0 7342.9 7383.3 7404.1 8465.2 8635.5 8723.2 8858.6 8929.8 8474.3 8906.3 9054.4 9126.5 9163.7 6818.2 6889.1 6896.1 6899.3 6916.6 7614.7 7642.7 7727.5 7744.1 7769.5 6957.6 7315.6 7331.6 7391.9 7606.7 6891.0 7086.4 7123.6 7169.9 7210.8 7024.8 7039.0 7065.9 7068.1 7071.6 6365.6 6427.1 6440.1 6450.8 6457.5 6174.2 6452.2 6521.7 6556.2 6575.1 21:29:58 INFO - PROCESS | 17064 | 21:29:58 INFO - PROCESS | 17064 | [#4] prototype.html Cycles:180 Average:5541.82 Median:6255.00 stddev:1712.30 (27.4%) stddev-sans-first:1671.73 21:29:58 INFO - PROCESS | 17064 | Values: 324.7 327.9 331.1 335.2 339.9 6203.4 6303.2 6327.2 6372.5 6407.2 6067.7 6132.8 6158.3 6179.9 6208.1 4691.9 4730.2 4730.2 4741.5 4742.9 4740.8 4748.1 4748.9 4750.0 4759.0 4607.5 4636.1 4664.2 4714.1 4718.9 4675.4 4687.1 4693.2 4704.9 4706.0 4043.2 4072.9 4098.3 4104.1 4110.9 5857.7 5900.0 5903.7 5910.7 5924.1 5279.3 5429.9 5433.5 5446.3 5457.7 6484.9 6564.2 6580.4 6583.6 6584.3 4458.1 4461.8 4463.3 4465.5 4465.7 6706.6 6860.5 6901.1 6908.4 6922.4 4541.4 4560.3 4566.9 4571.9 4578.2 4604.8 4628.5 4640.8 4654.5 4666.3 5437.9 5439.3 5442.2 5442.4 5447.0 6464.7 6688.3 6693.8 6707.7 6714.6 1610.9 1615.5 1657.6 1659.2 1659.7 1052.5 1075.9 1079.0 1081.8 1084.6 6215.1 6224.7 6255.2 6255.4 6259.5 6780.9 6791.0 6798.3 6801.8 6803.3 6011.0 6250.3 6254.7 6258.4 6265.2 3684.5 3686.0 3704.7 3706.5 3707.8 7075.8 7096.2 7097.3 7097.5 7113.3 6892.9 6896.0 6922.5 6925.2 6932.4 7212.6 7225.5 7230.9 7291.8 7322.9 6937.3 6980.7 6990.0 7002.6 7003.2 6790.2 6843.8 6858.1 6914.1 6917.1 7193.7 7198.5 7202.9 7212.7 7251.3 4648.3 4665.3 4706.2 4708.4 4709.4 6817.2 7005.7 7009.5 7017.6 7022.9 6770.5 6778.9 6779.5 6779.7 6784.8 6759.8 6775.4 6786.0 6792.4 6793.6 6476.9 6621.3 6645.6 6650.5 6654.2 6794.4 6797.0 6803.0 6810.0 6821.4 6650.5 6666.1 6670.7 6673.1 6676.3 21:29:58 INFO - PROCESS | 17064 | 21:29:58 INFO - PROCESS | 17064 | [#5] yui.html Cycles:180 Average:13527.94 Median:47009.53 stddev:15573.08 (33.1%) stddev-sans-first:15587.54 21:29:58 INFO - PROCESS | 17064 | Values: 822.2 846.2 847.9 854.5 863.8 13305.9 13352.0 13407.7 13416.3 13526.7 12284.1 12573.6 12600.8 12630.9 12673.0 780.6 785.2 796.6 805.2 807.9 792.5 798.4 800.5 801.3 803.5 827.1 833.3 834.9 836.4 837.4 833.6 834.2 835.9 837.2 839.5 610.7 610.8 614.1 614.8 615.2 13702.7 13822.7 13840.7 13842.9 13866.4 12277.9 12499.9 12620.9 12679.0 12722.4 9750.6 9928.1 9941.7 9954.5 9969.2 3553.9 3560.7 3596.6 3682.4 3707.4 48323.3 48963.5 49551.0 49661.0 49791.0 8884.4 8971.3 9048.3 9841.5 9915.5 14561.8 14565.8 14597.0 14604.1 14701.9 7291.2 7311.9 7381.1 7406.6 7420.3 4240.2 4291.9 4304.1 4354.9 4404.2 2957.2 2965.3 2967.6 2968.6 2988.2 582.7 591.6 597.8 599.9 608.8 566.2 668.2 680.2 703.2 705.2 8479.4 8548.5 8598.7 8672.0 8695.3 606.9 627.7 687.8 719.6 734.8 4000.8 4223.0 4251.5 4293.8 4300.8 55687.2 56861.1 56918.7 57012.7 57651.4 47766.5 48974.5 49407.5 49734.8 49968.3 44185.8 44391.6 44605.3 45307.3 46252.5 8293.1 8483.8 8597.2 8652.9 9003.9 33155.0 33161.0 33651.8 34299.3 34609.5 41660.6 42628.8 42729.6 42837.6 42874.4 10196.9 10211.5 11032.0 11080.0 11161.6 12196.6 12221.5 12349.5 12356.8 12779.5 11221.7 11222.0 11246.8 11359.8 11794.1 11398.9 11452.9 11516.5 11821.2 11990.4 11067.2 11224.4 11707.8 11865.9 12086.0 9769.6 9868.9 9962.9 10062.2 10166.5 9540.2 10417.6 10454.5 10455.2 10513.8 21:29:58 INFO - PROCESS | 17064 | -------- Summary: end -------- 21:29:58 INFO - PROCESS | 17064 | 21:29:58 INFO - TEST-INFO | 17064: exit 0 21:29:58 INFO - TEST-OK | dromaeo_css | took 1111063ms 21:29:58 INFO - TEST-START | kraken 21:29:58 INFO - operating with platform_type : linux_ 21:29:58 INFO - Initialising browser for kraken test... 21:29:58 INFO - TEST-INFO | started process 17312 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp05zUOW/profile http://localhost:57176/getInfo.html) 21:30:02 INFO - PROCESS | 17312 | 21:30:02 INFO - PROCESS | 17312 | (process:17381): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:30:03 INFO - PROCESS | 17312 | __metrics Screen width/height:1600/1200 21:30:03 INFO - PROCESS | 17312 | colorDepth:24 21:30:03 INFO - PROCESS | 17312 | Browser inner width/height: 1024/697 21:30:03 INFO - PROCESS | 17312 | __metrics 21:30:03 INFO - PROCESS | 17312 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:30:04 INFO - TEST-INFO | 17312: exit 0 21:30:04 INFO - Browser initialized. 21:30:04 INFO - Running cycle 1/1 for kraken test... 21:30:04 INFO - TEST-INFO | started process 17430 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp05zUOW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:30:05 INFO - PROCESS | 17430 | -- checkerboarding starts below -- 21:30:05 INFO - PROCESS | 17430 | RENDERTRACE 0.085647 rect red 0 0 10 10 // viewport 21:30:05 INFO - PROCESS | 17430 | RENDERTRACE 45.5256 rect brown 0 0 10 10 // page 21:30:05 INFO - PROCESS | 17430 | RENDERTRACE 45.5636 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 21:30:05 INFO - PROCESS | 17430 | Checkerboarded for 1 frames (60.7876 ms), 100 peak, 5 severity. 21:30:05 INFO - PROCESS | 17430 | 21:30:05 INFO - PROCESS | 17430 | (process:17490): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:30:16 INFO - PROCESS | 17430 | RSS: Main: 149729280 21:30:16 INFO - PROCESS | 17430 | 21:30:18 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57176/tests/kraken/driver.html?testName=audio-beat-detection) 21:30:19 INFO - PROCESS | 17430 | RSS: Main: 151789568 21:30:19 INFO - PROCESS | 17430 | 21:30:22 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57176/tests/kraken/driver.html?testName=audio-dft) 21:30:22 INFO - PROCESS | 17430 | RSS: Main: 153882624 21:30:22 INFO - PROCESS | 17430 | 21:30:25 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57176/tests/kraken/driver.html?testName=audio-fft) 21:30:26 INFO - PROCESS | 17430 | RSS: Main: 147533824 21:30:26 INFO - PROCESS | 17430 | 21:30:28 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57176/tests/kraken/driver.html?testName=audio-oscillator) 21:30:28 INFO - PROCESS | 17430 | RSS: Main: 147881984 21:30:28 INFO - PROCESS | 17430 | 21:30:31 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57176/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:30:31 INFO - PROCESS | 17430 | RSS: Main: 147906560 21:30:31 INFO - PROCESS | 17430 | 21:30:34 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57176/tests/kraken/driver.html?testName=imaging-darkroom) 21:30:35 INFO - PROCESS | 17430 | RSS: Main: 148320256 21:30:35 INFO - PROCESS | 17430 | 21:30:38 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57176/tests/kraken/driver.html?testName=imaging-desaturate) 21:30:39 INFO - PROCESS | 17430 | RSS: Main: 148389888 21:30:39 INFO - PROCESS | 17430 | 21:30:42 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57176/tests/kraken/driver.html?testName=json-parse-financial) 21:30:42 INFO - PROCESS | 17430 | RSS: Main: 148791296 21:30:42 INFO - PROCESS | 17430 | 21:30:44 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57176/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:30:44 INFO - PROCESS | 17430 | RSS: Main: 148156416 21:30:44 INFO - PROCESS | 17430 | 21:30:46 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57176/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:30:47 INFO - PROCESS | 17430 | RSS: Main: 148844544 21:30:47 INFO - PROCESS | 17430 | 21:30:49 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57176/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:30:49 INFO - PROCESS | 17430 | RSS: Main: 149504000 21:30:49 INFO - PROCESS | 17430 | 21:30:52 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57176/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:30:52 INFO - PROCESS | 17430 | RSS: Main: 149770240 21:30:52 INFO - PROCESS | 17430 | 21:30:55 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57176/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:30:56 INFO - PROCESS | 17430 | RSS: Main: 149426176 21:30:56 INFO - PROCESS | 17430 | 21:30:57 INFO - PROCESS | 17430 | Cycle 1(1): loaded http://localhost:57176/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57176/tests/kraken/driver.html?testName=ai-astar) 21:30:58 INFO - PROCESS | 17430 | RSS: Main: 149872640 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | __start_tp_report 21:30:58 INFO - PROCESS | 17430 | _x_x_mozilla_page_load 21:30:58 INFO - PROCESS | 17430 | _x_x_mozilla_page_load_details 21:30:58 INFO - PROCESS | 17430 | |i|pagename|runs| 21:30:58 INFO - PROCESS | 17430 | |0;ai-astar;111;108;110;113;112;123;111;112;112;110 21:30:58 INFO - PROCESS | 17430 | |1;audio-beat-detection;158;135;154;159;130;159;154;128;158;127 21:30:58 INFO - PROCESS | 17430 | |2;audio-dft;165;162;164;164;164;163;165;167;169;161 21:30:58 INFO - PROCESS | 17430 | |3;audio-fft;72;74;73;73;73;74;143;73;73;75 21:30:58 INFO - PROCESS | 17430 | |4;audio-oscillator;97;96;140;96;96;97;148;98;96;142 21:30:58 INFO - PROCESS | 17430 | |5;imaging-gaussian-blur;110;111;111;111;110;110;110;110;110;113 21:30:58 INFO - PROCESS | 17430 | |6;imaging-darkroom;148;147;149;147;148;151;147;147;146;147 21:30:58 INFO - PROCESS | 17430 | |7;imaging-desaturate;96;98;96;102;97;97;97;97;96;101 21:30:58 INFO - PROCESS | 17430 | |8;json-parse-financial;61;60;61;62;60;59;60;60;61;58 21:30:58 INFO - PROCESS | 17430 | |9;json-stringify-tinderbox;67;67;67;67;67;67;67;67;67;67 21:30:58 INFO - PROCESS | 17430 | |10;stanford-crypto-aes;83;83;83;83;85;85;82;83;83;84 21:30:58 INFO - PROCESS | 17430 | |11;stanford-crypto-ccm;116;118;118;124;118;117;116;116;125;121 21:30:58 INFO - PROCESS | 17430 | |12;stanford-crypto-pbkdf2;134;148;141;142;140;147;149;143;145;130 21:30:58 INFO - PROCESS | 17430 | |13;stanford-crypto-sha256-iterative;67;68;67;67;69;68;65;66;68;66 21:30:58 INFO - PROCESS | 17430 | __end_tp_report 21:30:58 INFO - PROCESS | 17430 | __start_cc_report 21:30:58 INFO - PROCESS | 17430 | _x_x_mozilla_cycle_collect,739 21:30:58 INFO - PROCESS | 17430 | __end_cc_report 21:30:58 INFO - PROCESS | 17430 | __startTimestamp1453354258044__endTimestamp 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | ------- Summary: start ------- 21:30:58 INFO - PROCESS | 17430 | Number of tests: 14 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:4.05 (3.6%) stddev-sans-first:4.27 21:30:58 INFO - PROCESS | 17430 | Values: 111.0 108.0 110.0 113.0 112.0 123.0 111.0 112.0 112.0 110.0 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:156.00 stddev:14.20 (9.1%) stddev-sans-first:14.41 21:30:58 INFO - PROCESS | 17430 | Values: 158.0 135.0 154.0 159.0 130.0 159.0 154.0 128.0 158.0 127.0 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:2.32 (1.4%) stddev-sans-first:2.45 21:30:58 INFO - PROCESS | 17430 | Values: 165.0 162.0 164.0 164.0 164.0 163.0 165.0 167.0 169.0 161.0 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#3] audio-fft Cycles:10 Average:80.30 Median:73.00 stddev:22.05 (30.2%) stddev-sans-first:23.18 21:30:58 INFO - PROCESS | 17430 | Values: 72.0 74.0 73.0 73.0 73.0 74.0 143.0 73.0 73.0 75.0 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:96.00 stddev:22.68 (23.6%) stddev-sans-first:23.52 21:30:58 INFO - PROCESS | 17430 | Values: 97.0 96.0 140.0 96.0 96.0 97.0 148.0 98.0 96.0 142.0 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:110.50 stddev:0.97 (0.9%) stddev-sans-first:1.00 21:30:58 INFO - PROCESS | 17430 | Values: 110.0 111.0 111.0 111.0 110.0 110.0 110.0 110.0 110.0 113.0 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.50 stddev:1.42 (1.0%) stddev-sans-first:1.50 21:30:58 INFO - PROCESS | 17430 | Values: 148.0 147.0 149.0 147.0 148.0 151.0 147.0 147.0 146.0 147.0 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:97.00 stddev:2.11 (2.2%) stddev-sans-first:2.15 21:30:58 INFO - PROCESS | 17430 | Values: 96.0 98.0 96.0 102.0 97.0 97.0 97.0 97.0 96.0 101.0 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.50 stddev:1.14 (1.9%) stddev-sans-first:1.17 21:30:58 INFO - PROCESS | 17430 | Values: 61.0 60.0 61.0 62.0 60.0 59.0 60.0 60.0 61.0 58.0 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 21:30:58 INFO - PROCESS | 17430 | Values: 67.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 21:30:58 INFO - PROCESS | 17430 | Values: 83.0 83.0 83.0 83.0 85.0 85.0 82.0 83.0 83.0 84.0 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:118.00 stddev:3.31 (2.8%) stddev-sans-first:3.35 21:30:58 INFO - PROCESS | 17430 | Values: 116.0 118.0 118.0 124.0 118.0 117.0 116.0 116.0 125.0 121.0 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.90 Median:144.00 stddev:6.08 (4.2%) stddev-sans-first:5.74 21:30:58 INFO - PROCESS | 17430 | Values: 134.0 148.0 141.0 142.0 140.0 147.0 149.0 143.0 145.0 130.0 21:30:58 INFO - PROCESS | 17430 | 21:30:58 INFO - PROCESS | 17430 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.20 (1.8%) stddev-sans-first:1.27 21:30:58 INFO - PROCESS | 17430 | Values: 67.0 68.0 67.0 67.0 69.0 68.0 65.0 66.0 68.0 66.0 21:30:58 INFO - PROCESS | 17430 | -------- Summary: end -------- 21:30:58 INFO - PROCESS | 17430 | 21:30:59 INFO - TEST-INFO | 17430: exit 0 21:30:59 INFO - TEST-OK | kraken | took 60129ms 21:30:59 INFO - TEST-START | v8_7 21:30:59 INFO - operating with platform_type : linux_ 21:30:59 INFO - Initialising browser for v8_7 test... 21:30:59 INFO - TEST-INFO | started process 17718 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMkSQb2/profile http://localhost:57176/getInfo.html) 21:31:02 INFO - PROCESS | 17718 | 21:31:02 INFO - PROCESS | 17718 | (process:17787): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:31:03 INFO - PROCESS | 17718 | __metrics Screen width/height:1600/1200 21:31:03 INFO - PROCESS | 17718 | colorDepth:24 21:31:03 INFO - PROCESS | 17718 | Browser inner width/height: 1024/697 21:31:03 INFO - PROCESS | 17718 | __metrics 21:31:03 INFO - PROCESS | 17718 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:31:04 INFO - TEST-INFO | 17718: exit 0 21:31:04 INFO - Browser initialized. 21:31:04 INFO - Running cycle 1/1 for v8_7 test... 21:31:04 INFO - TEST-INFO | started process 17836 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMkSQb2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:31:05 INFO - PROCESS | 17836 | -- checkerboarding starts below -- 21:31:05 INFO - PROCESS | 17836 | RENDERTRACE 0.032278 rect red 0 0 10 10 // viewport 21:31:05 INFO - PROCESS | 17836 | RENDERTRACE 38.0363 rect brown 0 0 10 10 // page 21:31:05 INFO - PROCESS | 17836 | RENDERTRACE 38.0581 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 21:31:05 INFO - PROCESS | 17836 | Checkerboarded for 1 frames (50.4535 ms), 100 peak, 1 severity. 21:31:06 INFO - PROCESS | 17836 | 21:31:06 INFO - PROCESS | 17836 | (process:17892): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:31:16 INFO - PROCESS | 17836 | RSS: Main: 150265856 21:31:16 INFO - PROCESS | 17836 | 21:31:39 INFO - PROCESS | 17836 | Cycle 1(1): loaded http://localhost:57176/tests/v8_7/run.html (next: http://localhost:57176/tests/v8_7/run.html) 21:31:39 INFO - PROCESS | 17836 | RSS: Main: 145723392 21:31:39 INFO - PROCESS | 17836 | 21:31:39 INFO - PROCESS | 17836 | __start_tp_report 21:31:39 INFO - PROCESS | 17836 | _x_x_mozilla_page_load 21:31:39 INFO - PROCESS | 17836 | _x_x_mozilla_page_load_details 21:31:39 INFO - PROCESS | 17836 | |i|pagename|runs| 21:31:39 INFO - PROCESS | 17836 | |0;Richards;167.44809109176154 21:31:39 INFO - PROCESS | 17836 | |1;DeltaBlue;185.70102135561746 21:31:39 INFO - PROCESS | 17836 | |2;Encrypt;279.56388034665923 21:31:39 INFO - PROCESS | 17836 | |3;Decrypt;5218.75 21:31:39 INFO - PROCESS | 17836 | |4;RayTrace;1069.51871657754 21:31:39 INFO - PROCESS | 17836 | |5;Earley;712.7583749109052 21:31:39 INFO - PROCESS | 17836 | |6;Boyer;12658.227848101265 21:31:39 INFO - PROCESS | 17836 | |7;RegExp;40840 21:31:39 INFO - PROCESS | 17836 | |8;Splay;576.036866359447 21:31:39 INFO - PROCESS | 17836 | |9;NavierStokes;4882.926829268293 21:31:39 INFO - PROCESS | 17836 | __end_tp_report 21:31:39 INFO - PROCESS | 17836 | __startTimestamp1453354299333__endTimestamp 21:31:39 INFO - PROCESS | 17836 | 21:31:39 INFO - PROCESS | 17836 | ------- Summary: start ------- 21:31:39 INFO - PROCESS | 17836 | Number of tests: 10 21:31:39 INFO - PROCESS | 17836 | 21:31:39 INFO - PROCESS | 17836 | [#0] Richards Cycles:1 Average:167.45 Median:167.45 stddev:0.00 (0.0%) 21:31:39 INFO - PROCESS | 17836 | Values: 167.4 21:31:39 INFO - PROCESS | 17836 | 21:31:39 INFO - PROCESS | 17836 | [#1] DeltaBlue Cycles:1 Average:185.70 Median:185.70 stddev:0.00 (0.0%) 21:31:39 INFO - PROCESS | 17836 | Values: 185.7 21:31:39 INFO - PROCESS | 17836 | 21:31:39 INFO - PROCESS | 17836 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 21:31:39 INFO - PROCESS | 17836 | Values: 279.6 21:31:39 INFO - PROCESS | 17836 | 21:31:39 INFO - PROCESS | 17836 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 21:31:39 INFO - PROCESS | 17836 | Values: 5218.8 21:31:39 INFO - PROCESS | 17836 | 21:31:39 INFO - PROCESS | 17836 | [#4] RayTrace Cycles:1 Average:1069.52 Median:1069.52 stddev:0.00 (0.0%) 21:31:39 INFO - PROCESS | 17836 | Values: 1069.5 21:31:39 INFO - PROCESS | 17836 | 21:31:39 INFO - PROCESS | 17836 | [#5] Earley Cycles:1 Average:712.76 Median:712.76 stddev:0.00 (0.0%) 21:31:39 INFO - PROCESS | 17836 | Values: 712.8 21:31:39 INFO - PROCESS | 17836 | 21:31:39 INFO - PROCESS | 17836 | [#6] Boyer Cycles:1 Average:12658.23 Median:12658.23 stddev:0.00 (0.0%) 21:31:39 INFO - PROCESS | 17836 | Values: 12658.2 21:31:39 INFO - PROCESS | 17836 | 21:31:39 INFO - PROCESS | 17836 | [#7] RegExp Cycles:1 Average:40840.00 Median:40840.00 stddev:0.00 (0.0%) 21:31:39 INFO - PROCESS | 17836 | Values: 40840.0 21:31:39 INFO - PROCESS | 17836 | 21:31:39 INFO - PROCESS | 17836 | [#8] Splay Cycles:1 Average:576.04 Median:576.04 stddev:0.00 (0.0%) 21:31:39 INFO - PROCESS | 17836 | Values: 576.0 21:31:39 INFO - PROCESS | 17836 | 21:31:39 INFO - PROCESS | 17836 | [#9] NavierStokes Cycles:1 Average:4882.93 Median:4882.93 stddev:0.00 (0.0%) 21:31:39 INFO - PROCESS | 17836 | Values: 4882.9 21:31:39 INFO - PROCESS | 17836 | -------- Summary: end -------- 21:31:39 INFO - PROCESS | 17836 | 21:31:40 INFO - TEST-INFO | 17836: exit 0 21:31:40 INFO - TEST-OK | v8_7 | took 41075ms 21:31:40 INFO - SUITE-END | took 1212s 21:31:40 INFO - Completed test suite (00:20:12) 21:31:40 INFO - Working with test: dromaeo_css 21:31:40 INFO - Generating results file: dromaeo_css 21:31:40 INFO - Working with test: kraken 21:31:40 INFO - Generating results file: kraken 21:31:40 INFO - javascript benchmark 21:31:40 INFO - Working with test: v8_7 21:31:40 INFO - Generating results file: v8_7 21:31:40 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:31:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 21:31:40 INFO - process_Request line: dromaeo_css 6990.96 graph.html#tests=[[72,64,43]] 21:31:40 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:31:40 INFO - process_Request line: kraken 1508.20 graph.html#tests=[[232,64,43]] 21:31:40 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:31:40 INFO - process_Request line: v8_7 20415.40 graph.html#tests=[[230,64,43]] 21:31:40 INFO - RETURN: dromaeo_css: 6990.96 21:31:40 INFO - RETURN: kraken: 1508.20 21:31:40 INFO - RETURN: v8_7: 20415.40 21:31:40 INFO - javascript benchmark 21:31:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3148.9685103148977, 3173.8571764270605, 3209.390215858986, 3222.3877463281974, 3228.3381906709124, 5298.867528311785, 5409.729513524323, 5451.37309209441, 5466.535344495717, 5468.617196796221, 5381.461853814617, 5448.700321482317, 5470.316210473691, 5491.450854914507, 5508.256385387971, 4903.9754801225945, 4910.116179087763, 4944.530269624398, 4987.17711577591, 5008.2738002989545, 4972.428170760355, 4985.6759310644875, 5007.624428167902, 5027.874303142414, 5037.874053148664, 4840.709557426548, 4872.78072486739, 4914.21372580389, 4942.0, 4983.8504844854715, 4923.80304787808, 4929.556339929388, 4930.186519224324, 4949.975250123726, 4976.576990955773, 4904.5831104356175, 4912.8526144215375, 4933.679310844784, 4940.827071052532, 4953.405591329064, 5217.295665085241, 5236.083685355047, 5280.445553216895, 5363.088274993261, 5419.078756611386, 5780.104083867007, 5832.24180856486, 5834.4165583441745, 5838.854028649275, 5863.2670916135485, 5703.0, 5889.116632505158, 5903.114532820068, 5915.940840591582, 5917.408259174092, 5297.046531624344, 5299.31108955841, 5359.196120581905, 5366.973165134188, 5375.704336261504, 5906.438888305604, 6030.6080104793045, 6034.849128771728, 6038.728257228435, 6097.817065488042, 5729.7708091676695, 5733.512651424592, 5748.19525266463, 5790.507806836466, 5791.565632577489, 5750.942490575125, 5840.88318233633, 5901.822945311562, 5901.822945311647, 5914.9112763308585, 5738.971305143447, 5779.3642699303045, 5780.595358324961, 5797.681127538026, 5830.795922142789, 5688.943110568925, 5696.088625819932, 5706.629069110494, 5725.08398656213, 5739.942600574024, 4428.645708343325, 4473.351364052194, 4478.596926276651, 4480.955190448119, 4506.752128632957, 3980.86066987654, 3982.482277303932, 3983.6813054955533, 3988.142549351903, 4008.8396464141692, 5373.301470808769, 5388.326459192601, 5416.674999500043, 5419.376771671229, 5440.619156659075, 5770.596058275881, 5774.711264436845, 5812.505936995318, 5836.182934389189, 5901.822945311647, 5420.53925416344, 5448.891022179534, 5464.9453505464435, 5502.367227768857, 5528.612997090165, 4959.181735013754, 4985.451600323961, 5000.024995125916, 5004.899902001939, 5037.647364684437, 5916.467517923407, 5939.673317967467, 5978.372270911578, 6053.334133245339, 6082.878342433127, 5843.328017278068, 5903.881922361615, 5919.467247947706, 5934.317553481233, 5960.5827592068135, 6017.969910150421, 6037.335893051849, 6053.182820319201, 6064.878702426015, 6101.267847858286, 5709.115087161496, 5710.771569137354, 5775.595708300547, 5777.422257774357, 5842.444967728059, 5833.737481813244, 5835.620684655484, 5836.095405212199, 5840.328362238397, 5871.031279838779, 5667.829965101054, 5674.517665998436, 5698.088305871041, 5699.629524080921, 5721.942780572141, 5648.661080335193, 5665.405132461032, 5699.487046165865, 5722.0272553665145, 5823.097419899922, 5592.189132575672, 5593.440655934374, 5623.662580245198, 5649.68926709035, 5677.630953987978, 5720.8283751487525, 5722.542196624343, 5730.054541000688, 5738.311402631711, 5821.94178058214, 5514.283143191359, 5599.888002239851, 5670.262865827416, 5674.120511320752, 5743.483086522233], "unit": "score", "name": "dojo.html", "value": 5366.3446591120155}, {"lowerIsBetter": false, "replicates": [522.9346331708537, 524.7848382163312, 529.7218960045975, 547.8850539152824, 554.1189508681196, 35027.0, 35746.64253357465, 35755.28489430216, 35930.461043084375, 35944.0, 38647.0, 39390.60609393905, 39487.802560987155, 39500.80249598748, 39583.20833583327, 8475.618597163128, 8557.144285571425, 8626.3098952084, 8638.0, 8676.089010653885, 8313.667453301861, 8468.407211495198, 8480.66077356905, 8498.065212826585, 8538.146185381474, 8694.56527173642, 8777.42946708465, 8783.47299162049, 8801.383903126783, 8808.691695790649, 8545.700900468484, 8615.267702245254, 8674.956625216864, 8722.171393717586, 8757.2994160467, 8558.400911936167, 8649.610767515414, 8659.696910608098, 8660.393772435931, 8691.478511289342, 38153.0461738456, 38318.42522362139, 38481.80759096215, 38660.806695966625, 38703.0, 3280.934381312384, 3296.8186749728757, 3366.629670736217, 3466.0988143082727, 3663.5786884508357, 28738.425231495254, 28764.0, 29095.854520727262, 29408.705912941026, 29912.10263692093, 3875.5930627284292, 3958.1094253792953, 3982.721209515335, 4062.0454193264854, 4116.629503344713, 245691.99999999822, 245751.0, 245857.0, 246143.0, 247531.0, 53567.464325357025, 53668.73165634225, 53712.73143634257, 53803.0, 53811.695064395535, 56351.0, 56498.0, 56596.43403565994, 56613.71693141508, 56672.14991775127, 12575.5598554052, 12846.807297890538, 12853.871461285455, 12888.871111288954, 12941.547045853538, 9976.152027077635, 10052.095311421861, 10053.994600540034, 10062.496875156214, 10070.899291007143, 17781.0, 17890.194941227415, 18101.547461313574, 18117.547061323574, 18152.0, 6935.202451718016, 7151.642417879085, 7263.636818159071, 7268.309510596485, 7318.377937875233, 944.2257348973912, 979.6326377608397, 1052.3843551522293, 1069.844872493484, 1078.9082927951213, 27111.1866644001, 27717.722822771917, 27758.3060423487, 28046.579301310496, 28052.158435246976, 934.4860326820221, 988.421773262635, 999.1008092716468, 1001.1690297053428, 1080.4327727942893, 12981.870181298065, 13341.399637016357, 13386.330683465787, 15051.322690478955, 15314.923425382802, 342296.0, 342701.0, 342814.0, 342873.0, 343390.0, 46580.0, 47021.5297847024, 47071.76464117726, 47107.29339059917, 47343.76328118406, 1324.5628942448968, 1350.122420426711, 1360.5986234060977, 1361.7616917039281, 1365.2286458151113, 27711.30721731973, 27999.74001169993, 28047.298817529725, 28559.714402855705, 28598.0, 42661.14677706367, 42732.78633606812, 42901.570984289756, 43077.3538396918, 43239.56760432355, 241104.0, 242061.0, 244301.12042717167, 313156.0, 314095.0, 29041.7095829039, 29468.463784346015, 29518.55722164212, 29630.259243519085, 29759.85120074386, 40666.0, 40884.0, 40916.0, 40921.79539102285, 40988.79505602453, 34367.82816085903, 34941.825290873385, 35033.29933401369, 35372.86884311779, 35603.46594801132, 33976.66023339735, 34239.0, 34806.65193348034, 35240.295194096485, 35605.46591801177, 30791.2302192447, 31155.37689246157, 31159.37681246317, 31301.686983129875, 34435.65564344425, 27923.860380697966, 28034.71965280321, 28922.855385722938, 28967.420651586428, 29639.851800741722, 22694.886525567268, 23617.527649446572, 24017.712764634456, 24201.51596968086, 24228.757712422652], "unit": "score", "name": "ext.html", "value": 17552.099751935737}, {"lowerIsBetter": false, "replicates": [362.40022762328357, 363.041570254528, 364.30963324500067, 366.836757642849, 367.3662931443259, 16068.51794446167, 16889.662206755856, 16967.745483817736, 17587.120643967814, 17846.553836154104, 10053.346532475402, 10402.63590774323, 15637.218139093056, 16085.356585736556, 16196.623287020617, 4883.438404583474, 5179.8446046618665, 5382.6232163748555, 5391.838244852641, 5394.406615272317, 5346.27825243593, 5374.543163831079, 5379.542738867201, 5551.72241387931, 5599.41206173352, 5553.333599967989, 5581.469760372778, 6407.679616019203, 6787.728490860384, 6793.490488213379, 6523.967380163116, 6672.266050734415, 6684.164479440045, 6727.0, 6794.490413218979, 6290.9685451572905, 6503.479721622259, 6503.7073331700185, 6513.511486638521, 6522.902156467657, 21124.577508449744, 21211.78788212129, 21551.67672484914, 22701.43246418853, 22867.542649146922, 2215.3796936857707, 2224.8442609017375, 2265.716785401825, 2294.6099163142308, 2332.288651961151, 13568.253746043963, 13826.585202443943, 13864.792028119586, 14063.43746250159, 14197.716045679028, 1909.4844392014218, 1927.7108433734911, 1932.9323473678494, 1994.7107669388004, 2003.2888324644687, 59430.702846485925, 60288.0, 61361.0, 61659.38340616581, 63371.0, 14453.49412770569, 14898.702025959421, 14905.68961810921, 14927.776083358542, 15006.62483437901, 22837.31488055361, 22845.543089138126, 22950.42623934415, 23253.302400927998, 23264.65103023456, 7739.7678069658, 7848.803779905548, 7955.721549745731, 8030.277275045274, 8071.919280807117, 6378.0, 6471.385218404244, 6478.838029049311, 6480.4815614750705, 6493.967530162319, 7524.887126693104, 7528.397728181732, 7550.735724249735, 7570.318671319607, 7579.090509138939, 1813.737008133813, 1827.1412436155251, 2946.2781618503604, 3020.969790302113, 3037.650670172914, 935.0, 964.344245912786, 984.5028260728286, 1003.6988903328972, 1036.4972988100765, 15894.9205253973, 16012.759808602881, 16099.758503622455, 16302.755458668129, 16437.83562164387, 926.5089502563652, 942.641796117471, 988.4859872866214, 1000.4688139008321, 1033.0289527843802, 7959.522428654299, 9389.154976052188, 9902.405855648683, 9930.851037234448, 10325.948370258251, 495114.0, 505874.0, 510864.0, 544562.0, 547578.0, 66325.0, 67251.3274867245, 69080.6545967267, 70887.64556177186, 75012.62493687606, 1112.6550769261555, 1145.0610499390586, 1158.623447379605, 1158.8030034894089, 1170.7014711248578, 14882.553523394316, 14986.100833949999, 15013.099214047192, 15259.542213733606, 15358.539243822703, 31679.0, 31911.0, 32195.195120122185, 32273.51589726203, 32809.671903280665, 40484.59515404808, 41436.792816035726, 41516.58483415127, 42731.786341068095, 42811.35782963196, 7032.437405007485, 7267.236940121423, 7437.958685783887, 7459.515131516434, 7507.924920750941, 7822.687087535799, 9884.604615815575, 10583.153347732317, 10735.302205356627, 11222.438878056228, 8150.9184908150155, 8641.740747777576, 9289.814203715752, 9697.0, 9750.902490974999, 9158.358914875895, 9487.857682134636, 9513.762155946157, 9546.522673866419, 9559.139677429064, 8986.0, 9166.22087122602, 9231.723048308562, 9380.0, 9420.576074076545, 7267.854642907007, 7384.224656410999, 7394.704211831467, 7442.404607631268, 7505.136909255505, 8298.917010830057, 8760.342974277082, 9106.453612782989, 9138.954305228432, 9168.54157292146], "unit": "score", "name": "jquery.html", "value": 8767.565228710942}, {"lowerIsBetter": false, "replicates": [1455.1414665347445, 1480.3486465954982, 1631.3066946547715, 1760.471858442467, 1786.8302511261434, 7671.271229233221, 7841.882371764414, 7951.204879512046, 7977.481463704862, 7979.960100199491, 7968.641411136498, 7973.720919767809, 7998.560079195642, 8051.792231165328, 8061.274485296322, 2239.85440946338, 2259.401258666455, 2260.4235919840416, 2272.988635056822, 2277.6583512473094, 2296.8392212545127, 2320.3619004773655, 2337.614293641547, 2338.8830558472096, 2341.180586794617, 2209.4807720185822, 2292.6561015847674, 2302.355340504653, 2302.435903203709, 2335.8131349492, 2264.9660255096187, 2282.075759317479, 2306.400335912658, 2315.0392587076426, 2316.2819525946843, 2310.1798861404127, 2332.07882886259, 2338.09983156486, 2338.1232037985756, 2342.672025916373, 7741.57421341826, 7839.294463498256, 7845.0, 7857.1749966253865, 7857.410694197958, 4755.405574303212, 4941.135301322254, 4941.308216849644, 4942.258661200813, 4950.504949505057, 3098.860551275198, 3130.827804470753, 3205.0, 3206.567113439679, 3222.6455089940087, 1041.5261056219401, 1046.8325067989085, 1050.8633877595864, 1059.9523021463976, 1065.339489516497, 11000.724981875437, 11022.063124634416, 11061.0, 11089.112870970384, 11128.554857805759, 4138.503379594468, 4221.261279276176, 4251.915761480803, 4265.4241677373775, 4316.179925814085, 8926.375153739305, 8944.105589441004, 8968.0, 8984.55077246135, 8990.505522196341, 4832.661713680079, 4835.395575553056, 4840.394950631171, 4859.927101093486, 4862.222044472867, 4394.582514661102, 4399.5380485049245, 4425.579569940915, 4425.889352766142, 4443.044745379759, 3361.2941282330494, 3380.560527131457, 3398.116489712643, 3406.5060566217758, 3426.1777173478185, 1020.1430798129607, 1020.9744756381001, 1023.7133602591286, 1027.6968294353185, 1029.1766586730585, 1058.2063452410691, 1072.303003048025, 1074.957001719938, 1206.1737709668905, 1333.919964802115, 7052.894206586802, 7114.822129446702, 7140.0, 7157.964210178916, 7357.374623157091, 1040.2770074798093, 1050.669039252633, 1059.057438879398, 1118.552578968403, 1138.5616537632905, 5480.972595137078, 5550.7779688812, 5554.028045092093, 5558.805441809517, 5564.944350556523, 8976.147266009719, 9629.951850240845, 9789.608415663437, 10016.54925528353, 10036.347637403545, 9750.414975101517, 9756.219502439788, 9774.951125244328, 9815.36200146988, 9828.115469607626, 7452.515586486861, 7604.733834315773, 7620.733274335372, 7682.1549629540705, 7715.498492597963, 7173.42612590981, 7316.9634151828905, 7342.853142937218, 7383.261673832574, 7404.074490688664, 8465.153484651486, 8635.481871087755, 8723.171298726611, 8858.557072146237, 8929.821403572023, 8474.27968622674, 8906.332025098272, 9054.41146325513, 9126.5436728162, 9163.725088247364, 6818.249992500921, 6889.069975553236, 6896.137982752156, 6899.344562266577, 6916.619585922823, 7614.733484328022, 7642.65608047628, 7727.536347819148, 7744.1094274159195, 7769.456138070281, 6957.582545047313, 7315.561066336037, 7331.560106393634, 7391.852162956819, 7606.733764318223, 6890.965545172242, 7086.433085353263, 7123.608201548965, 7169.892451613126, 7210.819729506804, 7024.754133605299, 7038.964805175941, 7065.858682826418, 7068.081149450744, 7071.611061391673, 6365.61806291624, 6427.1002059710745, 6440.066190402459, 6450.774222902363, 6457.515686323451, 6174.228221472316, 6452.161219041494, 6521.673916304071, 6556.18047744032, 6575.112359831362], "unit": "score", "name": "mootools.html", "value": 4535.997757622461}, {"lowerIsBetter": false, "replicates": [324.681811824412, 327.8885179039126, 331.14894720568134, 335.24736965512426, 339.92521645238037, 6203.410675985785, 6303.243610766709, 6327.209098862642, 6372.458341041017, 6407.167068281123, 6067.726952287147, 6132.773445310944, 6158.261008678954, 6179.876402471948, 6208.099825525296, 4691.882702932428, 4730.172219861511, 4730.243161094226, 4741.5495527924795, 4742.857714268577, 4740.76296185191, 4748.121597504455, 4748.857534273978, 4749.952500474986, 4758.952410475886, 4607.539246075399, 4636.072785442908, 4664.230401983668, 4714.104320179172, 4718.90562188756, 4675.438947326308, 4687.0625874825, 4693.155232058211, 4704.858854234379, 4706.0, 4043.2115737431213, 4072.857449989236, 4098.282800509929, 4104.1381309924955, 4110.876673699794, 5857.6778277194735, 5899.970500147472, 5903.675297858616, 5910.67491287979, 5924.081767326072, 5279.260903473517, 5429.945700542983, 5433.538149257279, 5446.346438427375, 5457.672539647594, 6484.902726459107, 6564.21229452464, 6580.4406625436895, 6583.637899915503, 6584.341565843425, 4458.1306645204195, 4461.754603496806, 4463.33050042493, 4465.486469056068, 4465.68740188187, 6706.5640733352175, 6860.5197636165485, 6901.068355772007, 6908.447324214051, 6922.41159501443, 4541.364209010741, 4560.270356742905, 4566.88582785433, 4571.885702857388, 4578.198815207325, 4604.815807367735, 4628.514006029319, 4640.814367425265, 4654.464736555339, 4666.2767271073035, 5437.918431223535, 5439.347278326547, 5442.156465747816, 5442.374126975369, 5447.0, 6464.709088091047, 6688.331166883273, 6693.79918602433, 6707.664616769142, 6714.597124172566, 1610.8630766384988, 1615.4588212948559, 1657.6187476880384, 1659.203582280488, 1659.6929568029952, 1052.4527245832278, 1075.876274228458, 1079.0396547073112, 1081.7944590527775, 1084.5553323137476, 6215.12988181655, 6224.688765561704, 6255.24937007562, 6255.40573645503, 6259.4679452246155, 6780.864382712417, 6791.049253104569, 6798.252192258848, 6801.761938332134, 6803.2856550062525, 6011.008183649649, 6250.343713910065, 6254.74981000764, 6258.374162583706, 6265.185525881698, 3684.502592150079, 3685.9631403686158, 3704.7406681532034, 3706.5181526401393, 3707.8331475083687, 7075.787726368218, 7096.183938847099, 7097.254788247263, 7097.538659987084, 7113.288671132846, 6892.931070689229, 6896.000079988374, 6922.5154239202775, 6925.238223795379, 6932.410745086623, 7212.639368031578, 7225.494215404976, 7230.855382892312, 7291.781246562611, 7322.926770732331, 6937.306269373023, 6980.720771169096, 6990.021397004525, 7002.649867506706, 7003.229644739176, 6790.219124800711, 6843.7604683835825, 6858.074159988537, 6914.101166848278, 6917.13535808024, 7193.748218812317, 7198.49610527258, 7202.927970720226, 7212.74755383559, 7251.274872512707, 4648.302754586839, 4665.346851440869, 4706.199946009255, 4708.434987801349, 4709.3642358281195, 6817.181938167451, 7005.719771209095, 7009.474289428415, 7017.614031228331, 7022.859542809218, 6770.4922130839395, 6778.8983165251575, 6779.491538134561, 6779.72881084751, 6784.796456106127, 6759.797206083826, 6775.390214880685, 6786.049953006484, 6792.422644075309, 6793.626350550767, 6476.935230647633, 6621.33786621334, 6645.60126392418, 6650.501212408992, 6654.201495820533, 6794.388505034571, 6797.048413222054, 6803.047573339637, 6810.0, 6821.420179284816, 6650.501212409185, 6666.133402657623, 6670.733170673118, 6673.132492775908, 6676.332366763285], "unit": "score", "name": "prototype.html", "value": 4975.190583687666}, {"lowerIsBetter": false, "replicates": [822.2024487117668, 846.1749793950895, 847.8685803700424, 854.4915775113809, 863.7797361672773, 13305.866941330583, 13352.0, 13407.7318453631, 13416.329183540809, 13526.661833454156, 12284.078694097934, 12573.559925402613, 12600.802923722254, 12630.873691263085, 12673.0, 780.5979920341, 785.2343964634479, 796.6056801883076, 805.2350267246139, 807.9151689072651, 792.5482474989259, 798.4291231769283, 800.4916877782621, 801.3068695578312, 803.5058439059965, 827.0984626756834, 833.3250067445358, 834.9165083491663, 836.3894357119307, 837.426362941384, 833.6457005772553, 834.1950018232404, 835.9373047021437, 837.1795640272567, 839.4879123734547, 610.7190692281556, 610.7923306075955, 614.1310046284502, 614.7786796753165, 615.2278889993074, 13702.725945481034, 13822.723545529034, 13840.723185536233, 13842.930785346009, 13866.376013079436, 12277.877221227764, 12499.937500312531, 12620.936895315557, 12678.983374433215, 12722.427490762939, 9750.561224744904, 9928.056834600702, 9941.65204217856, 9954.502274886227, 9969.202463802878, 3553.875614353485, 3560.661737134968, 3596.5504311961004, 3682.410814269731, 3707.4253490708984, 48323.27515087277, 48963.51036489661, 49551.0, 49661.0, 49791.0, 8884.422512536665, 8971.327150463741, 9048.321375896834, 9841.45871977048, 9915.504224788732, 14561.78157327641, 14565.781513277308, 14597.0, 14604.12375257488, 14701.926490367694, 7291.197968223491, 7311.89032164518, 7381.077365329334, 7406.629668516553, 7420.257974202645, 4240.173166232555, 4291.871243862689, 4304.139172165579, 4354.934675979863, 4404.163208990281, 2957.231119908839, 2965.3476235228213, 2967.5548667699586, 2968.5992391026934, 2988.2230620038513, 582.6882617799457, 591.6479694581803, 597.7877853361994, 599.8800239951939, 608.7930103764742, 566.1960016776188, 668.2248591633681, 680.1939701453794, 703.1632357494667, 705.2031204738715, 8479.364047696448, 8548.487090774574, 8598.699045533376, 8672.002719687316, 8695.347848911357, 606.8604221029188, 627.6830200748684, 687.814290141659, 719.5790462579345, 734.8383355661746, 4000.7799571023875, 4223.0, 4251.4685664291965, 4293.849715259951, 4300.78496075195, 55687.164692529645, 56861.14708279379, 56918.71540642353, 57012.71493642588, 57651.42348576461, 47766.522334776906, 48974.510254896995, 49407.50592494101, 49734.75132624314, 49968.25047624289, 44185.779071105084, 44391.55608443939, 44605.33092003623, 45307.320390194174, 46252.53747462482, 8293.087760346478, 8483.83032339362, 8597.18326758957, 8652.870206947027, 9003.90996090057, 33155.0, 33161.0, 33651.83174084114, 34299.314013719086, 34609.48085778665, 41660.58339416688, 42628.78685606676, 42729.5727042738, 42837.57162428336, 42874.356884646135, 10196.898031019595, 10211.489425528545, 11032.0, 11080.0, 11161.553537858395, 12196.57311994076, 12221.450034748636, 12349.506019759468, 12356.752864942471, 12779.488820447077, 11221.66335009951, 11222.046126079375, 11246.83129753038, 11359.772804543698, 11794.115441342105, 11398.886011139783, 11452.885471145182, 11516.53933842637, 11821.172517924007, 11990.40047997614, 11067.209470765938, 11224.382658953837, 11707.765844683228, 11865.940670296593, 12086.0, 9769.560369783234, 9868.901310986797, 9962.900370996487, 10062.245331600014, 10166.491675416348, 9540.236781057638, 10417.583296668048, 10454.477276136011, 10455.215858810467, 10513.842292365774], "unit": "score", "name": "yui.html", "value": 6263.480840617104}], "name": "dromaeo_css", "value": 6990.957011771436}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 113.0, 112.0, 123.0, 111.0, 112.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [158.0, 135.0, 154.0, 159.0, 130.0, 159.0, 154.0, 128.0, 158.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [165.0, 162.0, 164.0, 164.0, 164.0, 163.0, 165.0, 167.0, 169.0, 161.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 73.0, 73.0, 73.0, 74.0, 143.0, 73.0, 73.0, 75.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 140.0, 96.0, 96.0, 97.0, 148.0, 98.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 113.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.6}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 149.0, 147.0, 148.0, 151.0, 147.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 102.0, 97.0, 97.0, 97.0, 97.0, 96.0, 101.0], "unit": "score", "name": "imaging-desaturate", "value": 97.7}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 61.0, 62.0, 60.0, 59.0, 60.0, 60.0, 61.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 83.0, 85.0, 85.0, 82.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 118.0, 124.0, 118.0, 117.0, 116.0, 116.0, 125.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.9}, {"lowerIsBetter": true, "replicates": [134.0, 148.0, 141.0, 142.0, 140.0, 147.0, 149.0, 143.0, 145.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 69.0, 68.0, 65.0, 66.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1508.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.44809109176154], "unit": "score", "name": "Richards", "value": 210.82354399999997}, {"lowerIsBetter": false, "replicates": [185.70102135561746], "unit": "score", "name": "DeltaBlue", "value": 356.04543000000007}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1069.51871657754], "unit": "score", "name": "RayTrace", "value": 691.889715}, {"lowerIsBetter": false, "replicates": [712.7583749109052], "unit": "score", "name": "Earley", "value": 935.0475890000001}, {"lowerIsBetter": false, "replicates": [12658.227848101265], "unit": "score", "name": "Boyer", "value": 52.65057700000003}, {"lowerIsBetter": false, "replicates": [40840.0], "unit": "score", "name": "RegExp", "value": 22.306194906953955}, {"lowerIsBetter": false, "replicates": [576.036866359447], "unit": "score", "name": "Splay", "value": 141.46837599999995}, {"lowerIsBetter": false, "replicates": [4882.926829268293], "unit": "score", "name": "NavierStokes", "value": 303.91608391608383}], "name": "v8_7", "value": 20415.39656769706}]} 21:31:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20415.40"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1508.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6990.96"}}} 21:31:40 INFO - Return code: 0 21:31:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 21:31:40 INFO - # TBPL SUCCESS # 21:31:40 INFO - Running post-action listener: _resource_record_post_action 21:31:40 INFO - Running post-run listener: _resource_record_post_run 21:31:41 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 550957056; Read time: 0; Write time: 463540 21:31:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237416448; Read time: 0; Write time: 233372 21:31:41 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 313540608; Read time: 0; Write time: 230168 21:31:41 INFO - Running post-run listener: _upload_blobber_files 21:31:41 INFO - Blob upload gear active. 21:31:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 21:31:41 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 21:31:41 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'] 21:31:41 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 21:31:42 INFO - (blobuploader) - INFO - Open directory for files ... 21:31:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:31:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:31:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:31:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:31:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:31:42 INFO - (blobuploader) - INFO - Done attempting. 21:31:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:31:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:31:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:31:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:31:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:31:43 INFO - (blobuploader) - INFO - Done attempting. 21:31:43 INFO - (blobuploader) - INFO - Iteration through files over. 21:31:43 INFO - Return code: 0 21:31:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 21:31:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 21:31:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/145899fe1bfe7eff20fbda90ae1bce14b0580e146bb58dd333e9e97b66bfa7fefb8587b38fee8a622cc4c319d1e75b182ff974d9b968047804c309a06e7ea815", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f618a173a7179fd4faf368adffca3b82a982d7cdb0cf9da9114761547eaa7b12a117fd11b8c827a233e0d17f9f4e057669ec3a36f18ba5a1a9bb8d7faf54a26"} 21:31:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 21:31:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 21:31:43 INFO - Contents: 21:31:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/145899fe1bfe7eff20fbda90ae1bce14b0580e146bb58dd333e9e97b66bfa7fefb8587b38fee8a622cc4c319d1e75b182ff974d9b968047804c309a06e7ea815", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f618a173a7179fd4faf368adffca3b82a982d7cdb0cf9da9114761547eaa7b12a117fd11b8c827a233e0d17f9f4e057669ec3a36f18ba5a1a9bb8d7faf54a26"} 21:31:43 INFO - Running post-run listener: copy_logs_to_upload_dir 21:31:43 INFO - Copying logs to upload dir... 21:31:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 21:31:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.290151 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-20 21:31:43.513865) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 21:31:43.518463) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258 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/145899fe1bfe7eff20fbda90ae1bce14b0580e146bb58dd333e9e97b66bfa7fefb8587b38fee8a622cc4c319d1e75b182ff974d9b968047804c309a06e7ea815", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f618a173a7179fd4faf368adffca3b82a982d7cdb0cf9da9114761547eaa7b12a117fd11b8c827a233e0d17f9f4e057669ec3a36f18ba5a1a9bb8d7faf54a26"} build_url:https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/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/145899fe1bfe7eff20fbda90ae1bce14b0580e146bb58dd333e9e97b66bfa7fefb8587b38fee8a622cc4c319d1e75b182ff974d9b968047804c309a06e7ea815", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f618a173a7179fd4faf368adffca3b82a982d7cdb0cf9da9114761547eaa7b12a117fd11b8c827a233e0d17f9f4e057669ec3a36f18ba5a1a9bb8d7faf54a26"}' ========= master_lag: 0.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 21:31:43.905779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:31:43.909163) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1453352050.709997-285846258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004709 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:31:43.990372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 21:31:43.990738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 21:31:43.991147) ========= ========= Total master_lag: 0.98 =========