builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1447879715.24 results: success (0) buildid: 20151118113056 builduid: e5e592681ec246c7aba7095665dd327a revision: 929982f95a788e798b848da372725dd80cc44b36 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.244229) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.244668) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.244951) ========= 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=d6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006481 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.272486) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.272764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.291487) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.291742) ========= 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=d6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.345352) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.345650) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.345986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.346267) ========= 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=d6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 12:48:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-11-18 12:48:35 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.202833 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.562660) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.562932) ========= 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=d6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015084 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.612401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:35.612705) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 929982f95a788e798b848da372725dd80cc44b36 --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 929982f95a788e798b848da372725dd80cc44b36 --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=d6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 12:48:35,782 truncating revision to first 12 chars 2015-11-18 12:48:35,782 Setting DEBUG logging. 2015-11-18 12:48:35,782 attempt 1/10 2015-11-18 12:48:35,782 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/929982f95a78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 12:48:36,040 unpacking tar archive at: fx-team-929982f95a78/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534856 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:36.159284) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:36.159552) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:36.170873) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:36.171156) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 12:48:36.171518) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-18 12:48:36.171842) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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', '--system-bits', '64', '--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=d6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:48:36 INFO - MultiFileLogger online at 20151118 12:48:36 in /builds/slave/test-pgo 12:48:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:48:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:48:36 INFO - {'append_to_log': False, 12:48:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:48:36 INFO - 'blob_upload_branch': 'Fx-Team', 12:48:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:48:36 INFO - 'branch': 'Fx-Team', 12:48:36 INFO - 'buildbot_json_path': 'buildprops.json', 12:48:36 INFO - 'config_files': ('talos/linux_config.py',), 12:48:36 INFO - 'default_actions': ('clobber', 12:48:36 INFO - 'read-buildbot-config', 12:48:36 INFO - 'download-and-extract', 12:48:36 INFO - 'populate-webroot', 12:48:36 INFO - 'create-virtualenv', 12:48:36 INFO - 'install', 12:48:36 INFO - 'run-tests'), 12:48:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:48:36 INFO - 'download_minidump_stackwalk': True, 12:48:36 INFO - 'download_symbols': 'ondemand', 12:48:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:48:36 INFO - 'tooltool.py': '/tools/tooltool.py', 12:48:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:48:36 INFO - '/tools/misc-python/virtualenv.py')}, 12:48:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:48:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:48:36 INFO - 'installer_path': 'installer.exe', 12:48:36 INFO - 'log_level': 'info', 12:48:36 INFO - 'log_name': 'talos', 12:48:36 INFO - 'log_to_console': True, 12:48:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:48:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:48:36 INFO - 'opt_config_files': (), 12:48:36 INFO - 'pip_index': False, 12:48:36 INFO - 'sps_profile': False, 12:48:36 INFO - 'sps_profile_interval': 0, 12:48:36 INFO - 'suite': 'dromaeojs-e10s', 12:48:36 INFO - 'system_bits': '64', 12:48:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:48:36 INFO - 'title': 'talos-linux64-ix-016', 12:48:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:48:36 INFO - 'use_talos_json': True, 12:48:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:48:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:48:36 INFO - 'work_dir': 'build'} 12:48:36 INFO - ##### 12:48:36 INFO - ##### Running clobber step. 12:48:36 INFO - ##### 12:48:36 INFO - Running pre-action listener: _resource_record_pre_action 12:48:36 INFO - Running main action method: clobber 12:48:36 INFO - rmtree: /builds/slave/test-pgo/build 12:48:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:48:37 INFO - Running post-action listener: _resource_record_post_action 12:48:37 INFO - ##### 12:48:37 INFO - ##### Running read-buildbot-config step. 12:48:37 INFO - ##### 12:48:37 INFO - Running pre-action listener: _resource_record_pre_action 12:48:37 INFO - Running main action method: read_buildbot_config 12:48:37 INFO - Using buildbot properties: 12:48:37 INFO - { 12:48:37 INFO - "properties": { 12:48:37 INFO - "buildnumber": 340, 12:48:37 INFO - "product": "firefox", 12:48:37 INFO - "script_repo_revision": "production", 12:48:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:48:37 INFO - "repository": "", 12:48:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:48:37 INFO - "buildid": "20151118113056", 12:48:37 INFO - "slavename": "talos-linux64-ix-016", 12:48:37 INFO - "pgo_build": "True", 12:48:37 INFO - "basedir": "/builds/slave/test-pgo", 12:48:37 INFO - "project": "", 12:48:37 INFO - "platform": "ubuntu64_hw", 12:48:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:48:37 INFO - "slavebuilddir": "test", 12:48:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:48:37 INFO - "branch": "fx-team", 12:48:37 INFO - "repo_path": "integration/fx-team", 12:48:37 INFO - "stage_platform": "linux64-pgo", 12:48:37 INFO - "builduid": "e5e592681ec246c7aba7095665dd327a", 12:48:37 INFO - "revision": "929982f95a788e798b848da372725dd80cc44b36" 12:48:37 INFO - }, 12:48:37 INFO - "sourcestamp": { 12:48:37 INFO - "repository": "", 12:48:37 INFO - "hasPatch": false, 12:48:37 INFO - "project": "", 12:48:37 INFO - "branch": "fx-team-linux64-pgo-talos", 12:48:37 INFO - "changes": [ 12:48:37 INFO - { 12:48:37 INFO - "category": null, 12:48:37 INFO - "files": [ 12:48:37 INFO - { 12:48:37 INFO - "url": null, 12:48:37 INFO - "name": "https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:48:37 INFO - } 12:48:37 INFO - ], 12:48:37 INFO - "repository": "", 12:48:37 INFO - "rev": "929982f95a788e798b848da372725dd80cc44b36", 12:48:37 INFO - "who": "sendchange", 12:48:37 INFO - "when": 1447879664, 12:48:37 INFO - "number": 6678725, 12:48:37 INFO - "comments": "", 12:48:37 INFO - "project": "", 12:48:37 INFO - "at": "Wed 18 Nov 2015 12:47:44", 12:48:37 INFO - "branch": "fx-team-linux64-pgo-talos", 12:48:37 INFO - "revlink": "", 12:48:37 INFO - "properties": [ 12:48:37 INFO - [ 12:48:37 INFO - "buildid", 12:48:37 INFO - "20151118113056", 12:48:37 INFO - "Change" 12:48:37 INFO - ], 12:48:37 INFO - [ 12:48:37 INFO - "builduid", 12:48:37 INFO - "e5e592681ec246c7aba7095665dd327a", 12:48:37 INFO - "Change" 12:48:37 INFO - ], 12:48:37 INFO - [ 12:48:37 INFO - "pgo_build", 12:48:37 INFO - "True", 12:48:37 INFO - "Change" 12:48:37 INFO - ] 12:48:37 INFO - ], 12:48:37 INFO - "revision": "929982f95a788e798b848da372725dd80cc44b36" 12:48:37 INFO - } 12:48:37 INFO - ], 12:48:37 INFO - "revision": "929982f95a788e798b848da372725dd80cc44b36" 12:48:37 INFO - } 12:48:37 INFO - } 12:48:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:48:37 INFO - Running post-action listener: _resource_record_post_action 12:48:37 INFO - ##### 12:48:37 INFO - ##### Running download-and-extract step. 12:48:37 INFO - ##### 12:48:37 INFO - Running pre-action listener: _resource_record_pre_action 12:48:37 INFO - Running main action method: download_and_extract 12:48:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:37 INFO - https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:48:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/test_packages.json 12:48:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/test_packages.json 12:48:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:48:37 INFO - Downloaded 1302 bytes. 12:48:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:48:37 INFO - Using the following test package requirements: 12:48:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:48:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:37 INFO - u'jsshell-linux-x86_64.zip'], 12:48:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:48:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:48:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:48:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:48:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:48:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:48:38 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')]} 12:48:38 INFO - https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:48:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:48:39 INFO - Downloaded 22474411 bytes. 12:48:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:48:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:48:40 INFO - Return code: 0 12:48:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:40 INFO - https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:48:46 INFO - Downloaded 22474411 bytes. 12:48:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:48:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:48:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:48:48 INFO - Return code: 0 12:48:48 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')]} 12:48:48 INFO - https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:48:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:48:48 INFO - Downloaded 11130997 bytes. 12:48:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 12:48:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:48:49 INFO - Return code: 0 12:48: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')]} 12:48:49 INFO - https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:48:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:48:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:48:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:48:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:48:50 INFO - Downloaded 57209136 bytes. 12:48:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:48:50 INFO - mkdir: /builds/slave/test-pgo/properties 12:48:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:48:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:48:50 INFO - Contents: 12:48:50 INFO - build_url:https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:48:50 INFO - Running post-action listener: _resource_record_post_action 12:48:50 INFO - Running post-action listener: set_extra_try_arguments 12:48:50 INFO - ##### 12:48:50 INFO - ##### Running populate-webroot step. 12:48:50 INFO - ##### 12:48:50 INFO - Running pre-action listener: _resource_record_pre_action 12:48:50 INFO - Running main action method: populate_webroot 12:48:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:48:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:48:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:48:50 INFO - '../fennec_ids.txt'], 12:48:50 INFO - 'tests': ['tcheck2']}, 12:48:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:48:50 INFO - '--tppagecycles', 12:48:50 INFO - '7'], 12:48:50 INFO - 'tests': ['tsvgm']}}, 12:48:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:48:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:48:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:48:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:48:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:48:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:48:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:50 INFO - 'talos_options': ['--e10s'], 12:48:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:50 INFO - 'tests': ['damp', 'tps']}, 12:48:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:50 INFO - 'talos_options': ['--e10s'], 12:48:50 INFO - 'tests': ['damp', 'tps']}, 12:48:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:48:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:48:50 INFO - 'other': {'tests': ['a11yr', 12:48:50 INFO - 'ts_paint', 12:48:50 INFO - 'tpaint', 12:48:50 INFO - 'sessionrestore', 12:48:50 INFO - 'sessionrestore_no_auto_restore']}, 12:48:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:48:50 INFO - 'tests': ['a11yr', 12:48:50 INFO - 'ts_paint', 12:48:50 INFO - 'tpaint', 12:48:50 INFO - 'sessionrestore', 12:48:50 INFO - 'sessionrestore_no_auto_restore']}, 12:48:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:48:50 INFO - 'tests': ['a11yr', 12:48:50 INFO - 'ts_paint', 12:48:50 INFO - 'tpaint', 12:48:50 INFO - 'sessionrestore', 12:48:50 INFO - 'sessionrestore_no_auto_restore']}, 12:48:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:48:50 INFO - 'tests': ['a11yr', 12:48:50 INFO - 'ts_paint', 12:48:50 INFO - 'tpaint', 12:48:50 INFO - 'sessionrestore', 12:48:50 INFO - 'sessionrestore_no_auto_restore']}, 12:48:50 INFO - 'other_l64': {'tests': ['a11yr', 12:48:50 INFO - 'ts_paint', 12:48:50 INFO - 'tpaint', 12:48:50 INFO - 'sessionrestore', 12:48:50 INFO - 'sessionrestore_no_auto_restore']}, 12:48:50 INFO - 'other_nol64': {'tests': ['a11yr', 12:48:50 INFO - 'ts_paint', 12:48:50 INFO - 'tpaint', 12:48:50 INFO - 'sessionrestore', 12:48:50 INFO - 'sessionrestore_no_auto_restore']}, 12:48:50 INFO - 'svgr': {'tests': ['tsvgx', 12:48:50 INFO - 'tsvgr_opacity', 12:48:50 INFO - 'tart', 12:48:50 INFO - 'tscrollx', 12:48:50 INFO - 'cart']}, 12:48:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:48:50 INFO - 'tests': ['tsvgx', 12:48:50 INFO - 'tsvgr_opacity', 12:48:50 INFO - 'tart', 12:48:50 INFO - 'tscrollx', 12:48:50 INFO - 'cart']}, 12:48:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:50 INFO - 'tests': ['tp5o']}, 12:48:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:50 INFO - 'talos_options': ['--e10s'], 12:48:50 INFO - 'tests': ['tp5o']}, 12:48:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:50 INFO - 'talos_options': ['--xperf_path', 12:48:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:50 INFO - 'tests': ['tp5n']}, 12:48:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:50 INFO - 'talos_options': ['--e10s', 12:48:50 INFO - '--xperf_path', 12:48:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:50 INFO - 'tests': ['tp5n']}}, 12:48:50 INFO - 'talos.zip': {'path': '', 12:48:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:48:50 INFO - Running post-action listener: _resource_record_post_action 12:48:50 INFO - ##### 12:48:50 INFO - ##### Running create-virtualenv step. 12:48:50 INFO - ##### 12:48:50 INFO - Running pre-action listener: _resource_record_pre_action 12:48:50 INFO - Running main action method: create_virtualenv 12:48:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:48:50 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 12:48:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:48:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:48:50 INFO - Using real prefix '/usr' 12:48:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:48:51 INFO - Installing distribute.............................................................................................................................................................................................done. 12:48:53 INFO - Installing pip.................done. 12:48:53 INFO - Return code: 0 12:48:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f363be87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22887c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ccd70>, '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 0x22cdb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdfb0>, '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': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', '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 12:48:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 12:48:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:48:53 INFO - Using env: {'DISPLAY': ':0', 12:48:53 INFO - 'HOME': '/home/cltbld', 12:48:53 INFO - 'LANG': 'en_US.UTF-8', 12:48:53 INFO - 'LANGUAGE': 'en_US:en', 12:48:53 INFO - 'LOGNAME': 'cltbld', 12:48:53 INFO - 'MAIL': '/var/mail/cltbld', 12:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:53 INFO - 'MOZ_NO_REMOTE': '1', 12:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:53 INFO - 'NO_EM_RESTART': '1', 12:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:48:53 INFO - 'PWD': '/builds/slave/test-pgo', 12:48:53 INFO - 'SHELL': '/bin/bash', 12:48:53 INFO - 'SHLVL': '1', 12:48:53 INFO - 'TERM': 'linux', 12:48:53 INFO - 'TMOUT': '86400', 12:48:53 INFO - 'USER': 'cltbld', 12:48:53 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', 12:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:53 INFO - '_': '/tools/buildbot/bin/python'} 12:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:53 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 12:48:53 INFO - Cleaning up... 12:48:53 INFO - Return code: 0 12:48:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f363be87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22887c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ccd70>, '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 0x22cdb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdfb0>, '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': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', '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 12:48:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 12:48:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:48:53 INFO - Using env: {'DISPLAY': ':0', 12:48:53 INFO - 'HOME': '/home/cltbld', 12:48:53 INFO - 'LANG': 'en_US.UTF-8', 12:48:53 INFO - 'LANGUAGE': 'en_US:en', 12:48:53 INFO - 'LOGNAME': 'cltbld', 12:48:53 INFO - 'MAIL': '/var/mail/cltbld', 12:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:53 INFO - 'MOZ_NO_REMOTE': '1', 12:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:53 INFO - 'NO_EM_RESTART': '1', 12:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:48:53 INFO - 'PWD': '/builds/slave/test-pgo', 12:48:53 INFO - 'SHELL': '/bin/bash', 12:48:53 INFO - 'SHLVL': '1', 12:48:53 INFO - 'TERM': 'linux', 12:48:53 INFO - 'TMOUT': '86400', 12:48:53 INFO - 'USER': 'cltbld', 12:48:53 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', 12:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:53 INFO - '_': '/tools/buildbot/bin/python'} 12:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:53 INFO - Downloading/unpacking psutil>=0.7.1 12:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:48:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:48:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:48:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:55 INFO - Installing collected packages: psutil 12:48:55 INFO - Running setup.py install for psutil 12:48:55 INFO - building 'psutil._psutil_linux' extension 12:48:55 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 12:48:55 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 12:48:55 INFO - building 'psutil._psutil_posix' extension 12:48:55 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 12:48:55 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 12:48:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:56 INFO - Successfully installed psutil 12:48:56 INFO - Cleaning up... 12:48:56 INFO - Return code: 0 12:48:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f363be87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22887c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ccd70>, '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 0x22cdb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdfb0>, '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': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', '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 12:48:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 12:48:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:48:56 INFO - Using env: {'DISPLAY': ':0', 12:48:56 INFO - 'HOME': '/home/cltbld', 12:48:56 INFO - 'LANG': 'en_US.UTF-8', 12:48:56 INFO - 'LANGUAGE': 'en_US:en', 12:48:56 INFO - 'LOGNAME': 'cltbld', 12:48:56 INFO - 'MAIL': '/var/mail/cltbld', 12:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:56 INFO - 'MOZ_NO_REMOTE': '1', 12:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:56 INFO - 'NO_EM_RESTART': '1', 12:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:48:56 INFO - 'PWD': '/builds/slave/test-pgo', 12:48:56 INFO - 'SHELL': '/bin/bash', 12:48:56 INFO - 'SHLVL': '1', 12:48:56 INFO - 'TERM': 'linux', 12:48:56 INFO - 'TMOUT': '86400', 12:48:56 INFO - 'USER': 'cltbld', 12:48:56 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', 12:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:56 INFO - '_': '/tools/buildbot/bin/python'} 12:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:48:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:48:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:48:57 INFO - Installing collected packages: mozsystemmonitor 12:48:57 INFO - Running setup.py install for mozsystemmonitor 12:48:58 INFO - Successfully installed mozsystemmonitor 12:48:58 INFO - Cleaning up... 12:48:58 INFO - Return code: 0 12:48:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f363be87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22887c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ccd70>, '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 0x22cdb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdfb0>, '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': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', '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 12:48:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 12:48:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:48:58 INFO - Using env: {'DISPLAY': ':0', 12:48:58 INFO - 'HOME': '/home/cltbld', 12:48:58 INFO - 'LANG': 'en_US.UTF-8', 12:48:58 INFO - 'LANGUAGE': 'en_US:en', 12:48:58 INFO - 'LOGNAME': 'cltbld', 12:48:58 INFO - 'MAIL': '/var/mail/cltbld', 12:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:58 INFO - 'MOZ_NO_REMOTE': '1', 12:48:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:58 INFO - 'NO_EM_RESTART': '1', 12:48:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:48:58 INFO - 'PWD': '/builds/slave/test-pgo', 12:48:58 INFO - 'SHELL': '/bin/bash', 12:48:58 INFO - 'SHLVL': '1', 12:48:58 INFO - 'TERM': 'linux', 12:48:58 INFO - 'TMOUT': '86400', 12:48:58 INFO - 'USER': 'cltbld', 12:48:58 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', 12:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:58 INFO - '_': '/tools/buildbot/bin/python'} 12:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:58 INFO - Downloading/unpacking blobuploader==1.2.4 12:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:59 INFO - Downloading blobuploader-1.2.4.tar.gz 12:48:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:48:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:49:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:49:00 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 12:49:00 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 12:49:00 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 12:49:00 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 12:49:00 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 12:49:00 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 12:49:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:49:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:49:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:49:00 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 12:49:00 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 12:49:00 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 12:49:00 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 12:49:00 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 12:49:00 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 12:49:00 INFO - Downloading docopt-0.6.1.tar.gz 12:49:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:49:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:49:00 INFO - Installing collected packages: blobuploader, requests, docopt 12:49:00 INFO - Running setup.py install for blobuploader 12:49:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:49:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:49:00 INFO - Running setup.py install for requests 12:49:01 INFO - Running setup.py install for docopt 12:49:01 INFO - Successfully installed blobuploader requests docopt 12:49:01 INFO - Cleaning up... 12:49:01 INFO - Return code: 0 12:49:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:49: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')]} 12:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49: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')]} 12:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f363be87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22887c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ccd70>, '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 0x22cdb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdfb0>, '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': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', '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 12:49:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 12:49:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:49:01 INFO - Using env: {'DISPLAY': ':0', 12:49:01 INFO - 'HOME': '/home/cltbld', 12:49:01 INFO - 'LANG': 'en_US.UTF-8', 12:49:01 INFO - 'LANGUAGE': 'en_US:en', 12:49:01 INFO - 'LOGNAME': 'cltbld', 12:49:01 INFO - 'MAIL': '/var/mail/cltbld', 12:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:01 INFO - 'MOZ_NO_REMOTE': '1', 12:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:01 INFO - 'NO_EM_RESTART': '1', 12:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:01 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:01 INFO - 'SHELL': '/bin/bash', 12:49:01 INFO - 'SHLVL': '1', 12:49:01 INFO - 'TERM': 'linux', 12:49:01 INFO - 'TMOUT': '86400', 12:49:01 INFO - 'USER': 'cltbld', 12:49:01 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', 12:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:01 INFO - '_': '/tools/buildbot/bin/python'} 12:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:01 INFO - Running setup.py (path:/tmp/pip-5iUzDJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:01 INFO - Running setup.py (path:/tmp/pip-JpMNIi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:01 INFO - Running setup.py (path:/tmp/pip-iG9kLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:01 INFO - Running setup.py (path:/tmp/pip-2feTaf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:01 INFO - Running setup.py (path:/tmp/pip-h9eZEv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:01 INFO - Running setup.py (path:/tmp/pip-WgNuAh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:01 INFO - Running setup.py (path:/tmp/pip-jwamFg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:01 INFO - Running setup.py (path:/tmp/pip-YslgEs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:02 INFO - Running setup.py (path:/tmp/pip-kyIkl8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:02 INFO - Running setup.py (path:/tmp/pip-znJUyw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:02 INFO - Running setup.py (path:/tmp/pip-UjEzl_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:02 INFO - Running setup.py (path:/tmp/pip-5QWwmH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:02 INFO - Running setup.py (path:/tmp/pip-28SzGo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:02 INFO - Running setup.py (path:/tmp/pip-s9GW5d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:02 INFO - Running setup.py (path:/tmp/pip-CTIlZ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:02 INFO - Running setup.py (path:/tmp/pip-z3ND8g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:02 INFO - Running setup.py (path:/tmp/pip-d3dYRo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:49:02 INFO - Running setup.py install for manifestparser 12:49:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:49:02 INFO - Running setup.py install for mozcrash 12:49:02 INFO - Running setup.py install for mozdebug 12:49:02 INFO - Running setup.py install for mozdevice 12:49:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:49:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:49:03 INFO - Running setup.py install for mozfile 12:49:03 INFO - Running setup.py install for mozhttpd 12:49:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:49:03 INFO - Running setup.py install for mozinfo 12:49:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:49:03 INFO - Running setup.py install for mozInstall 12:49:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:49:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:49:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:49:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:49:03 INFO - Running setup.py install for mozleak 12:49:03 INFO - Running setup.py install for mozlog 12:49:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:49:03 INFO - Running setup.py install for moznetwork 12:49:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:49:03 INFO - Running setup.py install for mozprocess 12:49:03 INFO - Running setup.py install for mozprofile 12:49:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:49:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:49:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:49:04 INFO - Running setup.py install for mozrunner 12:49:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:49:04 INFO - Running setup.py install for mozscreenshot 12:49:04 INFO - Running setup.py install for moztest 12:49:04 INFO - Running setup.py install for mozversion 12:49:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:49:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:49:04 INFO - Cleaning up... 12:49:04 INFO - Return code: 0 12:49:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:49: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')]} 12:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49: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')]} 12:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f363be87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22887c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ccd70>, '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 0x22cdb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdfb0>, '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': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', '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 12:49:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 12:49:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:49:04 INFO - Using env: {'DISPLAY': ':0', 12:49:04 INFO - 'HOME': '/home/cltbld', 12:49:04 INFO - 'LANG': 'en_US.UTF-8', 12:49:04 INFO - 'LANGUAGE': 'en_US:en', 12:49:04 INFO - 'LOGNAME': 'cltbld', 12:49:04 INFO - 'MAIL': '/var/mail/cltbld', 12:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:04 INFO - 'MOZ_NO_REMOTE': '1', 12:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:04 INFO - 'NO_EM_RESTART': '1', 12:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:04 INFO - 'SHELL': '/bin/bash', 12:49:04 INFO - 'SHLVL': '1', 12:49:04 INFO - 'TERM': 'linux', 12:49:04 INFO - 'TMOUT': '86400', 12:49:04 INFO - 'USER': 'cltbld', 12:49:04 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', 12:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:04 INFO - '_': '/tools/buildbot/bin/python'} 12:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:04 INFO - Running setup.py (path:/tmp/pip-cPbZJc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:49:04 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)) 12:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:04 INFO - Running setup.py (path:/tmp/pip-y4HDLE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:49:04 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)) 12:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:04 INFO - Running setup.py (path:/tmp/pip-SjvITY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:49:04 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)) 12:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:04 INFO - Running setup.py (path:/tmp/pip-j3Zrpz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:04 INFO - Running setup.py (path:/tmp/pip-jYy5CB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:49:05 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)) 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:05 INFO - Running setup.py (path:/tmp/pip-0Hqxa8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:49:05 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)) 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:05 INFO - Running setup.py (path:/tmp/pip-HCmH1M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:49:05 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)) 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:05 INFO - Running setup.py (path:/tmp/pip-dO5ph3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:49:05 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)) 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:05 INFO - Running setup.py (path:/tmp/pip-782GSf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:49:05 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)) 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:05 INFO - Running setup.py (path:/tmp/pip-JGcs8m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:05 INFO - Running setup.py (path:/tmp/pip-xXua_v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:49:05 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)) 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:05 INFO - Running setup.py (path:/tmp/pip-TskUh_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:49:05 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)) 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:05 INFO - Running setup.py (path:/tmp/pip-wgBidU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:05 INFO - Running setup.py (path:/tmp/pip-O5XDY2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:49:05 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)) 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:05 INFO - Running setup.py (path:/tmp/pip-NqKPcg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:49:05 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)) 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:05 INFO - Running setup.py (path:/tmp/pip-67omP7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:49:05 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)) 12:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:05 INFO - Running setup.py (path:/tmp/pip-f1PRz8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:49:05 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)) 12:49:05 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)) 12:49:05 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)) 12:49:05 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)) 12:49: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 mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:49:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49:07 INFO - Downloading blessings-1.5.1.tar.gz 12:49:07 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 12:49:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:49:07 INFO - Installing collected packages: blessings 12:49:07 INFO - Running setup.py install for blessings 12:49:07 INFO - Successfully installed blessings 12:49:07 INFO - Cleaning up... 12:49:07 INFO - Return code: 0 12:49:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:49:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:49:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:49:08 INFO - Reading from file tmpfile_stdout 12:49:08 INFO - Current package versions: 12:49:08 INFO - argparse == 1.2.1 12:49:08 INFO - blessings == 1.5.1 12:49:08 INFO - blobuploader == 1.2.4 12:49:08 INFO - docopt == 0.6.1 12:49:08 INFO - manifestparser == 1.1 12:49:08 INFO - mozInstall == 1.12 12:49:08 INFO - mozcrash == 0.16 12:49:08 INFO - mozdebug == 0.1 12:49:08 INFO - mozdevice == 0.47 12:49:08 INFO - mozfile == 1.2 12:49:08 INFO - mozhttpd == 0.7 12:49:08 INFO - mozinfo == 0.9 12:49:08 INFO - mozleak == 0.1 12:49:08 INFO - mozlog == 3.0 12:49:08 INFO - moznetwork == 0.27 12:49:08 INFO - mozprocess == 0.22 12:49:08 INFO - mozprofile == 0.27 12:49:08 INFO - mozrunner == 6.11 12:49:08 INFO - mozscreenshot == 0.1 12:49:08 INFO - mozsystemmonitor == 0.0 12:49:08 INFO - moztest == 0.7 12:49:08 INFO - mozversion == 1.4 12:49:08 INFO - psutil == 3.1.1 12:49:08 INFO - requests == 1.2.3 12:49:08 INFO - wsgiref == 0.1.2 12:49:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f363be87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22887c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ccd70>, '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 0x22cdb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdfb0>, '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': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', '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 12:49:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 12:49:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 12:49:08 INFO - Using env: {'DISPLAY': ':0', 12:49:08 INFO - 'HOME': '/home/cltbld', 12:49:08 INFO - 'LANG': 'en_US.UTF-8', 12:49:08 INFO - 'LANGUAGE': 'en_US:en', 12:49:08 INFO - 'LOGNAME': 'cltbld', 12:49:08 INFO - 'MAIL': '/var/mail/cltbld', 12:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:08 INFO - 'MOZ_NO_REMOTE': '1', 12:49:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:08 INFO - 'NO_EM_RESTART': '1', 12:49:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:08 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:08 INFO - 'SHELL': '/bin/bash', 12:49:08 INFO - 'SHLVL': '1', 12:49:08 INFO - 'TERM': 'linux', 12:49:08 INFO - 'TMOUT': '86400', 12:49:08 INFO - 'USER': 'cltbld', 12:49:08 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', 12:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:08 INFO - '_': '/tools/buildbot/bin/python'} 12:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:08 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 1)) 12:49:08 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 2)) 12:49:08 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 3)) 12:49:08 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 4)) 12:49:08 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 5)) 12:49:08 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 6)) 12:49:08 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 7)) 12:49:08 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 8)) 12:49:08 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 12:49:08 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 3)) 12:49:08 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 12:49:08 INFO - Cleaning up... 12:49:08 INFO - Return code: 0 12:49:08 INFO - Running post-action listener: _resource_record_post_action 12:49:08 INFO - Running post-action listener: _start_resource_monitoring 12:49:08 INFO - Starting resource monitoring. 12:49:08 INFO - ##### 12:49:08 INFO - ##### Running install step. 12:49:08 INFO - ##### 12:49:08 INFO - Running pre-action listener: _resource_record_pre_action 12:49:08 INFO - Running main action method: install 12:49:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:49:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:49:08 INFO - Reading from file tmpfile_stdout 12:49:08 INFO - Detecting whether we're running mozinstall >=1.0... 12:49:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:49:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:49:08 INFO - Reading from file tmpfile_stdout 12:49:08 INFO - Output received: 12:49:08 INFO - Usage: mozinstall [options] installer 12:49:08 INFO - Options: 12:49:08 INFO - -h, --help show this help message and exit 12:49:08 INFO - -d DEST, --destination=DEST 12:49:08 INFO - Directory to install application into. [default: 12:49:08 INFO - "/builds/slave/test-pgo"] 12:49:08 INFO - --app=APP Application being installed. [default: firefox] 12:49:08 INFO - mkdir: /builds/slave/test-pgo/build/application 12:49:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 12:49:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 12:49:23 INFO - Reading from file tmpfile_stdout 12:49:23 INFO - Output received: 12:49:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:49:23 INFO - Running post-action listener: _resource_record_post_action 12:49:23 INFO - ##### 12:49:23 INFO - ##### Running run-tests step. 12:49:23 INFO - ##### 12:49:23 INFO - Running pre-action listener: _resource_record_pre_action 12:49:23 INFO - Running main action method: run_tests 12:49:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:49:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:49:23 INFO - Python 2.7.3 12:49:23 INFO - Return code: 0 12:49:23 INFO - grabbing minidump binary from tooltool 12:49: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')]} 12:49:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ccd70>, '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 0x22cdb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cdfb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:49:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 12:49:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:49:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:49:23 INFO - Return code: 0 12:49:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:49:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:49:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:49:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:49:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:49:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:49:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost 12:49:23 INFO - Using env: {'DISPLAY': ':0', 12:49:23 INFO - 'HOME': '/home/cltbld', 12:49:23 INFO - 'LANG': 'en_US.UTF-8', 12:49:23 INFO - 'LANGUAGE': 'en_US:en', 12:49:23 INFO - 'LOGNAME': 'cltbld', 12:49:23 INFO - 'MAIL': '/var/mail/cltbld', 12:49:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:49:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:23 INFO - 'MOZ_NO_REMOTE': '1', 12:49:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:23 INFO - 'NO_EM_RESTART': '1', 12:49:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:49:23 INFO - 'PWD': '/builds/slave/test-pgo', 12:49:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:49:23 INFO - 'SHELL': '/bin/bash', 12:49:23 INFO - 'SHLVL': '1', 12:49:23 INFO - 'TERM': 'linux', 12:49:23 INFO - 'TMOUT': '86400', 12:49:23 INFO - 'USER': 'cltbld', 12:49:23 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205', 12:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:23 INFO - '_': '/tools/buildbot/bin/python'} 12:49:23 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] with output_timeout 3600 12:49:23 INFO - mozversion INFO | application_buildid: 20151118113056 12:49:23 INFO - mozversion INFO | application_changeset: 929982f95a788e798b848da372725dd80cc44b36 12:49:23 INFO - mozversion INFO | application_display_name: Nightly 12:49:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:49:23 INFO - mozversion INFO | application_name: Firefox 12:49:23 INFO - mozversion INFO | application_remotingname: firefox 12:49:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:49:23 INFO - mozversion INFO | application_vendor: Mozilla 12:49:23 INFO - mozversion INFO | application_version: 45.0a1 12:49:23 INFO - mozversion INFO | platform_buildid: 20151118113056 12:49:23 INFO - mozversion INFO | platform_changeset: 929982f95a788e798b848da372725dd80cc44b36 12:49:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:49:23 INFO - mozversion INFO | platform_version: 45.0a1 12:49:23 INFO - 2015-11-18 12:49:23,895 DEBUG : using testdate: 1447879763 12:49:23 INFO - 2015-11-18 12:49:23,895 DEBUG : actual date: 1447879763 12:49:23 INFO - 2015-11-18 12:49:23,903 INFO : starting webserver on 'localhost:46743' 12:49:23 INFO - 2015-11-18 12:49:23,904 INFO : Starting test suite talos-linux64-ix-016.e 12:49:23 INFO - 2015-11-18 12:49:23,904 INFO : Starting test dromaeo_css 12:49:23 INFO - 2015-11-18 12:49:23,904 DEBUG : operating with platform_type : linux_ 12:49:23 INFO - 2015-11-18 12:49:23,905 INFO : Initialising browser for dromaeo_css test... 12:49:23 INFO - 2015-11-18 12:49:23,919 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3B7HeX/profile http://localhost:46743/getInfo.html 12:49:28 INFO - 2015-11-18 12:49:28,548 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:49:28 INFO - 2015-11-18 12:49:28,548 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:49:28 INFO - 2015-11-18 12:49:28,548 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:49:28 INFO - 2015-11-18 12:49:28,548 DEBUG : BROWSER_OUTPUT: __metrics 12:49:29 INFO - 2015-11-18 12:49:29,589 INFO : Browser initialized. 12:49:29 INFO - 2015-11-18 12:49:29,590 INFO : Running cycle 1/1 for dromaeo_css test... 12:49:29 INFO - 2015-11-18 12:49:29,590 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3B7HeX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:49:41 INFO - 2015-11-18 12:49:41,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 142249984 12:49:41 INFO - 2015-11-18 12:49:41,391 DEBUG : BROWSER_OUTPUT: 12:50:31 INFO - 2015-11-18 12:50:31,013 DEBUG : BROWSER_OUTPUT: 1447879831006 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] 12:52:39 INFO - 2015-11-18 12:52:39,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46743/tests/dromaeo/cssquery-ext.html) 12:52:40 INFO - 2015-11-18 12:52:40,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 145145856 12:52:40 INFO - 2015-11-18 12:52:40,686 DEBUG : BROWSER_OUTPUT: 12:55:42 INFO - 2015-11-18 12:55:42,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/dromaeo/cssquery-ext.html (next: http://localhost:46743/tests/dromaeo/cssquery-jquery.html) 12:55:43 INFO - 2015-11-18 12:55:43,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 140525568 12:55:43 INFO - 2015-11-18 12:55:43,295 DEBUG : BROWSER_OUTPUT: 12:58:44 INFO - 2015-11-18 12:58:44,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46743/tests/dromaeo/cssquery-mootools.html) 12:58:45 INFO - 2015-11-18 12:58:45,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 142217216 12:58:45 INFO - 2015-11-18 12:58:45,588 DEBUG : BROWSER_OUTPUT: 13:01:47 INFO - 2015-11-18 13:01:47,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46743/tests/dromaeo/cssquery-prototype.html) 13:01:47 INFO - 2015-11-18 13:01:47,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 140742656 13:01:47 INFO - 2015-11-18 13:01:47,827 DEBUG : BROWSER_OUTPUT: 13:04:50 INFO - 2015-11-18 13:04:50,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46743/tests/dromaeo/cssquery-yui.html) 13:04:50 INFO - 2015-11-18 13:04:50,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 141299712 13:04:50 INFO - 2015-11-18 13:04:50,710 DEBUG : BROWSER_OUTPUT: 13:07:52 INFO - 2015-11-18 13:07:52,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/dromaeo/cssquery-yui.html (next: http://localhost:46743/tests/dromaeo/cssquery-dojo.html) 13:07:53 INFO - 2015-11-18 13:07:53,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 144343040 13:07:53 INFO - 2015-11-18 13:07:53,124 DEBUG : BROWSER_OUTPUT: 13:07:53 INFO - 2015-11-18 13:07:53,125 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:07:53 INFO - 2015-11-18 13:07:53,125 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:07:53 INFO - 2015-11-18 13:07:53,125 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:07:53 INFO - 2015-11-18 13:07:53,126 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:07:53 INFO - 2015-11-18 13:07:53,129 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3136.7647426443014;3240.092774023273;3255.9348813023726;3271.362084393544;3278.4590542560477;5216.165413533835;5268.578513718908;5321.92017119743;5343.492368225013;5390.757415916283;5315.096433606286;5333.546648534879;5334.51989320961;5387.919181212285;5428.212909128184;4614.907701845961;4902.705837649743;5102.617303702219;5108.667936584129;5111.821086261982;4831.251156070814;5021.246812978065;5074.416442109168;5083.720395378253;5129.410117836459;4780.16347139251;4859.319695242669;4880.365552478191;4905.509449055102;4961.801527938878;4881.6338774591695;4887.535684110004;4905.975470122662;4947.406311242638;4949.861531847695;4822.758862056919;4883.096627123993;4892.192788189945;4931.358923339979;4938.3580134582635;5137.871553211162;5175.715335656538;5196.272521846944;5224.608154388436;5276.34045744282;5761.942380576183;5789;5813.651180929115;5828.358880523139;5831.125331200354;5646.463585959327;5801.042827933428;5806.187133801272;5842.707864606753;5866.530677545828;5390.380106287827;5475.4524547545325;5476.342838859362;5494.120940649477;5495.258140151029;5944.762209511658;5973.910391344133;5975.820725378246;5983;5987.43119403656;5782.219400380979;5784.334801497797;5785.247917770663;5792.420757924174;5809.738561764731;5674.886502269931;5752.424757524214;5758.049921762946;5844.678542680108;5913.408659134138;5777.682227477445;5779.306483222041;5783.884322313615;5792.797252096157;5795.130730390475;5757.251557297608;5800.56495762811;5808.3901190375245;5809.331926828384;5818.33089194748;4337.262665346899;4436.534163912807;4443.2224360736745;4513.887152821206;4542.500324964251;3967.8412863485137;3971;3975.6421922027157;4006.7996600169877;4019.3970904363996;5304.469553044742;5480.150576660624;5481.177823326533;5483.890322193533;5491.972540137273;5752.9424705753245;5785.334686511105;5804.332501762267;5863.149843272701;5929.110633405024;5589.496945274945;5604.6917419542315;5641.9435805641415;5645.294338207724;5654.434556544395;4971.502849715;5063.3417655704525;5139.408967968731;5161.27742116104;5172.508611681884;5842.211301474246;5866.97327967604;5977.910331345033;6012.338642749294;6034.5172386209;5842.591018628656;5865.032269675627;5868.178455016387;5868.295804503487;5911;5755.510781583613;5997.820065398045;5999.280086389486;6011.699415029144;6032.034874420072;5640.661560306395;5748.965186266512;5749.482546570829;5754.165645981393;5798.913016304675;5863.853403664943;5906.084556893688;5946.970265148647;5971.701414929149;5988.101784732325;5502.257195278587;5636.605437619327;5772.480476757112;5791.536677065909;5808.680522571299;5664.348599910898;5737.254156959569;5755.971220143872;5764.221830053057;5788.305403351456;5474.315710536183;5486.478784515464;5543.667379957215;5560.36055853582;5584.357798853184;5575.135853942646;5614.2701448811395;5642.435756424489;5674.687892165805;5781.103928891029;5629.7748090077575;5654.15187721845;5691.26013618227;5704.172894930295;5713.657180569179 13:07:53 INFO - 2015-11-18 13:07:53,129 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.5857048250646;577.3677822784051;584.2229834320352;584.7105682687069;588.9352171261157;39897.80051099744;40686.18627627446;40843.38734918975;41081.17837643253;41145.58854411459;42917.35623965643;43519.78240108803;43731.78134109333;43733.56266437335;43754.7812260939;8678.218960293572;8836.0722124177;8836.823263534758;8873.068327825582;8883.955580222122;8651.04838467768;8708.912910870906;8717.607707653171;8739.126087391242;8741.694040708577;8716;8728.563571821414;8749.387542872002;8762.518061506615;8817.470951742884;8685.348598855047;8699.086595907433;8760.386772925898;8761.51811650359;8776.210141087333;8610.698625548075;8671.479711217284;8748.737537873874;8753.7811554711;8763.430377025474;40068.398974015414;40557.59442405568;40642.79678601617;40650.79674601638;40694.796526017475;3380;3459.4810778383194;3542.36237477254;3559.839807208682;3648.1609229877276;30102.24744381386;30262.394752104836;30327.848360758057;30399.24001899948;31349;3586.8744593939086;3606.801625910574;3624.238909828939;3674.5039419678537;3728.9813550932345;256598;256730;256929;257213;258115;56745.43254567484;57875.421245787846;66187.66906165535;67186;67213.32786672168;62015;62205.68897155485;62316.57258850716;62591;62743;15428.845711542965;15594.220288985505;15676.529704108894;15686.9215653921;15791.28939197716;11823.704407389883;11910.106741994385;11911;12021.218620789621;12039.879601204051;20048.59902801965;20098.497537561678;20222.191112355635;20340.288089916783;20406.28577999763;7600.201978792258;7735.961320193475;7823.960880195563;7860.921390786133;7871.921280787234;960.5725452173716;986.1962500562018;1051.952662130206;1098.1653943003216;1119.076761671608;28862.567061494094;28904.277393065342;28904.42191156165;29248.660107191372;29268.853655731586;1076.650088721153;1086.4459125845876;1090.6727981605486;1114.6878873915155;1216.0757824053605;15011.549653510412;15048.849511504965;15056.247187640574;15193.696126077417;15323.46367877119;314887;319360;319710;319774;319971;53144.46855531473;53464.73267633637;53549.46450535523;53820.73089634527;53830;1320.808482769993;1345.7375811716818;1350.2641060621984;1372.9931350343184;1397.7134687389062;27003.324916877235;28043.298917527223;28218.2945426366;28615.28461788472;29716.85141574278;45721;45830.770846145555;46033.539664602926;46098.30852537282;46114;215488;217366;217492;217612;218157.72763408243;29475.557866632447;31712.682873171896;32185.67814321827;32185.839070805432;32228;43775.343369848844;44689.55310446854;45043.7747811272;45367;46021;36979.26041479102;37510.6248937518;38109.61890381061;38488;38535.22929541337;37022.62977370192;37222;37900.2419951605;38210.42684359681;38422.423663645626;36535.45196822103;37183.81408092942;37402.43896341503;37462.250754984205;37625.24749505049;32722.34555308833;33611.49582756212;34445.82777086098;34494.82752586221;39192.412113818886;28698.42603147967;30318.54522182125;30584.235394115327;31312.843435782674;31418 13:07:53 INFO - 2015-11-18 13:07:53,133 DEBUG : BROWSER_OUTPUT: |2;jquery.html;345.74242189568776;350.13516613963515;355.1193041257681;356.06710418703;357.18918056012853;12374.50501979922;12759.17065390749;16308.83691163088;16999.660006799855;18044.458666240018;11471.713207169825;11537.365444900528;11689.941550292258;11727.413629318522;11797.646070617895;4529.954700453003;4681.204195286792;4681.976590117045;4684.601808846252;4700.929486057695;4573.039661671037;4692.061587682477;4695.460022097468;4695.788689508963;4697.4832768395445;4651.232546629802;4656.860294191163;4660.324252983315;4801.1117943180625;4808.519148085181;4765.094632019923;4780.545848144421;4785.545373189541;4794.808207671672;4801.447833499157;4435.356873253392;4458.509563947963;4461.750709801261;4482.193205223059;4483.574060464251;13587.32063396836;13638.659033524142;13853.238071906042;13905.304734763222;13949.232792196424;2055.54777948851;2147.8389120816;2155.89220538974;2175.3147758456194;2201.7908298711595;9553.856692149624;9777.804443911082;9991.650292239809;10161.441120738356;10201;1721.1136264823626;1735.522731248904;1751;1756.929722811086;1803.6933721267417;55485.44514554884;56009.43990560083;56934.7153264231;59515;60356.39643603595;6876.349676077705;6911.550749201286;7006.77381458253;7042.964785176041;7112;8489.36329775257;8569.271611912933;8580.699675511327;8588.969323681198;8606.87089693655;5701.458361455655;5728.627639203439;5771.797987070432;5782.479576838021;5786.768529258867;5922.466977972003;5936.495397891227;5936.881262374728;5964.224650795369;5988;3367.4443716786454;3395.5416018837636;3402.5066365376883;3410.403179443637;3415.55597772288;1134.3194083549804;1138.510440510572;1149.8792626774236;1174.365842445087;1228.1403017887335;411.14276733011405;418.101082672251;422.2800125785528;441.5827043443979;441.8033974881147;10244.078032977068;10747.247692661595;10897.891021089847;10971.39657318839;11110.777784444428;439.3980247061546;446.1122366490725;449.0323353173915;454.6431051624459;466.51249444330756;5837.124431335334;5967.492763115097;6015.368386319374;6108.694565271719;6128.63228206309;515298;516572;522387;529594;529644;74751.25248747443;75931.24068759242;76604.61697691475;78465.60767196128;78979.21020789718;506.16735470151394;510.56346823466146;511.0315951272318;513.0406140517257;513.2942204468856;10601.628942986958;10634.946825265824;10673.57305707763;10697.625583104555;10740.785184296426;36079.819600902876;36417.089572760895;36621;37283;37305.761654300826;48302.27546586734;48598.02803943972;49261.75369123275;50977.882654081746;51061;8111.472754270953;8405.621747021522;8538.231559159705;8627.95686021566;8681.609327580149;12096.092793040732;12135.514579416724;12138.757224855277;12210.145289829627;12358.938205308916;9337.159655631025;9504.904950950402;10671.679849604525;10912.781744365227;10932.508037138507;10710.785784284115;10746.086582640562;10878.456077196266;11005.17461190398;11153.163512736415;10920.126389888948;11003.834942476029;11243.212975091665;11267.661970140909;11309.71725706864;8495.74512764618;8501.744947651581;8735.43219690718;8741.694040708544;8746.125387461203;11008.559657613605;11196;11310.264832785842;11373.090152787923;11560.248583842023 13:07:53 INFO - 2015-11-18 13:07:53,134 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1484.3839806480312;1543.0278924277707;1590.10159260018;1690.4337047089225;1792.0502133869045;7566.962165189173;7703.345215656662;7802.726904558334;7859.764207073783;7900.762977110681;7946.880796788053;7961.124276329613;8038.035435747718;8046.959765201181;8047.839043219146;2327.7323107842562;2363.7518060603647;2371.537550177716;2371.691680081587;2375.7861792438675;2253.504229069602;2301.056566807609;2373.715154181492;2374.905003799846;2377.037299893546;2280.600894843404;2309.030207312933;2325.5116425550655;2333.7549557296493;2364.3143488388346;2297.5519773644146;2304.4699719064542;2314.9768502315014;2348.6711860339483;2355.0344358812977;2306.9077236910503;2409.8794060761657;2410.7227668818136;2410.7348191698898;2414.251582009565;7657.961710191414;7674.1942096079665;7685.961570192113;7689.923100768977;7749.186335434754;4672.766361681903;4748.857534273978;4770.880727981794;4785.042991401733;4786.401699787527;3172.904812855618;3193.5209718542174;3219.2434777827193;3227.193201699575;3277.8688852445875;1043.8434234864756;1044.1959691037935;1045.6183493024992;1058.6294796821128;1074.6453670288786;10699.78600427995;10725.785484290349;10760.461976901124;10809.243352965295;10847.294925829796;4255.787210639518;4304.5910638489295;4366.995591014084;4400.075984043323;4424.579664931826;8852.513111778786;8865.113488651083;8867.423617464845;8881.111888811067;8886.555672216493;4673.3690951721765;4697.295405689106;4702.435707715096;4713.34013238147;4714.929276060861;4267.338562522814;4276.444062271885;4291.356296555542;4294.806733696991;4313.870583882489;3544.7518673692593;3584.8028358440015;3595.8381872815785;3612.259486805199;3621.6559426854406;1114.331401159314;1126.3861195648392;1131.2872890079198;1142.2118738070872;1146.8107762219308;1060.9575616975235;1074.9032587067045;1078.1590359519587;1257.8176164456286;1380.6824430381068;7386.224446433154;7414.036175297177;7473.476856620093;7488.288612581796;7588.317051465284;1044.6082718980383;1073.9570417183224;1138.2771939818274;1144.8683401408778;1162.3490845126587;5809.8547536311935;5871.735771890189;5916.674582897896;5921.259842519685;5936.5547583931375;8851.291896648252;8857.689980850768;9156.175944165057;9222.53887305632;9257.953710231406;8973.641054357882;9005.684801031932;9006.54967251648;9016.459012459274;9084.500352480545;7060.646967651597;7120.074390329328;7225.855482890418;7292.8906066409045;7318.634068296564;7317.597532135784;7360.07999000125;7406.222346653523;7457.701691932479;7469.290417410337;8058.355331573577;8170.700751071577;8283.792905177177;8301.501909885426;8396.118407567117;8499.617517211864;8505.277051450696;8545.102764209918;8590;8591.87112193305;6879.277675843964;6985.091938048021;6997.230304666585;7001;7023.578585284899;7594.734184303523;7747.147813740371;7749.147593764794;7749.573773442515;7782.961085194538;7037.331453511908;7286.761250587307;7288.198298187089;7338.816529586589;7400.666969986256;7114.964425177841;7122.252163522963;7184.281571842774;7227.747028853965;7247.710091596277;7335.706571737284;7392;7397.038385009914;7401.111866576045;7413.518121322097;6527.281998980204;6783.89824152648;6785.558938668971;6798.626075565891;6804.183497980274;6713.731450741916;6745.426638735762;6820.113385260083;6830.872905970459;6834.829129271609 13:07:53 INFO - 2015-11-18 13:07:53,138 DEBUG : BROWSER_OUTPUT: |4;prototype.html;338.93899098162336;340.7308226501064;345.94810778383254;349.4897449723403;350.23124242288156;6262.561620686548;6348.36516348365;6395.0407438884195;6400.295967443583;6438;6278.372162783719;6309.274433440156;6318.652474113922;6326.398992095755;6336.714847831847;4790.329353890458;4799.976000119995;4805.879853003668;4809.735464549449;4810.97594512027;4804.639652026094;4811.13399588074;4812.470628230892;4817.90364192716;4823.541763532477;4642.953570464286;4709.270063140219;4748.477667456577;4757.333973243749;4809;4702.8118875244945;4716.716996980158;4735.479097299311;4763.118823017753;4780;4185.142045880587;4194.6853985950875;4198.160367926427;4198.9370159447635;4199.790010499493;5947.732352044169;5950.166976623276;5951.821445356603;5954.106883967396;5998.340182579913;5505.834824955257;5589.496945274904;5605.299337582802;5607.214989901417;5616.63491873031;6661.367170118831;6678.332166783332;6682.164729408824;6696;6696.732130714766;4616.699914505546;4620.283856002325;4632.444106707183;4637.976810115962;4672.742999135046;6793.864122717568;6886.449084073312;6944.756933507303;6956.339147781004;6976.860462790766;4802.303665968415;4809.374781278481;4814.422269327703;4822.734749588736;4830.855074347775;4880.951190488121;4888.926666100011;4889.168841296988;4889.633277504201;4897.069556784199;5619.887602247933;5622.297212848394;5630.97184514083;5636.0982242841765;5639.605227634108;6612.669366531654;6684.863573192569;6721.22705888829;6730.596164230162;6755.459563234929;1680.1263343061785;1708.487453763866;1723.4657256250352;1723.9827601723823;1724.7067998440295;1140.6920131564432;1146.512732088859;1156.259993604094;1157.5543415784985;1168.0830548019933;6412.166418365583;6424.935750642528;6429.38920802523;6430.7106180222;6441.903371449432;6813.454923606099;6832.965835170792;6872.931270687329;6881.8967715484305;6895.827604309832;6342.23893132827;6429.421352078335;6429.903551446732;6431.099646049557;6446.903296450557;3729.1236559408517;3735.290294843971;3735.6451137141926;3757.5490941087246;3759.699224062123;7062.1878483975;7070.575765454089;7080.645967701595;7138;7157.320054594805;6836.863262734718;6982;6983.406410455168;7017.543859649107;7044;6983.89524157138;7001.054857594159;7039.54242974205;7061.364477197077;7138.500304978706;6834.624095674786;6870.690818913261;6877.690503927435;6881.898896176788;6887.793366199022;6615.305392933865;6768.7292508299115;6779.322067793181;6825.419839313714;6828.658567071726;7055.1886533049355;7097.822554435974;7100;7100.857982840417;7106.111736032996;4795.976020119877;4813.95186048135;4821.927671084866;4825.131476334293;4846.588040016497;6755.0615482265375;6855.245922948571;6861.970704394181;6870.20992585859;6871.965640171967;6534.379233972765;6618.768343107968;6643.335666433318;6645.269020407848;6661.1007513985;6653.101831252912;6658.400743933069;6663.466922646274;6678.465722742266;6691.197056353269;6432.967835160982;6495.317991611002;6529.608223506605;6530.281669016499;6558.1802274715665;6615.17310336208;6632.1709786276715;6695.330466953461;6717.059611654275;6719.865602688016;6515.73937042532;6527.412532872065;6528.836779080561;6534.085228067979;6542.640154791532 13:07:53 INFO - 2015-11-18 13:07:53,138 DEBUG : BROWSER_OUTPUT: |5;yui.html;859.2395729779145;859.261035509462;864.1747131489428;866.5190819095408;893.0221407558721;10572.259941804077;10708.732281692952;10722.731931701712;10771.946140269287;10820.350778953258;13512.797308040388;13534.72930541391;13589.456421743143;13611.659708507292;13624.386902589382;798.2297083314601;821.1337039423406;821.3716506872247;821.954792486413;822.2312138150818;818.2717381530442;819.8114433680228;827.759949614614;832.2385017708789;833.4749108061943;859.8538248497771;866.1338661338661;866.4974314897345;868.826234753052;870.6082262981652;854.8418542569644;856.6616186606287;856.7729551668813;860.9698660546882;864.4985908173276;619.1764952613014;621.8569728962364;625.5621065254295;626.0171530696808;626.505061001808;13210.537631182959;13253.602391928258;13282.468701251939;13324.400401981935;13370.799438008438;10123.493825308706;10314.896851031468;10363.740906477324;10577.312474689197;10600.946995264974;9119.772005699844;9829.4102353859;9948.701538953843;10069.949650251776;10070;3198.824064676442;3225.709686128236;3247.431699452586;3285.342931413727;3294.258791771856;40724.38913416301;45160.548394515965;45220;45433.318500222194;45895.31157032647;7040.225575186725;7082.716691332289;7095.219525852152;7117.857642847114;7135.678894449762;11735.823962640567;11776.234544754563;11793.823092653616;11810.645680629596;11846.170768046326;6848.9657551711925;6884.827879303058;6955.547889387275;6990.951357296446;7156.226354983959;4272.188284225987;4289.806958686804;4347.282698354799;4358.433403657505;4392.472903251631;2771.6119743235963;2788.219298596396;2796.4826507096254;2796.832190068562;2804.0606396857283;435.6863058597805;440.12854547995147;444.74427204357625;447.74702293204234;458.5460394209708;619.7805026558464;631.2204427531994;649.746598826458;655.367570294668;709;8735.694250701195;9205.63177472907;9210.95394523023;9462.479563623929;9529.475878826732;609.7865746988518;665.2748504130424;670.4770279182246;678.8336857469852;680.3944489404435;3906;3933.3903244997073;4005.6595189409227;4046.1705350403095;4134.545200027995;58972.41027589755;58973;59078;59328.70335648294;59430.702846486354;53949.73025134849;54335;54359.72820135874;54708.452915470334;56121.71939140278;50426.97438153723;50630;51083.48916510787;51297.23054154116;51882.48117518852;7888.408369372435;7959.072170068856;7982.361411086983;8106.878396823934;8305.750827475185;34976.65023349734;35360.82319588386;35607;36705;38539;44641.55358446374;44868.1026379464;45427.54572454233;47880.52119478761;47924.5207547934;8161.306288965505;8330.250277475056;8401.243888050105;8481.40630155883;8616.698415555426;11937.881430906324;12200.755984880076;12211.084168687206;12455.439505222468;12481.939035182111;10997.175211858983;11291.378974156172;11375.976162145447;11779.05767538612;11809.704757381134;11267.323960562393;11270.718232044264;11343.546258149912;11479.25384849982;11733.061355091742;10034.899651003396;11862.82205766897;11897.107716921439;12276.324802135969;12284.324362160167;9250.768730781785;9255.490947997925;9310.48792316402;9404.576794044422;9423.37115266179;9124.31567632417;9461.950931037994;9588.66439674608;9859.802803943738;9959.452230127412 13:07:53 INFO - 2015-11-18 13:07:53,138 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:07:53 INFO - 2015-11-18 13:07:53,138 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:07:53 INFO - 2015-11-18 13:07:53,138 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,286 13:07:53 INFO - 2015-11-18 13:07:53,138 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:07:53 INFO - 2015-11-18 13:07:53,138 DEBUG : BROWSER_OUTPUT: __startTimestamp1447880873124__endTimestamp 13:07:53 INFO - 2015-11-18 13:07:53,138 DEBUG : BROWSER_OUTPUT: 13:07:53 INFO - 2015-11-18 13:07:53,138 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:07:53 INFO - 2015-11-18 13:07:53,139 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:07:53 INFO - 2015-11-18 13:07:53,139 DEBUG : BROWSER_OUTPUT: 13:07:53 INFO - 2015-11-18 13:07:53,139 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5399.91 Median:5640.66 stddev:605.99 (10.7%) stddev-sans-first:581.26 13:07:53 INFO - 2015-11-18 13:07:53,139 DEBUG : BROWSER_OUTPUT: Values: 3136.8 3240.1 3255.9 3271.4 3278.5 5216.2 5268.6 5321.9 5343.5 5390.8 5315.1 5333.5 5334.5 5387.9 5428.2 4614.9 4902.7 5102.6 5108.7 5111.8 4831.3 5021.2 5074.4 5083.7 5129.4 4780.2 4859.3 4880.4 4905.5 4961.8 4881.6 4887.5 4906.0 4947.4 4949.9 4822.8 4883.1 4892.2 4931.4 4938.4 5137.9 5175.7 5196.3 5224.6 5276.3 5761.9 5789.0 5813.7 5828.4 5831.1 5646.5 5801.0 5806.2 5842.7 5866.5 5390.4 5475.5 5476.3 5494.1 5495.3 5944.8 5973.9 5975.8 5983.0 5987.4 5782.2 5784.3 5785.2 5792.4 5809.7 5674.9 5752.4 5758.0 5844.7 5913.4 5777.7 5779.3 5783.9 5792.8 5795.1 5757.3 5800.6 5808.4 5809.3 5818.3 4337.3 4436.5 4443.2 4513.9 4542.5 3967.8 3971.0 3975.6 4006.8 4019.4 5304.5 5480.2 5481.2 5483.9 5492.0 5752.9 5785.3 5804.3 5863.1 5929.1 5589.5 5604.7 5641.9 5645.3 5654.4 4971.5 5063.3 5139.4 5161.3 5172.5 5842.2 5867.0 5977.9 6012.3 6034.5 5842.6 5865.0 5868.2 5868.3 5911.0 5755.5 5997.8 5999.3 6011.7 6032.0 5640.7 5749.0 5749.5 5754.2 5798.9 5863.9 5906.1 5947.0 5971.7 5988.1 5502.3 5636.6 5772.5 5791.5 5808.7 5664.3 5737.3 5756.0 5764.2 5788.3 5474.3 5486.5 5543.7 5560.4 5584.4 5575.1 5614.3 5642.4 5674.7 5781.1 5629.8 5654.2 5691.3 5704.2 5713.7 13:07:53 INFO - 2015-11-18 13:07:53,139 DEBUG : BROWSER_OUTPUT: 13:07:53 INFO - 2015-11-18 13:07:53,139 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44754.52 Median:20475.49 stddev:69786.40 (340.8%) stddev-sans-first:69903.23 13:07:53 INFO - 2015-11-18 13:07:53,140 DEBUG : BROWSER_OUTPUT: Values: 546.6 577.4 584.2 584.7 588.9 39897.8 40686.2 40843.4 41081.2 41145.6 42917.4 43519.8 43731.8 43733.6 43754.8 8678.2 8836.1 8836.8 8873.1 8884.0 8651.0 8708.9 8717.6 8739.1 8741.7 8716.0 8728.6 8749.4 8762.5 8817.5 8685.3 8699.1 8760.4 8761.5 8776.2 8610.7 8671.5 8748.7 8753.8 8763.4 40068.4 40557.6 40642.8 40650.8 40694.8 3380.0 3459.5 3542.4 3559.8 3648.2 30102.2 30262.4 30327.8 30399.2 31349.0 3586.9 3606.8 3624.2 3674.5 3729.0 256598.0 256730.0 256929.0 257213.0 258115.0 56745.4 57875.4 66187.7 67186.0 67213.3 62015.0 62205.7 62316.6 62591.0 62743.0 15428.8 15594.2 15676.5 15686.9 15791.3 11823.7 11910.1 11911.0 12021.2 12039.9 20048.6 20098.5 20222.2 20340.3 20406.3 7600.2 7736.0 7824.0 7860.9 7871.9 960.6 986.2 1052.0 1098.2 1119.1 28862.6 28904.3 28904.4 29248.7 29268.9 1076.7 1086.4 1090.7 1114.7 1216.1 15011.5 15048.8 15056.2 15193.7 15323.5 314887.0 319360.0 319710.0 319774.0 319971.0 53144.5 53464.7 53549.5 53820.7 53830.0 1320.8 1345.7 1350.3 1373.0 1397.7 27003.3 28043.3 28218.3 28615.3 29716.9 45721.0 45830.8 46033.5 46098.3 46114.0 215488.0 217366.0 217492.0 217612.0 218157.7 29475.6 31712.7 32185.7 32185.8 32228.0 43775.3 44689.6 45043.8 45367.0 46021.0 36979.3 37510.6 38109.6 38488.0 38535.2 37022.6 37222.0 37900.2 38210.4 38422.4 36535.5 37183.8 37402.4 37462.3 37625.2 32722.3 33611.5 34445.8 34494.8 39192.4 28698.4 30318.5 30584.2 31312.8 31418.0 13:07:53 INFO - 2015-11-18 13:07:53,140 DEBUG : BROWSER_OUTPUT: 13:07:53 INFO - 2015-11-18 13:07:53,140 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26541.71 Median:4482.88 stddev:85707.94 (1911.9%) stddev-sans-first:85925.80 13:07:53 INFO - 2015-11-18 13:07:53,142 DEBUG : BROWSER_OUTPUT: Values: 345.7 350.1 355.1 356.1 357.2 12374.5 12759.2 16308.8 16999.7 18044.5 11471.7 11537.4 11689.9 11727.4 11797.6 4530.0 4681.2 4682.0 4684.6 4700.9 4573.0 4692.1 4695.5 4695.8 4697.5 4651.2 4656.9 4660.3 4801.1 4808.5 4765.1 4780.5 4785.5 4794.8 4801.4 4435.4 4458.5 4461.8 4482.2 4483.6 13587.3 13638.7 13853.2 13905.3 13949.2 2055.5 2147.8 2155.9 2175.3 2201.8 9553.9 9777.8 9991.7 10161.4 10201.0 1721.1 1735.5 1751.0 1756.9 1803.7 55485.4 56009.4 56934.7 59515.0 60356.4 6876.3 6911.6 7006.8 7043.0 7112.0 8489.4 8569.3 8580.7 8589.0 8606.9 5701.5 5728.6 5771.8 5782.5 5786.8 5922.5 5936.5 5936.9 5964.2 5988.0 3367.4 3395.5 3402.5 3410.4 3415.6 1134.3 1138.5 1149.9 1174.4 1228.1 411.1 418.1 422.3 441.6 441.8 10244.1 10747.2 10897.9 10971.4 11110.8 439.4 446.1 449.0 454.6 466.5 5837.1 5967.5 6015.4 6108.7 6128.6 515298.0 516572.0 522387.0 529594.0 529644.0 74751.3 75931.2 76604.6 78465.6 78979.2 506.2 510.6 511.0 513.0 513.3 10601.6 10634.9 10673.6 10697.6 10740.8 36079.8 36417.1 36621.0 37283.0 37305.8 48302.3 48598.0 49261.8 50977.9 51061.0 8111.5 8405.6 8538.2 8628.0 8681.6 12096.1 12135.5 12138.8 12210.1 12358.9 9337.2 9504.9 10671.7 10912.8 10932.5 10710.8 10746.1 10878.5 11005.2 11153.2 10920.1 11003.8 11243.2 11267.7 11309.7 8495.7 8501.7 8735.4 8741.7 8746.1 11008.6 11196.0 11310.3 11373.1 11560.2 13:07:53 INFO - 2015-11-18 13:07:53,142 DEBUG : BROWSER_OUTPUT: 13:07:53 INFO - 2015-11-18 13:07:53,142 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5520.62 Median:6620.51 stddev:2807.91 (42.4%) stddev-sans-first:2799.39 13:07:53 INFO - 2015-11-18 13:07:53,142 DEBUG : BROWSER_OUTPUT: Values: 1484.4 1543.0 1590.1 1690.4 1792.1 7567.0 7703.3 7802.7 7859.8 7900.8 7946.9 7961.1 8038.0 8047.0 8047.8 2327.7 2363.8 2371.5 2371.7 2375.8 2253.5 2301.1 2373.7 2374.9 2377.0 2280.6 2309.0 2325.5 2333.8 2364.3 2297.6 2304.5 2315.0 2348.7 2355.0 2306.9 2409.9 2410.7 2410.7 2414.3 7658.0 7674.2 7686.0 7689.9 7749.2 4672.8 4748.9 4770.9 4785.0 4786.4 3172.9 3193.5 3219.2 3227.2 3277.9 1043.8 1044.2 1045.6 1058.6 1074.6 10699.8 10725.8 10760.5 10809.2 10847.3 4255.8 4304.6 4367.0 4400.1 4424.6 8852.5 8865.1 8867.4 8881.1 8886.6 4673.4 4697.3 4702.4 4713.3 4714.9 4267.3 4276.4 4291.4 4294.8 4313.9 3544.8 3584.8 3595.8 3612.3 3621.7 1114.3 1126.4 1131.3 1142.2 1146.8 1061.0 1074.9 1078.2 1257.8 1380.7 7386.2 7414.0 7473.5 7488.3 7588.3 1044.6 1074.0 1138.3 1144.9 1162.3 5809.9 5871.7 5916.7 5921.3 5936.6 8851.3 8857.7 9156.2 9222.5 9258.0 8973.6 9005.7 9006.5 9016.5 9084.5 7060.6 7120.1 7225.9 7292.9 7318.6 7317.6 7360.1 7406.2 7457.7 7469.3 8058.4 8170.7 8283.8 8301.5 8396.1 8499.6 8505.3 8545.1 8590.0 8591.9 6879.3 6985.1 6997.2 7001.0 7023.6 7594.7 7747.1 7749.1 7749.6 7783.0 7037.3 7286.8 7288.2 7338.8 7400.7 7115.0 7122.3 7184.3 7227.7 7247.7 7335.7 7392.0 7397.0 7401.1 7413.5 6527.3 6783.9 6785.6 6798.6 6804.2 6713.7 6745.4 6820.1 6830.9 6834.8 13:07:53 INFO - 2015-11-18 13:07:53,142 DEBUG : BROWSER_OUTPUT: 13:07:53 INFO - 2015-11-18 13:07:53,142 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5581.98 Median:6418.55 stddev:1668.18 (26.0%) stddev-sans-first:1625.78 13:07:53 INFO - 2015-11-18 13:07:53,144 DEBUG : BROWSER_OUTPUT: Values: 338.9 340.7 345.9 349.5 350.2 6262.6 6348.4 6395.0 6400.3 6438.0 6278.4 6309.3 6318.7 6326.4 6336.7 4790.3 4800.0 4805.9 4809.7 4811.0 4804.6 4811.1 4812.5 4817.9 4823.5 4643.0 4709.3 4748.5 4757.3 4809.0 4702.8 4716.7 4735.5 4763.1 4780.0 4185.1 4194.7 4198.2 4198.9 4199.8 5947.7 5950.2 5951.8 5954.1 5998.3 5505.8 5589.5 5605.3 5607.2 5616.6 6661.4 6678.3 6682.2 6696.0 6696.7 4616.7 4620.3 4632.4 4638.0 4672.7 6793.9 6886.4 6944.8 6956.3 6976.9 4802.3 4809.4 4814.4 4822.7 4830.9 4881.0 4888.9 4889.2 4889.6 4897.1 5619.9 5622.3 5631.0 5636.1 5639.6 6612.7 6684.9 6721.2 6730.6 6755.5 1680.1 1708.5 1723.5 1724.0 1724.7 1140.7 1146.5 1156.3 1157.6 1168.1 6412.2 6424.9 6429.4 6430.7 6441.9 6813.5 6833.0 6872.9 6881.9 6895.8 6342.2 6429.4 6429.9 6431.1 6446.9 3729.1 3735.3 3735.6 3757.5 3759.7 7062.2 7070.6 7080.6 7138.0 7157.3 6836.9 6982.0 6983.4 7017.5 7044.0 6983.9 7001.1 7039.5 7061.4 7138.5 6834.6 6870.7 6877.7 6881.9 6887.8 6615.3 6768.7 6779.3 6825.4 6828.7 7055.2 7097.8 7100.0 7100.9 7106.1 4796.0 4814.0 4821.9 4825.1 4846.6 6755.1 6855.2 6862.0 6870.2 6872.0 6534.4 6618.8 6643.3 6645.3 6661.1 6653.1 6658.4 6663.5 6678.5 6691.2 6433.0 6495.3 6529.6 6530.3 6558.2 6615.2 6632.2 6695.3 6717.1 6719.9 6515.7 6527.4 6528.8 6534.1 6542.6 13:07:53 INFO - 2015-11-18 13:07:53,144 DEBUG : BROWSER_OUTPUT: 13:07:53 INFO - 2015-11-18 13:07:53,144 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13550.80 Median:51589.86 stddev:16581.71 (32.1%) stddev-sans-first:16600.83 13:07:53 INFO - 2015-11-18 13:07:53,145 DEBUG : BROWSER_OUTPUT: Values: 859.2 859.3 864.2 866.5 893.0 10572.3 10708.7 10722.7 10771.9 10820.4 13512.8 13534.7 13589.5 13611.7 13624.4 798.2 821.1 821.4 822.0 822.2 818.3 819.8 827.8 832.2 833.5 859.9 866.1 866.5 868.8 870.6 854.8 856.7 856.8 861.0 864.5 619.2 621.9 625.6 626.0 626.5 13210.5 13253.6 13282.5 13324.4 13370.8 10123.5 10314.9 10363.7 10577.3 10600.9 9119.8 9829.4 9948.7 10069.9 10070.0 3198.8 3225.7 3247.4 3285.3 3294.3 40724.4 45160.5 45220.0 45433.3 45895.3 7040.2 7082.7 7095.2 7117.9 7135.7 11735.8 11776.2 11793.8 11810.6 11846.2 6849.0 6884.8 6955.5 6991.0 7156.2 4272.2 4289.8 4347.3 4358.4 4392.5 2771.6 2788.2 2796.5 2796.8 2804.1 435.7 440.1 444.7 447.7 458.5 619.8 631.2 649.7 655.4 709.0 8735.7 9205.6 9211.0 9462.5 9529.5 609.8 665.3 670.5 678.8 680.4 3906.0 3933.4 4005.7 4046.2 4134.5 58972.4 58973.0 59078.0 59328.7 59430.7 53949.7 54335.0 54359.7 54708.5 56121.7 50427.0 50630.0 51083.5 51297.2 51882.5 7888.4 7959.1 7982.4 8106.9 8305.8 34976.7 35360.8 35607.0 36705.0 38539.0 44641.6 44868.1 45427.5 47880.5 47924.5 8161.3 8330.3 8401.2 8481.4 8616.7 11937.9 12200.8 12211.1 12455.4 12481.9 10997.2 11291.4 11376.0 11779.1 11809.7 11267.3 11270.7 11343.5 11479.3 11733.1 10034.9 11862.8 11897.1 12276.3 12284.3 9250.8 9255.5 9310.5 9404.6 9423.4 9124.3 9462.0 9588.7 9859.8 9959.5 13:07:53 INFO - 2015-11-18 13:07:53,145 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:07:53 INFO - 2015-11-18 13:07:53,146 DEBUG : BROWSER_OUTPUT: 13:07:53 INFO - 2015-11-18 13:07:53,793 INFO : Browser exited with error code: 0 13:07:53 INFO - 2015-11-18 13:07:53,814 INFO : Completed test dromaeo_css (00:18:29) 13:07:53 INFO - 2015-11-18 13:07:53,815 INFO : Starting test kraken 13:07:53 INFO - 2015-11-18 13:07:53,815 DEBUG : operating with platform_type : linux_ 13:07:53 INFO - 2015-11-18 13:07:53,815 INFO : Initialising browser for kraken test... 13:07:53 INFO - 2015-11-18 13:07:53,821 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBATnwJ/profile http://localhost:46743/getInfo.html 13:07:58 INFO - 2015-11-18 13:07:58,460 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:07:58 INFO - 2015-11-18 13:07:58,460 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:07:58 INFO - 2015-11-18 13:07:58,460 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:07:58 INFO - 2015-11-18 13:07:58,460 DEBUG : BROWSER_OUTPUT: __metrics 13:07:59 INFO - 2015-11-18 13:07:59,545 INFO : Browser initialized. 13:07:59 INFO - 2015-11-18 13:07:59,546 INFO : Running cycle 1/1 for kraken test... 13:07:59 INFO - 2015-11-18 13:07:59,546 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBATnwJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:08:11 INFO - 2015-11-18 13:08:11,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 141942784 13:08:11 INFO - 2015-11-18 13:08:11,326 DEBUG : BROWSER_OUTPUT: 13:08:13 INFO - 2015-11-18 13:08:13,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46743/tests/kraken/driver.html?testName=audio-beat-detection) 13:08:14 INFO - 2015-11-18 13:08:14,422 DEBUG : BROWSER_OUTPUT: RSS: Main: 142163968 13:08:14 INFO - 2015-11-18 13:08:14,423 DEBUG : BROWSER_OUTPUT: 13:08:17 INFO - 2015-11-18 13:08:17,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46743/tests/kraken/driver.html?testName=audio-dft) 13:08:17 INFO - 2015-11-18 13:08:17,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 141680640 13:08:17 INFO - 2015-11-18 13:08:17,681 DEBUG : BROWSER_OUTPUT: 13:08:20 INFO - 2015-11-18 13:08:20,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46743/tests/kraken/driver.html?testName=audio-fft) 13:08:21 INFO - 2015-11-18 13:08:21,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 136884224 13:08:21 INFO - 2015-11-18 13:08:21,128 DEBUG : BROWSER_OUTPUT: 13:08:23 INFO - 2015-11-18 13:08:23,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46743/tests/kraken/driver.html?testName=audio-oscillator) 13:08:23 INFO - 2015-11-18 13:08:23,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 136945664 13:08:23 INFO - 2015-11-18 13:08:23,927 DEBUG : BROWSER_OUTPUT: 13:08:26 INFO - 2015-11-18 13:08:26,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46743/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:08:26 INFO - 2015-11-18 13:08:26,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 137146368 13:08:26 INFO - 2015-11-18 13:08:26,702 DEBUG : BROWSER_OUTPUT: 13:08:29 INFO - 2015-11-18 13:08:29,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46743/tests/kraken/driver.html?testName=imaging-darkroom) 13:08:30 INFO - 2015-11-18 13:08:30,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 138571776 13:08:30 INFO - 2015-11-18 13:08:30,295 DEBUG : BROWSER_OUTPUT: 13:08:33 INFO - 2015-11-18 13:08:33,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46743/tests/kraken/driver.html?testName=imaging-desaturate) 13:08:34 INFO - 2015-11-18 13:08:34,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 138752000 13:08:34 INFO - 2015-11-18 13:08:34,333 DEBUG : BROWSER_OUTPUT: 13:08:37 INFO - 2015-11-18 13:08:37,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46743/tests/kraken/driver.html?testName=json-parse-financial) 13:08:37 INFO - 2015-11-18 13:08:37,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 138989568 13:08:37 INFO - 2015-11-18 13:08:37,742 DEBUG : BROWSER_OUTPUT: 13:08:39 INFO - 2015-11-18 13:08:39,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46743/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:08:39 INFO - 2015-11-18 13:08:39,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 139333632 13:08:39 INFO - 2015-11-18 13:08:39,922 DEBUG : BROWSER_OUTPUT: 13:08:41 INFO - 2015-11-18 13:08:41,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46743/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:08:42 INFO - 2015-11-18 13:08:42,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 138629120 13:08:42 INFO - 2015-11-18 13:08:42,361 DEBUG : BROWSER_OUTPUT: 13:08:44 INFO - 2015-11-18 13:08:44,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46743/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:08:45 INFO - 2015-11-18 13:08:45,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 140496896 13:08:45 INFO - 2015-11-18 13:08:45,058 DEBUG : BROWSER_OUTPUT: 13:08:47 INFO - 2015-11-18 13:08:47,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:08:48 INFO - 2015-11-18 13:08:48,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 139489280 13:08:48 INFO - 2015-11-18 13:08:48,113 DEBUG : BROWSER_OUTPUT: 13:08:50 INFO - 2015-11-18 13:08:50,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:08:51 INFO - 2015-11-18 13:08:51,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 140566528 13:08:51 INFO - 2015-11-18 13:08:51,327 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46743/tests/kraken/driver.html?testName=ai-astar) 13:08:53 INFO - 2015-11-18 13:08:53,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 140705792 13:08:53 INFO - 2015-11-18 13:08:53,279 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,280 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:08:53 INFO - 2015-11-18 13:08:53,281 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:08:53 INFO - 2015-11-18 13:08:53,281 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:08:53 INFO - 2015-11-18 13:08:53,281 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:08:53 INFO - 2015-11-18 13:08:53,281 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;109;111;111;112;122;111;111;112;110 13:08:53 INFO - 2015-11-18 13:08:53,281 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;168;125;151;169;132;159;159;130;159;124 13:08:53 INFO - 2015-11-18 13:08:53,281 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;166;160;162;163;161;162;163;172;164 13:08:53 INFO - 2015-11-18 13:08:53,281 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;73;71;73;73;71;149;71;72 13:08:53 INFO - 2015-11-18 13:08:53,281 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;134;91;90;90;136;90;90;144 13:08:53 INFO - 2015-11-18 13:08:53,281 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;109;109;109;110;110;109 13:08:53 INFO - 2015-11-18 13:08:53,281 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;149;147;148;146;147;146;149;146 13:08:53 INFO - 2015-11-18 13:08:53,282 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;96;97;99;97;96;96;96;96 13:08:53 INFO - 2015-11-18 13:08:53,282 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;65;65;61;63;63;64;63;67;60 13:08:53 INFO - 2015-11-18 13:08:53,282 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;72;70;69;70;71;69;68;71;71 13:08:53 INFO - 2015-11-18 13:08:53,282 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;93;87;88;86;86;85;85;93;85 13:08:53 INFO - 2015-11-18 13:08:53,282 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;120;133;126;119;128;119;118;125;118 13:08:53 INFO - 2015-11-18 13:08:53,282 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;157;154;150;157;141;150;151;152;154 13:08:53 INFO - 2015-11-18 13:08:53,282 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;71;69;73;69;70;71;73;73;70 13:08:53 INFO - 2015-11-18 13:08:53,282 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:08:53 INFO - 2015-11-18 13:08:53,282 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:08:53 INFO - 2015-11-18 13:08:53,282 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,725 13:08:53 INFO - 2015-11-18 13:08:53,282 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:08:53 INFO - 2015-11-18 13:08:53,282 DEBUG : BROWSER_OUTPUT: __startTimestamp1447880933279__endTimestamp 13:08:53 INFO - 2015-11-18 13:08:53,282 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,286 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:08:53 INFO - 2015-11-18 13:08:53,286 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:08:53 INFO - 2015-11-18 13:08:53,286 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,286 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:3.60 (3.2%) stddev-sans-first:3.82 13:08:53 INFO - 2015-11-18 13:08:53,286 DEBUG : BROWSER_OUTPUT: Values: 112.0 109.0 111.0 111.0 112.0 122.0 111.0 111.0 112.0 110.0 13:08:53 INFO - 2015-11-18 13:08:53,286 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,286 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.60 Median:159.00 stddev:17.94 (11.3%) stddev-sans-first:17.44 13:08:53 INFO - 2015-11-18 13:08:53,286 DEBUG : BROWSER_OUTPUT: Values: 168.0 125.0 151.0 169.0 132.0 159.0 159.0 130.0 159.0 124.0 13:08:53 INFO - 2015-11-18 13:08:53,287 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,287 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:3.37 (2.1%) stddev-sans-first:3.57 13:08:53 INFO - 2015-11-18 13:08:53,287 DEBUG : BROWSER_OUTPUT: Values: 164.0 166.0 160.0 162.0 163.0 161.0 162.0 163.0 172.0 164.0 13:08:53 INFO - 2015-11-18 13:08:53,287 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,287 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:72.50 stddev:24.33 (33.6%) stddev-sans-first:25.64 13:08:53 INFO - 2015-11-18 13:08:53,287 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 73.0 71.0 73.0 73.0 71.0 149.0 71.0 72.0 13:08:53 INFO - 2015-11-18 13:08:53,287 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,287 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.70 Median:90.00 stddev:23.12 (25.7%) stddev-sans-first:23.98 13:08:53 INFO - 2015-11-18 13:08:53,287 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 134.0 91.0 90.0 90.0 136.0 90.0 90.0 144.0 13:08:53 INFO - 2015-11-18 13:08:53,287 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,287 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:08:53 INFO - 2015-11-18 13:08:53,287 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 13:08:53 INFO - 2015-11-18 13:08:53,287 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,288 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 13:08:53 INFO - 2015-11-18 13:08:53,288 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 149.0 147.0 148.0 146.0 147.0 146.0 149.0 146.0 13:08:53 INFO - 2015-11-18 13:08:53,288 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,288 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.50 stddev:1.06 (1.1%) stddev-sans-first:1.09 13:08:53 INFO - 2015-11-18 13:08:53,288 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 96.0 97.0 99.0 97.0 96.0 96.0 96.0 96.0 13:08:53 INFO - 2015-11-18 13:08:53,288 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,288 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.50 stddev:2.47 (3.8%) stddev-sans-first:2.13 13:08:53 INFO - 2015-11-18 13:08:53,288 DEBUG : BROWSER_OUTPUT: Values: 68.0 65.0 65.0 61.0 63.0 63.0 64.0 63.0 67.0 60.0 13:08:53 INFO - 2015-11-18 13:08:53,288 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,288 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.50 stddev:1.25 (1.8%) stddev-sans-first:1.27 13:08:53 INFO - 2015-11-18 13:08:53,289 DEBUG : BROWSER_OUTPUT: Values: 69.0 72.0 70.0 69.0 70.0 71.0 69.0 68.0 71.0 71.0 13:08:53 INFO - 2015-11-18 13:08:53,289 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,289 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:86.50 stddev:3.26 (3.8%) stddev-sans-first:3.24 13:08:53 INFO - 2015-11-18 13:08:53,289 DEBUG : BROWSER_OUTPUT: Values: 84.0 93.0 87.0 88.0 86.0 86.0 85.0 85.0 93.0 85.0 13:08:53 INFO - 2015-11-18 13:08:53,289 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,289 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:124.00 stddev:5.04 (4.1%) stddev-sans-first:5.35 13:08:53 INFO - 2015-11-18 13:08:53,289 DEBUG : BROWSER_OUTPUT: Values: 123.0 120.0 133.0 126.0 119.0 128.0 119.0 118.0 125.0 118.0 13:08:53 INFO - 2015-11-18 13:08:53,289 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,290 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:153.00 stddev:5.19 (3.4%) stddev-sans-first:4.84 13:08:53 INFO - 2015-11-18 13:08:53,290 DEBUG : BROWSER_OUTPUT: Values: 144.0 157.0 154.0 150.0 157.0 141.0 150.0 151.0 152.0 154.0 13:08:53 INFO - 2015-11-18 13:08:53,290 DEBUG : BROWSER_OUTPUT: 13:08:53 INFO - 2015-11-18 13:08:53,290 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:2.01 (2.8%) stddev-sans-first:1.66 13:08:53 INFO - 2015-11-18 13:08:53,290 DEBUG : BROWSER_OUTPUT: Values: 67.0 71.0 69.0 73.0 69.0 70.0 71.0 73.0 73.0 70.0 13:08:53 INFO - 2015-11-18 13:08:53,290 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:08:53 INFO - 2015-11-18 13:08:53,290 DEBUG : BROWSER_OUTPUT: 13:08:54 INFO - 2015-11-18 13:08:54,153 INFO : Browser exited with error code: 0 13:08:54 INFO - 2015-11-18 13:08:54,209 INFO : Completed test kraken (00:01:00) 13:08:54 INFO - 2015-11-18 13:08:54,209 INFO : Starting test v8_7 13:08:54 INFO - 2015-11-18 13:08:54,209 DEBUG : operating with platform_type : linux_ 13:08:54 INFO - 2015-11-18 13:08:54,209 INFO : Initialising browser for v8_7 test... 13:08:54 INFO - 2015-11-18 13:08:54,215 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxWF01z/profile http://localhost:46743/getInfo.html 13:08:58 INFO - 2015-11-18 13:08:58,941 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:08:58 INFO - 2015-11-18 13:08:58,941 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:08:58 INFO - 2015-11-18 13:08:58,941 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:08:58 INFO - 2015-11-18 13:08:58,941 DEBUG : BROWSER_OUTPUT: __metrics 13:09:00 INFO - 2015-11-18 13:09:00,077 INFO : Browser initialized. 13:09:00 INFO - 2015-11-18 13:09:00,078 INFO : Running cycle 1/1 for v8_7 test... 13:09:00 INFO - 2015-11-18 13:09:00,078 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxWF01z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:09:11 INFO - 2015-11-18 13:09:11,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 142090240 13:09:11 INFO - 2015-11-18 13:09:11,870 DEBUG : BROWSER_OUTPUT: 13:09:33 INFO - 2015-11-18 13:09:33,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46743/tests/v8_7/run.html (next: http://localhost:46743/tests/v8_7/run.html) 13:09:33 INFO - 2015-11-18 13:09:33,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 138878976 13:09:33 INFO - 2015-11-18 13:09:33,488 DEBUG : BROWSER_OUTPUT: 13:09:33 INFO - 2015-11-18 13:09:33,489 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:09:33 INFO - 2015-11-18 13:09:33,489 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:09:33 INFO - 2015-11-18 13:09:33,489 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:09:33 INFO - 2015-11-18 13:09:33,489 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:09:33 INFO - 2015-11-18 13:09:33,489 DEBUG : BROWSER_OUTPUT: |0;Richards;165.78249336870027 13:09:33 INFO - 2015-11-18 13:09:33,489 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.32568985619898 13:09:33 INFO - 2015-11-18 13:09:33,490 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.5270768358378 13:09:33 INFO - 2015-11-18 13:09:33,490 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5065.656565656565 13:09:33 INFO - 2015-11-18 13:09:33,490 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1059.2592592592594 13:09:33 INFO - 2015-11-18 13:09:33,490 DEBUG : BROWSER_OUTPUT: |5;Earley;708.2152974504249 13:09:33 INFO - 2015-11-18 13:09:33,490 DEBUG : BROWSER_OUTPUT: |6;Boyer;12204.819277108434 13:09:33 INFO - 2015-11-18 13:09:33,490 DEBUG : BROWSER_OUTPUT: |7;RegExp;25575 13:09:33 INFO - 2015-11-18 13:09:33,490 DEBUG : BROWSER_OUTPUT: |8;Splay;635.2121595946802 13:09:33 INFO - 2015-11-18 13:09:33,490 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 13:09:33 INFO - 2015-11-18 13:09:33,490 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:09:33 INFO - 2015-11-18 13:09:33,491 DEBUG : BROWSER_OUTPUT: __startTimestamp1447880973488__endTimestamp 13:09:33 INFO - 2015-11-18 13:09:33,491 DEBUG : BROWSER_OUTPUT: 13:09:33 INFO - 2015-11-18 13:09:33,491 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:09:33 INFO - 2015-11-18 13:09:33,491 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:09:33 INFO - 2015-11-18 13:09:33,491 DEBUG : BROWSER_OUTPUT: 13:09:33 INFO - 2015-11-18 13:09:33,491 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.78 Median:165.78 stddev:0.00 (0.0%) 13:09:33 INFO - 2015-11-18 13:09:33,491 DEBUG : BROWSER_OUTPUT: Values: 165.8 13:09:33 INFO - 2015-11-18 13:09:33,491 DEBUG : BROWSER_OUTPUT: 13:09:33 INFO - 2015-11-18 13:09:33,491 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.33 Median:194.33 stddev:0.00 (0.0%) 13:09:33 INFO - 2015-11-18 13:09:33,492 DEBUG : BROWSER_OUTPUT: Values: 194.3 13:09:33 INFO - 2015-11-18 13:09:33,492 DEBUG : BROWSER_OUTPUT: 13:09:33 INFO - 2015-11-18 13:09:33,492 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.53 Median:283.53 stddev:0.00 (0.0%) 13:09:33 INFO - 2015-11-18 13:09:33,492 DEBUG : BROWSER_OUTPUT: Values: 283.5 13:09:33 INFO - 2015-11-18 13:09:33,492 DEBUG : BROWSER_OUTPUT: 13:09:33 INFO - 2015-11-18 13:09:33,492 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5065.66 Median:5065.66 stddev:0.00 (0.0%) 13:09:33 INFO - 2015-11-18 13:09:33,492 DEBUG : BROWSER_OUTPUT: Values: 5065.7 13:09:33 INFO - 2015-11-18 13:09:33,492 DEBUG : BROWSER_OUTPUT: 13:09:33 INFO - 2015-11-18 13:09:33,493 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1059.26 Median:1059.26 stddev:0.00 (0.0%) 13:09:33 INFO - 2015-11-18 13:09:33,493 DEBUG : BROWSER_OUTPUT: Values: 1059.3 13:09:33 INFO - 2015-11-18 13:09:33,493 DEBUG : BROWSER_OUTPUT: 13:09:33 INFO - 2015-11-18 13:09:33,493 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:708.22 Median:708.22 stddev:0.00 (0.0%) 13:09:33 INFO - 2015-11-18 13:09:33,493 DEBUG : BROWSER_OUTPUT: Values: 708.2 13:09:33 INFO - 2015-11-18 13:09:33,493 DEBUG : BROWSER_OUTPUT: 13:09:33 INFO - 2015-11-18 13:09:33,494 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12204.82 Median:12204.82 stddev:0.00 (0.0%) 13:09:33 INFO - 2015-11-18 13:09:33,494 DEBUG : BROWSER_OUTPUT: Values: 12204.8 13:09:33 INFO - 2015-11-18 13:09:33,494 DEBUG : BROWSER_OUTPUT: 13:09:33 INFO - 2015-11-18 13:09:33,494 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25575.00 Median:25575.00 stddev:0.00 (0.0%) 13:09:33 INFO - 2015-11-18 13:09:33,495 DEBUG : BROWSER_OUTPUT: Values: 25575.0 13:09:33 INFO - 2015-11-18 13:09:33,495 DEBUG : BROWSER_OUTPUT: 13:09:33 INFO - 2015-11-18 13:09:33,495 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:635.21 Median:635.21 stddev:0.00 (0.0%) 13:09:33 INFO - 2015-11-18 13:09:33,495 DEBUG : BROWSER_OUTPUT: Values: 635.2 13:09:33 INFO - 2015-11-18 13:09:33,496 DEBUG : BROWSER_OUTPUT: 13:09:33 INFO - 2015-11-18 13:09:33,497 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 13:09:33 INFO - 2015-11-18 13:09:33,497 DEBUG : BROWSER_OUTPUT: Values: 4850.2 13:09:33 INFO - 2015-11-18 13:09:33,497 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:09:33 INFO - 2015-11-18 13:09:33,497 DEBUG : BROWSER_OUTPUT: 13:09:34 INFO - 2015-11-18 13:09:34,357 INFO : Browser exited with error code: 0 13:09:34 INFO - 2015-11-18 13:09:34,372 INFO : Completed test v8_7 (00:00:40) 13:09:34 INFO - 2015-11-18 13:09:34,541 INFO : Completed test suite (00:20:10) 13:09:34 INFO - 2015-11-18 13:09:34,541 DEBUG : Working with test: dromaeo_css 13:09:34 INFO - 2015-11-18 13:09:34,541 DEBUG : Generating results file: dromaeo_css 13:09:34 INFO - 2015-11-18 13:09:34,542 DEBUG : Working with test: kraken 13:09:34 INFO - 2015-11-18 13:09:34,542 DEBUG : Generating results file: kraken 13:09:34 INFO - 2015-11-18 13:09:34,542 INFO : javascript benchmark 13:09:34 INFO - 2015-11-18 13:09:34,543 DEBUG : Working with test: v8_7 13:09:34 INFO - 2015-11-18 13:09:34,543 DEBUG : Generating results file: v8_7 13:09:34 INFO - 2015-11-18 13:09:34,543 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:09:34 INFO - 2015-11-18 13:09:34,605 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 13:09:34 INFO - 2015-11-18 13:09:34,605 DEBUG : process_Request line: dromaeo_css 6774.95 graph.html#tests=[[72,64,43]] 13:09:34 INFO - 2015-11-18 13:09:34,605 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:09:34 INFO - 2015-11-18 13:09:34,635 DEBUG : process_Request line: kraken 1526.70 graph.html#tests=[[232,64,43]] 13:09:34 INFO - 2015-11-18 13:09:34,635 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:09:34 INFO - 2015-11-18 13:09:34,667 DEBUG : process_Request line: v8_7 21238.04 graph.html#tests=[[230,64,43]] 13:09:34 INFO - 2015-11-18 13:09:34,668 INFO : javascript benchmark 13:09:34 INFO - 2015-11-18 13:09:34,672 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3136.7647426443014, 3240.092774023273, 3255.9348813023726, 3271.362084393544, 3278.4590542560477, 5216.165413533835, 5268.578513718908, 5321.92017119743, 5343.492368225013, 5390.757415916283, 5315.096433606286, 5333.546648534879, 5334.51989320961, 5387.919181212285, 5428.212909128184, 4614.907701845961, 4902.705837649743, 5102.617303702219, 5108.667936584129, 5111.821086261982, 4831.251156070814, 5021.246812978065, 5074.416442109168, 5083.720395378253, 5129.410117836459, 4780.16347139251, 4859.319695242669, 4880.365552478191, 4905.509449055102, 4961.801527938878, 4881.6338774591695, 4887.535684110004, 4905.975470122662, 4947.406311242638, 4949.861531847695, 4822.758862056919, 4883.096627123993, 4892.192788189945, 4931.358923339979, 4938.3580134582635, 5137.871553211162, 5175.715335656538, 5196.272521846944, 5224.608154388436, 5276.34045744282, 5761.942380576183, 5789.0, 5813.651180929115, 5828.358880523139, 5831.125331200354, 5646.463585959327, 5801.042827933428, 5806.187133801272, 5842.707864606753, 5866.530677545828, 5390.380106287827, 5475.4524547545325, 5476.342838859362, 5494.120940649477, 5495.258140151029, 5944.762209511658, 5973.910391344133, 5975.820725378246, 5983.0, 5987.43119403656, 5782.219400380979, 5784.334801497797, 5785.247917770663, 5792.420757924174, 5809.738561764731, 5674.886502269931, 5752.424757524214, 5758.049921762946, 5844.678542680108, 5913.408659134138, 5777.682227477445, 5779.306483222041, 5783.884322313615, 5792.797252096157, 5795.130730390475, 5757.251557297608, 5800.56495762811, 5808.3901190375245, 5809.331926828384, 5818.33089194748, 4337.262665346899, 4436.534163912807, 4443.2224360736745, 4513.887152821206, 4542.500324964251, 3967.8412863485137, 3971.0, 3975.6421922027157, 4006.7996600169877, 4019.3970904363996, 5304.469553044742, 5480.150576660624, 5481.177823326533, 5483.890322193533, 5491.972540137273, 5752.9424705753245, 5785.334686511105, 5804.332501762267, 5863.149843272701, 5929.110633405024, 5589.496945274945, 5604.6917419542315, 5641.9435805641415, 5645.294338207724, 5654.434556544395, 4971.502849715, 5063.3417655704525, 5139.408967968731, 5161.27742116104, 5172.508611681884, 5842.211301474246, 5866.97327967604, 5977.910331345033, 6012.338642749294, 6034.5172386209, 5842.591018628656, 5865.032269675627, 5868.178455016387, 5868.295804503487, 5911.0, 5755.510781583613, 5997.820065398045, 5999.280086389486, 6011.699415029144, 6032.034874420072, 5640.661560306395, 5748.965186266512, 5749.482546570829, 5754.165645981393, 5798.913016304675, 5863.853403664943, 5906.084556893688, 5946.970265148647, 5971.701414929149, 5988.101784732325, 5502.257195278587, 5636.605437619327, 5772.480476757112, 5791.536677065909, 5808.680522571299, 5664.348599910898, 5737.254156959569, 5755.971220143872, 5764.221830053057, 5788.305403351456, 5474.315710536183, 5486.478784515464, 5543.667379957215, 5560.36055853582, 5584.357798853184, 5575.135853942646, 5614.2701448811395, 5642.435756424489, 5674.687892165805, 5781.103928891029, 5629.7748090077575, 5654.15187721845, 5691.26013618227, 5704.172894930295, 5713.657180569179], "unit": "ms", "name": "dojo.html", "value": 5360.302171856036}, {"lowerIsBetter": false, "replicates": [546.5857048250646, 577.3677822784051, 584.2229834320352, 584.7105682687069, 588.9352171261157, 39897.80051099744, 40686.18627627446, 40843.38734918975, 41081.17837643253, 41145.58854411459, 42917.35623965643, 43519.78240108803, 43731.78134109333, 43733.56266437335, 43754.7812260939, 8678.218960293572, 8836.0722124177, 8836.823263534758, 8873.068327825582, 8883.955580222122, 8651.04838467768, 8708.912910870906, 8717.607707653171, 8739.126087391242, 8741.694040708577, 8716.0, 8728.563571821414, 8749.387542872002, 8762.518061506615, 8817.470951742884, 8685.348598855047, 8699.086595907433, 8760.386772925898, 8761.51811650359, 8776.210141087333, 8610.698625548075, 8671.479711217284, 8748.737537873874, 8753.7811554711, 8763.430377025474, 40068.398974015414, 40557.59442405568, 40642.79678601617, 40650.79674601638, 40694.796526017475, 3380.0, 3459.4810778383194, 3542.36237477254, 3559.839807208682, 3648.1609229877276, 30102.24744381386, 30262.394752104836, 30327.848360758057, 30399.24001899948, 31349.0, 3586.8744593939086, 3606.801625910574, 3624.238909828939, 3674.5039419678537, 3728.9813550932345, 256598.0, 256730.0, 256929.0, 257213.0, 258115.0, 56745.43254567484, 57875.421245787846, 66187.66906165535, 67186.0, 67213.32786672168, 62015.0, 62205.68897155485, 62316.57258850716, 62591.0, 62743.0, 15428.845711542965, 15594.220288985505, 15676.529704108894, 15686.9215653921, 15791.28939197716, 11823.704407389883, 11910.106741994385, 11911.0, 12021.218620789621, 12039.879601204051, 20048.59902801965, 20098.497537561678, 20222.191112355635, 20340.288089916783, 20406.28577999763, 7600.201978792258, 7735.961320193475, 7823.960880195563, 7860.921390786133, 7871.921280787234, 960.5725452173716, 986.1962500562018, 1051.952662130206, 1098.1653943003216, 1119.076761671608, 28862.567061494094, 28904.277393065342, 28904.42191156165, 29248.660107191372, 29268.853655731586, 1076.650088721153, 1086.4459125845876, 1090.6727981605486, 1114.6878873915155, 1216.0757824053605, 15011.549653510412, 15048.849511504965, 15056.247187640574, 15193.696126077417, 15323.46367877119, 314887.0, 319360.0, 319710.0, 319774.0, 319971.0, 53144.46855531473, 53464.73267633637, 53549.46450535523, 53820.73089634527, 53830.0, 1320.808482769993, 1345.7375811716818, 1350.2641060621984, 1372.9931350343184, 1397.7134687389062, 27003.324916877235, 28043.298917527223, 28218.2945426366, 28615.28461788472, 29716.85141574278, 45721.0, 45830.770846145555, 46033.539664602926, 46098.30852537282, 46114.0, 215488.0, 217366.0, 217492.0, 217612.0, 218157.72763408243, 29475.557866632447, 31712.682873171896, 32185.67814321827, 32185.839070805432, 32228.0, 43775.343369848844, 44689.55310446854, 45043.7747811272, 45367.0, 46021.0, 36979.26041479102, 37510.6248937518, 38109.61890381061, 38488.0, 38535.22929541337, 37022.62977370192, 37222.0, 37900.2419951605, 38210.42684359681, 38422.423663645626, 36535.45196822103, 37183.81408092942, 37402.43896341503, 37462.250754984205, 37625.24749505049, 32722.34555308833, 33611.49582756212, 34445.82777086098, 34494.82752586221, 39192.412113818886, 28698.42603147967, 30318.54522182125, 30584.235394115327, 31312.843435782674, 31418.0], "unit": "ms", "name": "ext.html", "value": 18745.23377260244}, {"lowerIsBetter": false, "replicates": [345.74242189568776, 350.13516613963515, 355.1193041257681, 356.06710418703, 357.18918056012853, 12374.50501979922, 12759.17065390749, 16308.83691163088, 16999.660006799855, 18044.458666240018, 11471.713207169825, 11537.365444900528, 11689.941550292258, 11727.413629318522, 11797.646070617895, 4529.954700453003, 4681.204195286792, 4681.976590117045, 4684.601808846252, 4700.929486057695, 4573.039661671037, 4692.061587682477, 4695.460022097468, 4695.788689508963, 4697.4832768395445, 4651.232546629802, 4656.860294191163, 4660.324252983315, 4801.1117943180625, 4808.519148085181, 4765.094632019923, 4780.545848144421, 4785.545373189541, 4794.808207671672, 4801.447833499157, 4435.356873253392, 4458.509563947963, 4461.750709801261, 4482.193205223059, 4483.574060464251, 13587.32063396836, 13638.659033524142, 13853.238071906042, 13905.304734763222, 13949.232792196424, 2055.54777948851, 2147.8389120816, 2155.89220538974, 2175.3147758456194, 2201.7908298711595, 9553.856692149624, 9777.804443911082, 9991.650292239809, 10161.441120738356, 10201.0, 1721.1136264823626, 1735.522731248904, 1751.0, 1756.929722811086, 1803.6933721267417, 55485.44514554884, 56009.43990560083, 56934.7153264231, 59515.0, 60356.39643603595, 6876.349676077705, 6911.550749201286, 7006.77381458253, 7042.964785176041, 7112.0, 8489.36329775257, 8569.271611912933, 8580.699675511327, 8588.969323681198, 8606.87089693655, 5701.458361455655, 5728.627639203439, 5771.797987070432, 5782.479576838021, 5786.768529258867, 5922.466977972003, 5936.495397891227, 5936.881262374728, 5964.224650795369, 5988.0, 3367.4443716786454, 3395.5416018837636, 3402.5066365376883, 3410.403179443637, 3415.55597772288, 1134.3194083549804, 1138.510440510572, 1149.8792626774236, 1174.365842445087, 1228.1403017887335, 411.14276733011405, 418.101082672251, 422.2800125785528, 441.5827043443979, 441.8033974881147, 10244.078032977068, 10747.247692661595, 10897.891021089847, 10971.39657318839, 11110.777784444428, 439.3980247061546, 446.1122366490725, 449.0323353173915, 454.6431051624459, 466.51249444330756, 5837.124431335334, 5967.492763115097, 6015.368386319374, 6108.694565271719, 6128.63228206309, 515298.0, 516572.0, 522387.0, 529594.0, 529644.0, 74751.25248747443, 75931.24068759242, 76604.61697691475, 78465.60767196128, 78979.21020789718, 506.16735470151394, 510.56346823466146, 511.0315951272318, 513.0406140517257, 513.2942204468856, 10601.628942986958, 10634.946825265824, 10673.57305707763, 10697.625583104555, 10740.785184296426, 36079.819600902876, 36417.089572760895, 36621.0, 37283.0, 37305.761654300826, 48302.27546586734, 48598.02803943972, 49261.75369123275, 50977.882654081746, 51061.0, 8111.472754270953, 8405.621747021522, 8538.231559159705, 8627.95686021566, 8681.609327580149, 12096.092793040732, 12135.514579416724, 12138.757224855277, 12210.145289829627, 12358.938205308916, 9337.159655631025, 9504.904950950402, 10671.679849604525, 10912.781744365227, 10932.508037138507, 10710.785784284115, 10746.086582640562, 10878.456077196266, 11005.17461190398, 11153.163512736415, 10920.126389888948, 11003.834942476029, 11243.212975091665, 11267.661970140909, 11309.71725706864, 8495.74512764618, 8501.744947651581, 8735.43219690718, 8741.694040708544, 8746.125387461203, 11008.559657613605, 11196.0, 11310.264832785842, 11373.090152787923, 11560.248583842023], "unit": "ms", "name": "jquery.html", "value": 6955.677347965556}, {"lowerIsBetter": false, "replicates": [1484.3839806480312, 1543.0278924277707, 1590.10159260018, 1690.4337047089225, 1792.0502133869045, 7566.962165189173, 7703.345215656662, 7802.726904558334, 7859.764207073783, 7900.762977110681, 7946.880796788053, 7961.124276329613, 8038.035435747718, 8046.959765201181, 8047.839043219146, 2327.7323107842562, 2363.7518060603647, 2371.537550177716, 2371.691680081587, 2375.7861792438675, 2253.504229069602, 2301.056566807609, 2373.715154181492, 2374.905003799846, 2377.037299893546, 2280.600894843404, 2309.030207312933, 2325.5116425550655, 2333.7549557296493, 2364.3143488388346, 2297.5519773644146, 2304.4699719064542, 2314.9768502315014, 2348.6711860339483, 2355.0344358812977, 2306.9077236910503, 2409.8794060761657, 2410.7227668818136, 2410.7348191698898, 2414.251582009565, 7657.961710191414, 7674.1942096079665, 7685.961570192113, 7689.923100768977, 7749.186335434754, 4672.766361681903, 4748.857534273978, 4770.880727981794, 4785.042991401733, 4786.401699787527, 3172.904812855618, 3193.5209718542174, 3219.2434777827193, 3227.193201699575, 3277.8688852445875, 1043.8434234864756, 1044.1959691037935, 1045.6183493024992, 1058.6294796821128, 1074.6453670288786, 10699.78600427995, 10725.785484290349, 10760.461976901124, 10809.243352965295, 10847.294925829796, 4255.787210639518, 4304.5910638489295, 4366.995591014084, 4400.075984043323, 4424.579664931826, 8852.513111778786, 8865.113488651083, 8867.423617464845, 8881.111888811067, 8886.555672216493, 4673.3690951721765, 4697.295405689106, 4702.435707715096, 4713.34013238147, 4714.929276060861, 4267.338562522814, 4276.444062271885, 4291.356296555542, 4294.806733696991, 4313.870583882489, 3544.7518673692593, 3584.8028358440015, 3595.8381872815785, 3612.259486805199, 3621.6559426854406, 1114.331401159314, 1126.3861195648392, 1131.2872890079198, 1142.2118738070872, 1146.8107762219308, 1060.9575616975235, 1074.9032587067045, 1078.1590359519587, 1257.8176164456286, 1380.6824430381068, 7386.224446433154, 7414.036175297177, 7473.476856620093, 7488.288612581796, 7588.317051465284, 1044.6082718980383, 1073.9570417183224, 1138.2771939818274, 1144.8683401408778, 1162.3490845126587, 5809.8547536311935, 5871.735771890189, 5916.674582897896, 5921.259842519685, 5936.5547583931375, 8851.291896648252, 8857.689980850768, 9156.175944165057, 9222.53887305632, 9257.953710231406, 8973.641054357882, 9005.684801031932, 9006.54967251648, 9016.459012459274, 9084.500352480545, 7060.646967651597, 7120.074390329328, 7225.855482890418, 7292.8906066409045, 7318.634068296564, 7317.597532135784, 7360.07999000125, 7406.222346653523, 7457.701691932479, 7469.290417410337, 8058.355331573577, 8170.700751071577, 8283.792905177177, 8301.501909885426, 8396.118407567117, 8499.617517211864, 8505.277051450696, 8545.102764209918, 8590.0, 8591.87112193305, 6879.277675843964, 6985.091938048021, 6997.230304666585, 7001.0, 7023.578585284899, 7594.734184303523, 7747.147813740371, 7749.147593764794, 7749.573773442515, 7782.961085194538, 7037.331453511908, 7286.761250587307, 7288.198298187089, 7338.816529586589, 7400.666969986256, 7114.964425177841, 7122.252163522963, 7184.281571842774, 7227.747028853965, 7247.710091596277, 7335.706571737284, 7392.0, 7397.038385009914, 7401.111866576045, 7413.518121322097, 6527.281998980204, 6783.89824152648, 6785.558938668971, 6798.626075565891, 6804.183497980274, 6713.731450741916, 6745.426638735762, 6820.113385260083, 6830.872905970459, 6834.829129271609], "unit": "ms", "name": "mootools.html", "value": 4555.1981280991195}, {"lowerIsBetter": false, "replicates": [338.93899098162336, 340.7308226501064, 345.94810778383254, 349.4897449723403, 350.23124242288156, 6262.561620686548, 6348.36516348365, 6395.0407438884195, 6400.295967443583, 6438.0, 6278.372162783719, 6309.274433440156, 6318.652474113922, 6326.398992095755, 6336.714847831847, 4790.329353890458, 4799.976000119995, 4805.879853003668, 4809.735464549449, 4810.97594512027, 4804.639652026094, 4811.13399588074, 4812.470628230892, 4817.90364192716, 4823.541763532477, 4642.953570464286, 4709.270063140219, 4748.477667456577, 4757.333973243749, 4809.0, 4702.8118875244945, 4716.716996980158, 4735.479097299311, 4763.118823017753, 4780.0, 4185.142045880587, 4194.6853985950875, 4198.160367926427, 4198.9370159447635, 4199.790010499493, 5947.732352044169, 5950.166976623276, 5951.821445356603, 5954.106883967396, 5998.340182579913, 5505.834824955257, 5589.496945274904, 5605.299337582802, 5607.214989901417, 5616.63491873031, 6661.367170118831, 6678.332166783332, 6682.164729408824, 6696.0, 6696.732130714766, 4616.699914505546, 4620.283856002325, 4632.444106707183, 4637.976810115962, 4672.742999135046, 6793.864122717568, 6886.449084073312, 6944.756933507303, 6956.339147781004, 6976.860462790766, 4802.303665968415, 4809.374781278481, 4814.422269327703, 4822.734749588736, 4830.855074347775, 4880.951190488121, 4888.926666100011, 4889.168841296988, 4889.633277504201, 4897.069556784199, 5619.887602247933, 5622.297212848394, 5630.97184514083, 5636.0982242841765, 5639.605227634108, 6612.669366531654, 6684.863573192569, 6721.22705888829, 6730.596164230162, 6755.459563234929, 1680.1263343061785, 1708.487453763866, 1723.4657256250352, 1723.9827601723823, 1724.7067998440295, 1140.6920131564432, 1146.512732088859, 1156.259993604094, 1157.5543415784985, 1168.0830548019933, 6412.166418365583, 6424.935750642528, 6429.38920802523, 6430.7106180222, 6441.903371449432, 6813.454923606099, 6832.965835170792, 6872.931270687329, 6881.8967715484305, 6895.827604309832, 6342.23893132827, 6429.421352078335, 6429.903551446732, 6431.099646049557, 6446.903296450557, 3729.1236559408517, 3735.290294843971, 3735.6451137141926, 3757.5490941087246, 3759.699224062123, 7062.1878483975, 7070.575765454089, 7080.645967701595, 7138.0, 7157.320054594805, 6836.863262734718, 6982.0, 6983.406410455168, 7017.543859649107, 7044.0, 6983.89524157138, 7001.054857594159, 7039.54242974205, 7061.364477197077, 7138.500304978706, 6834.624095674786, 6870.690818913261, 6877.690503927435, 6881.898896176788, 6887.793366199022, 6615.305392933865, 6768.7292508299115, 6779.322067793181, 6825.419839313714, 6828.658567071726, 7055.1886533049355, 7097.822554435974, 7100.0, 7100.857982840417, 7106.111736032996, 4795.976020119877, 4813.95186048135, 4821.927671084866, 4825.131476334293, 4846.588040016497, 6755.0615482265375, 6855.245922948571, 6861.970704394181, 6870.20992585859, 6871.965640171967, 6534.379233972765, 6618.768343107968, 6643.335666433318, 6645.269020407848, 6661.1007513985, 6653.101831252912, 6658.400743933069, 6663.466922646274, 6678.465722742266, 6691.197056353269, 6432.967835160982, 6495.317991611002, 6529.608223506605, 6530.281669016499, 6558.1802274715665, 6615.17310336208, 6632.1709786276715, 6695.330466953461, 6717.059611654275, 6719.865602688016, 6515.73937042532, 6527.412532872065, 6528.836779080561, 6534.085228067979, 6542.640154791532], "unit": "ms", "name": "prototype.html", "value": 5037.632977371433}, {"lowerIsBetter": false, "replicates": [859.2395729779145, 859.261035509462, 864.1747131489428, 866.5190819095408, 893.0221407558721, 10572.259941804077, 10708.732281692952, 10722.731931701712, 10771.946140269287, 10820.350778953258, 13512.797308040388, 13534.72930541391, 13589.456421743143, 13611.659708507292, 13624.386902589382, 798.2297083314601, 821.1337039423406, 821.3716506872247, 821.954792486413, 822.2312138150818, 818.2717381530442, 819.8114433680228, 827.759949614614, 832.2385017708789, 833.4749108061943, 859.8538248497771, 866.1338661338661, 866.4974314897345, 868.826234753052, 870.6082262981652, 854.8418542569644, 856.6616186606287, 856.7729551668813, 860.9698660546882, 864.4985908173276, 619.1764952613014, 621.8569728962364, 625.5621065254295, 626.0171530696808, 626.505061001808, 13210.537631182959, 13253.602391928258, 13282.468701251939, 13324.400401981935, 13370.799438008438, 10123.493825308706, 10314.896851031468, 10363.740906477324, 10577.312474689197, 10600.946995264974, 9119.772005699844, 9829.4102353859, 9948.701538953843, 10069.949650251776, 10070.0, 3198.824064676442, 3225.709686128236, 3247.431699452586, 3285.342931413727, 3294.258791771856, 40724.38913416301, 45160.548394515965, 45220.0, 45433.318500222194, 45895.31157032647, 7040.225575186725, 7082.716691332289, 7095.219525852152, 7117.857642847114, 7135.678894449762, 11735.823962640567, 11776.234544754563, 11793.823092653616, 11810.645680629596, 11846.170768046326, 6848.9657551711925, 6884.827879303058, 6955.547889387275, 6990.951357296446, 7156.226354983959, 4272.188284225987, 4289.806958686804, 4347.282698354799, 4358.433403657505, 4392.472903251631, 2771.6119743235963, 2788.219298596396, 2796.4826507096254, 2796.832190068562, 2804.0606396857283, 435.6863058597805, 440.12854547995147, 444.74427204357625, 447.74702293204234, 458.5460394209708, 619.7805026558464, 631.2204427531994, 649.746598826458, 655.367570294668, 709.0, 8735.694250701195, 9205.63177472907, 9210.95394523023, 9462.479563623929, 9529.475878826732, 609.7865746988518, 665.2748504130424, 670.4770279182246, 678.8336857469852, 680.3944489404435, 3906.0, 3933.3903244997073, 4005.6595189409227, 4046.1705350403095, 4134.545200027995, 58972.41027589755, 58973.0, 59078.0, 59328.70335648294, 59430.702846486354, 53949.73025134849, 54335.0, 54359.72820135874, 54708.452915470334, 56121.71939140278, 50426.97438153723, 50630.0, 51083.48916510787, 51297.23054154116, 51882.48117518852, 7888.408369372435, 7959.072170068856, 7982.361411086983, 8106.878396823934, 8305.750827475185, 34976.65023349734, 35360.82319588386, 35607.0, 36705.0, 38539.0, 44641.55358446374, 44868.1026379464, 45427.54572454233, 47880.52119478761, 47924.5207547934, 8161.306288965505, 8330.250277475056, 8401.243888050105, 8481.40630155883, 8616.698415555426, 11937.881430906324, 12200.755984880076, 12211.084168687206, 12455.439505222468, 12481.939035182111, 10997.175211858983, 11291.378974156172, 11375.976162145447, 11779.05767538612, 11809.704757381134, 11267.323960562393, 11270.718232044264, 11343.546258149912, 11479.25384849982, 11733.061355091742, 10034.899651003396, 11862.82205766897, 11897.107716921439, 12276.324802135969, 12284.324362160167, 9250.768730781785, 9255.490947997925, 9310.48792316402, 9404.576794044422, 9423.37115266179, 9124.31567632417, 9461.950931037994, 9588.66439674608, 9859.802803943738, 9959.452230127412], "unit": "ms", "name": "yui.html", "value": 6029.038164177837}], "name": "dromaeo_css", "value": 6774.9510559285845}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 111.0, 111.0, 112.0, 122.0, 111.0, 111.0, 112.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [168.0, 125.0, 151.0, 169.0, 132.0, 159.0, 159.0, 130.0, 159.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [164.0, 166.0, 160.0, 162.0, 163.0, 161.0, 162.0, 163.0, 172.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 71.0, 73.0, 73.0, 71.0, 149.0, 71.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 134.0, 91.0, 90.0, 90.0, 136.0, 90.0, 90.0, 144.0], "unit": "ms", "name": "audio-oscillator", "value": 104.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 149.0, 147.0, 148.0, 146.0, 147.0, 146.0, 149.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 97.0, 99.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 65.0, 61.0, 63.0, 63.0, 64.0, 63.0, 67.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 63.9}, {"lowerIsBetter": true, "replicates": [69.0, 72.0, 70.0, 69.0, 70.0, 71.0, 69.0, 68.0, 71.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.0}, {"lowerIsBetter": true, "replicates": [84.0, 93.0, 87.0, 88.0, 86.0, 86.0, 85.0, 85.0, 93.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [123.0, 120.0, 133.0, 126.0, 119.0, 128.0, 119.0, 118.0, 125.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [144.0, 157.0, 154.0, 150.0, 157.0, 141.0, 150.0, 151.0, 152.0, 154.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.0}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 69.0, 73.0, 69.0, 70.0, 71.0, 73.0, 73.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1526.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.78249336870027], "unit": "score", "name": "Richards", "value": 212.94166399999992}, {"lowerIsBetter": false, "replicates": [194.32568985619898], "unit": "score", "name": "DeltaBlue", "value": 340.2432279999999}, {"lowerIsBetter": false, "replicates": [283.5270768358378], "unit": "score", "name": "Encrypt", "value": 938.8203869999999}, {"lowerIsBetter": false, "replicates": [5065.656565656565], "unit": "score", "name": "Decrypt", "value": 52.54619940179463}, {"lowerIsBetter": false, "replicates": [1059.2592592592594], "unit": "score", "name": "RayTrace", "value": 698.5910139860142}, {"lowerIsBetter": false, "replicates": [708.2152974504249], "unit": "score", "name": "Earley", "value": 941.0457559999996}, {"lowerIsBetter": false, "replicates": [12204.819277108434], "unit": "score", "name": "Boyer", "value": 54.606543928923976}, {"lowerIsBetter": false, "replicates": [25575.0], "unit": "score", "name": "RegExp", "value": 35.620136852394914}, {"lowerIsBetter": false, "replicates": [635.2121595946802], "unit": "score", "name": "Splay", "value": 128.28942073778663}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21238.041959101265}]} 13:09:34 INFO - RETURN: dromaeo_css: 6774.95 13:09:34 INFO - RETURN: kraken: 1526.70 13:09:34 INFO - RETURN: v8_7: 21238.04 13:09:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21238.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1526.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6774.95"}}} 13:09:34 INFO - Return code: 0 13:09:34 INFO - # TBPL SUCCESS # 13:09:34 INFO - Running post-action listener: _resource_record_post_action 13:09:34 INFO - Running post-run listener: _resource_record_post_run 13:09:35 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 8192; Write bytes: 527675392; Read time: 88; Write time: 488652 13:09:35 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 250867712; Read time: 0; Write time: 335348 13:09:35 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276807680; Read time: 76; Write time: 153304 13:09:35 INFO - Running post-run listener: _upload_blobber_files 13:09:35 INFO - Blob upload gear active. 13:09:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:09:35 INFO - Copying logs to upload dir... 13:09:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.566331 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-18 13:09:35.763745) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 13:09:35.767577) ========= 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=d6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009941 build_url: 'https://queue.taskcluster.net/v1/task/oFDrVlcbTaybdBqyZB_ywg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 13:09:35.819455) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:09:35.819815) ========= 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=d6a7e047ef025f707024e163000001c3-1447879613.76689-1028920205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 13:09:35.869961) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 13:09:35.870293) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 13:09:35.870607) ========= ========= Total master_lag: 0.24 =========