builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1450346377.59 results: success (0) buildid: 20151216233005 builduid: 2e55da5c5a3c48a1b21b394fcc03b7ea revision: 1afbb237019de001797d566cd33dd8fa5a9395d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.591543) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.592014) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.592350) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006445 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.615683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.615968) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.629560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.629917) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004669 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.682738) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.683031) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.683384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.683658) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 01:59:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2015-12-17 01:59:38 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185046 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.899008) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.899307) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017654 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.956174) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:37.956516) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1afbb237019de001797d566cd33dd8fa5a9395d1 --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 1afbb237019de001797d566cd33dd8fa5a9395d1 --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=447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 01:59:38,301 truncating revision to first 12 chars 2015-12-17 01:59:38,301 Setting DEBUG logging. 2015-12-17 01:59:38,301 attempt 1/10 2015-12-17 01:59:38,301 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1afbb237019d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 01:59:38,572 unpacking tar archive at: fx-team-1afbb237019d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564977 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.544912) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.545200) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.555045) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.555412) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.555893) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-17 01:59:38.556207) ========= /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=447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:59:38 INFO - MultiFileLogger online at 20151217 01:59:38 in /builds/slave/test-pgo 01:59:38 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 01:59:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:59:38 INFO - {'append_to_log': False, 01:59:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:59:38 INFO - 'blob_upload_branch': 'Fx-Team', 01:59:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:59:38 INFO - 'branch': 'Fx-Team', 01:59:38 INFO - 'buildbot_json_path': 'buildprops.json', 01:59:38 INFO - 'config_files': ('talos/linux_config.py',), 01:59:38 INFO - 'default_actions': ('clobber', 01:59:38 INFO - 'read-buildbot-config', 01:59:38 INFO - 'download-and-extract', 01:59:38 INFO - 'populate-webroot', 01:59:38 INFO - 'create-virtualenv', 01:59:38 INFO - 'install', 01:59:38 INFO - 'run-tests'), 01:59:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:59:38 INFO - 'download_minidump_stackwalk': True, 01:59:38 INFO - 'download_symbols': 'ondemand', 01:59:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:59:38 INFO - 'tooltool.py': '/tools/tooltool.py', 01:59:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:59:38 INFO - '/tools/misc-python/virtualenv.py')}, 01:59:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:59:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:59:38 INFO - 'installer_path': 'installer.exe', 01:59:38 INFO - 'log_level': 'info', 01:59:38 INFO - 'log_name': 'talos', 01:59:38 INFO - 'log_to_console': True, 01:59:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:59:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:59:38 INFO - 'opt_config_files': (), 01:59:38 INFO - 'pip_index': False, 01:59:38 INFO - 'sps_profile': False, 01:59:38 INFO - 'sps_profile_interval': 0, 01:59:38 INFO - 'suite': 'dromaeojs-e10s', 01:59:38 INFO - 'system_bits': '64', 01:59:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:59:38 INFO - 'title': 'talos-linux64-ix-027', 01:59:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:59:38 INFO - 'use_talos_json': True, 01:59:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:59:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:59:38 INFO - 'work_dir': 'build'} 01:59:38 INFO - ##### 01:59:38 INFO - ##### Running clobber step. 01:59:38 INFO - ##### 01:59:38 INFO - Running pre-action listener: _resource_record_pre_action 01:59:38 INFO - Running main action method: clobber 01:59:38 INFO - rmtree: /builds/slave/test-pgo/build 01:59:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:59:39 INFO - Running post-action listener: _resource_record_post_action 01:59:39 INFO - ##### 01:59:39 INFO - ##### Running read-buildbot-config step. 01:59:39 INFO - ##### 01:59:39 INFO - Running pre-action listener: _resource_record_pre_action 01:59:39 INFO - Running main action method: read_buildbot_config 01:59:39 INFO - Using buildbot properties: 01:59:39 INFO - { 01:59:39 INFO - "project": "", 01:59:39 INFO - "product": "firefox", 01:59:39 INFO - "script_repo_revision": "production", 01:59:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:59:39 INFO - "repository": "", 01:59:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 01:59:39 INFO - "buildid": "20151216233005", 01:59:39 INFO - "pgo_build": "True", 01:59:39 INFO - "basedir": "/builds/slave/test-pgo", 01:59:39 INFO - "buildnumber": 389, 01:59:39 INFO - "slavename": "talos-linux64-ix-027", 01:59:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:59:39 INFO - "platform": "ubuntu64_hw", 01:59:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:59:39 INFO - "branch": "fx-team", 01:59:39 INFO - "repo_path": "integration/fx-team", 01:59:39 INFO - "revision": "1afbb237019de001797d566cd33dd8fa5a9395d1", 01:59:39 INFO - "stage_platform": "linux64-pgo", 01:59:39 INFO - "builduid": "2e55da5c5a3c48a1b21b394fcc03b7ea", 01:59:39 INFO - "slavebuilddir": "test" 01:59:39 INFO - } 01:59:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:59:39 INFO - Running post-action listener: _resource_record_post_action 01:59:39 INFO - ##### 01:59:39 INFO - ##### Running download-and-extract step. 01:59:39 INFO - ##### 01:59:39 INFO - Running pre-action listener: _resource_record_pre_action 01:59:39 INFO - Running main action method: download_and_extract 01:59:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:39 INFO - https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:59:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/test_packages.json 01:59:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/test_packages.json 01:59:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:59:40 INFO - Downloaded 1302 bytes. 01:59:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:59:40 INFO - Using the following test package requirements: 01:59:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:59:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:40 INFO - u'jsshell-linux-x86_64.zip'], 01:59:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:59:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:59:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:59:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:59:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:59:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:59: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')]} 01:59:40 INFO - https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:59:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:59:42 INFO - Downloaded 23118372 bytes. 01:59:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:59:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:59:43 INFO - Return code: 0 01:59:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:59:43 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')]} 01:59:43 INFO - https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:59:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:59:47 INFO - Downloaded 23118372 bytes. 01:59:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:59:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:59:49 INFO - Return code: 0 01:59: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')]} 01:59:49 INFO - https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:59:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:59:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:59:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:59:50 INFO - Downloaded 11132052 bytes. 01:59:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 01:59:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:59:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 01:59:50 INFO - Return code: 0 01:59:50 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')]} 01:59:50 INFO - https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:59:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:59:52 INFO - Downloaded 59283175 bytes. 01:59:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:52 INFO - mkdir: /builds/slave/test-pgo/properties 01:59:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:59:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:59:52 INFO - Contents: 01:59:52 INFO - build_url:https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:52 INFO - Running post-action listener: _resource_record_post_action 01:59:52 INFO - Running post-action listener: set_extra_try_arguments 01:59:52 INFO - ##### 01:59:52 INFO - ##### Running populate-webroot step. 01:59:52 INFO - ##### 01:59:52 INFO - Running pre-action listener: _resource_record_pre_action 01:59:52 INFO - Running main action method: populate_webroot 01:59:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:59:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:59:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:59:52 INFO - '--tppagecycles', 01:59:52 INFO - '7'], 01:59:52 INFO - 'tests': ['tsvgm']}}, 01:59:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:59:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:59:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:59:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:59:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:59:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:59:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:52 INFO - 'talos_options': ['--e10s'], 01:59:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:52 INFO - 'tests': ['damp', 'tps']}, 01:59:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:52 INFO - 'talos_options': ['--e10s'], 01:59:52 INFO - 'tests': ['damp', 'tps']}, 01:59:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:59:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:59:52 INFO - 'other': {'tests': ['a11yr', 01:59:52 INFO - 'ts_paint', 01:59:52 INFO - 'tpaint', 01:59:52 INFO - 'sessionrestore', 01:59:52 INFO - 'sessionrestore_no_auto_restore']}, 01:59:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:59:52 INFO - 'tests': ['a11yr', 01:59:52 INFO - 'ts_paint', 01:59:52 INFO - 'tpaint', 01:59:52 INFO - 'sessionrestore', 01:59:52 INFO - 'sessionrestore_no_auto_restore']}, 01:59:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:59:52 INFO - 'tests': ['a11yr', 01:59:52 INFO - 'ts_paint', 01:59:52 INFO - 'tpaint', 01:59:52 INFO - 'sessionrestore', 01:59:52 INFO - 'sessionrestore_no_auto_restore']}, 01:59:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:59:52 INFO - 'tests': ['a11yr', 01:59:52 INFO - 'ts_paint', 01:59:52 INFO - 'tpaint', 01:59:52 INFO - 'sessionrestore', 01:59:52 INFO - 'sessionrestore_no_auto_restore']}, 01:59:52 INFO - 'other_l64': {'tests': ['a11yr', 01:59:52 INFO - 'ts_paint', 01:59:52 INFO - 'tpaint', 01:59:52 INFO - 'sessionrestore', 01:59:52 INFO - 'sessionrestore_no_auto_restore']}, 01:59:52 INFO - 'other_nol64': {'tests': ['a11yr', 01:59:52 INFO - 'ts_paint', 01:59:52 INFO - 'tpaint', 01:59:52 INFO - 'sessionrestore', 01:59:52 INFO - 'sessionrestore_no_auto_restore']}, 01:59:52 INFO - 'svgr': {'tests': ['tsvgx', 01:59:52 INFO - 'tsvgr_opacity', 01:59:52 INFO - 'tart', 01:59:52 INFO - 'tscrollx', 01:59:52 INFO - 'cart']}, 01:59:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:59:52 INFO - 'tests': ['tsvgx', 01:59:52 INFO - 'tsvgr_opacity', 01:59:52 INFO - 'tart', 01:59:52 INFO - 'tscrollx', 01:59:52 INFO - 'cart']}, 01:59:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:52 INFO - 'tests': ['tp5o']}, 01:59:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:52 INFO - 'talos_options': ['--e10s'], 01:59:52 INFO - 'tests': ['tp5o']}, 01:59:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:52 INFO - 'talos_options': ['--xperf_path', 01:59:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:52 INFO - 'tests': ['tp5n']}, 01:59:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:52 INFO - 'talos_options': ['--e10s', 01:59:52 INFO - '--xperf_path', 01:59:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:52 INFO - 'tests': ['tp5n']}}, 01:59:52 INFO - 'talos.zip': {'path': '', 01:59:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:59:52 INFO - Running post-action listener: _resource_record_post_action 01:59:52 INFO - ##### 01:59:52 INFO - ##### Running create-virtualenv step. 01:59:52 INFO - ##### 01:59:52 INFO - Running pre-action listener: _resource_record_pre_action 01:59:52 INFO - Running main action method: create_virtualenv 01:59:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:59:52 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 01:59:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:59:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:59:52 INFO - Using real prefix '/usr' 01:59:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:59:53 INFO - Installing distribute.............................................................................................................................................................................................done. 01:59:55 INFO - Installing pip.................done. 01:59:55 INFO - Return code: 0 01:59:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:55 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 0x7fc59b392f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda350>, '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 0x1cdb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb6e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', '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 01:59:55 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 01:59:55 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 01:59:55 INFO - Using env: {'DISPLAY': ':0', 01:59:55 INFO - 'HOME': '/home/cltbld', 01:59:55 INFO - 'LANG': 'en_US.UTF-8', 01:59:55 INFO - 'LANGUAGE': 'en_US:en', 01:59:55 INFO - 'LOGNAME': 'cltbld', 01:59:55 INFO - 'MAIL': '/var/mail/cltbld', 01:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:55 INFO - 'MOZ_NO_REMOTE': '1', 01:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:55 INFO - 'NO_EM_RESTART': '1', 01:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:55 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:55 INFO - 'SHELL': '/bin/bash', 01:59:55 INFO - 'SHLVL': '1', 01:59:55 INFO - 'TERM': 'linux', 01:59:55 INFO - 'TMOUT': '86400', 01:59:55 INFO - 'USER': 'cltbld', 01:59:55 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', 01:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:55 INFO - '_': '/tools/buildbot/bin/python'} 01:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:55 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 01:59:55 INFO - Cleaning up... 01:59:55 INFO - Return code: 0 01:59:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:55 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 0x7fc59b392f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda350>, '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 0x1cdb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb6e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', '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 01:59:55 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 01:59:55 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 01:59:55 INFO - Using env: {'DISPLAY': ':0', 01:59:55 INFO - 'HOME': '/home/cltbld', 01:59:55 INFO - 'LANG': 'en_US.UTF-8', 01:59:55 INFO - 'LANGUAGE': 'en_US:en', 01:59:55 INFO - 'LOGNAME': 'cltbld', 01:59:55 INFO - 'MAIL': '/var/mail/cltbld', 01:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:55 INFO - 'MOZ_NO_REMOTE': '1', 01:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:55 INFO - 'NO_EM_RESTART': '1', 01:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:55 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:55 INFO - 'SHELL': '/bin/bash', 01:59:55 INFO - 'SHLVL': '1', 01:59:55 INFO - 'TERM': 'linux', 01:59:55 INFO - 'TMOUT': '86400', 01:59:55 INFO - 'USER': 'cltbld', 01:59:55 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', 01:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:55 INFO - '_': '/tools/buildbot/bin/python'} 01:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:55 INFO - Downloading/unpacking psutil>=0.7.1 01:59:55 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 01:59:55 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 01:59:55 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 01:59:55 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 01:59:55 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 01:59:55 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 01:59:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:59:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:59:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:59:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:59:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:59:57 INFO - Installing collected packages: psutil 01:59:57 INFO - Running setup.py install for psutil 01:59:57 INFO - building 'psutil._psutil_linux' extension 01:59:57 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 01:59:57 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 01:59:57 INFO - building 'psutil._psutil_posix' extension 01:59:57 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 01:59:57 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 01:59:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:59:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:59:58 INFO - Successfully installed psutil 01:59:58 INFO - Cleaning up... 01:59:58 INFO - Return code: 0 01:59:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:59: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')]} 01:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59: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')]} 01:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59: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', '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 0x7fc59b392f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda350>, '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 0x1cdb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb6e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', '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 01:59: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:59: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 mozsystemmonitor==0.0.0 01:59:58 INFO - Using env: {'DISPLAY': ':0', 01:59:58 INFO - 'HOME': '/home/cltbld', 01:59:58 INFO - 'LANG': 'en_US.UTF-8', 01:59:58 INFO - 'LANGUAGE': 'en_US:en', 01:59:58 INFO - 'LOGNAME': 'cltbld', 01:59:58 INFO - 'MAIL': '/var/mail/cltbld', 01:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:58 INFO - 'MOZ_NO_REMOTE': '1', 01:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:58 INFO - 'NO_EM_RESTART': '1', 01:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:58 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:58 INFO - 'SHELL': '/bin/bash', 01:59:58 INFO - 'SHLVL': '1', 01:59:58 INFO - 'TERM': 'linux', 01:59:58 INFO - 'TMOUT': '86400', 01:59:58 INFO - 'USER': 'cltbld', 01:59:58 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', 01:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:58 INFO - '_': '/tools/buildbot/bin/python'} 01:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:59: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 01:59: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 01:59: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 01:59: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 01:59: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 01:59: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 01:59:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:00:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:00:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:00:00 INFO - Installing collected packages: mozsystemmonitor 02:00:00 INFO - Running setup.py install for mozsystemmonitor 02:00:00 INFO - Successfully installed mozsystemmonitor 02:00:00 INFO - Cleaning up... 02:00:00 INFO - Return code: 0 02:00:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:00:00 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')]} 02:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:00 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')]} 02:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:00 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 0x7fc59b392f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda350>, '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 0x1cdb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb6e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', '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 02:00:00 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 02:00:00 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 02:00:00 INFO - Using env: {'DISPLAY': ':0', 02:00:00 INFO - 'HOME': '/home/cltbld', 02:00:00 INFO - 'LANG': 'en_US.UTF-8', 02:00:00 INFO - 'LANGUAGE': 'en_US:en', 02:00:00 INFO - 'LOGNAME': 'cltbld', 02:00:00 INFO - 'MAIL': '/var/mail/cltbld', 02:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:00 INFO - 'MOZ_NO_REMOTE': '1', 02:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:00 INFO - 'NO_EM_RESTART': '1', 02:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:00 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:00 INFO - 'SHELL': '/bin/bash', 02:00:00 INFO - 'SHLVL': '1', 02:00:00 INFO - 'TERM': 'linux', 02:00:00 INFO - 'TMOUT': '86400', 02:00:00 INFO - 'USER': 'cltbld', 02:00:00 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', 02:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:00 INFO - '_': '/tools/buildbot/bin/python'} 02:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:00 INFO - Downloading/unpacking blobuploader==1.2.4 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00:02 INFO - Downloading blobuploader-1.2.4.tar.gz 02:00:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:00:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:00:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:00:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:00:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:02 INFO - Downloading docopt-0.6.1.tar.gz 02:00:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:00:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:00:02 INFO - Installing collected packages: blobuploader, requests, docopt 02:00:02 INFO - Running setup.py install for blobuploader 02:00:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:00:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:00:03 INFO - Running setup.py install for requests 02:00:03 INFO - Running setup.py install for docopt 02:00:03 INFO - Successfully installed blobuploader requests docopt 02:00:03 INFO - Cleaning up... 02:00:03 INFO - Return code: 0 02:00:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:00:03 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')]} 02:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:03 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')]} 02:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:03 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 0x7fc59b392f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda350>, '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 0x1cdb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb6e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', '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 02:00:03 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 02:00:03 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 02:00:03 INFO - Using env: {'DISPLAY': ':0', 02:00:03 INFO - 'HOME': '/home/cltbld', 02:00:03 INFO - 'LANG': 'en_US.UTF-8', 02:00:03 INFO - 'LANGUAGE': 'en_US:en', 02:00:03 INFO - 'LOGNAME': 'cltbld', 02:00:03 INFO - 'MAIL': '/var/mail/cltbld', 02:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:03 INFO - 'MOZ_NO_REMOTE': '1', 02:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:03 INFO - 'NO_EM_RESTART': '1', 02:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:03 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:03 INFO - 'SHELL': '/bin/bash', 02:00:03 INFO - 'SHLVL': '1', 02:00:03 INFO - 'TERM': 'linux', 02:00:03 INFO - 'TMOUT': '86400', 02:00:03 INFO - 'USER': 'cltbld', 02:00:03 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', 02:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:03 INFO - '_': '/tools/buildbot/bin/python'} 02:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:03 INFO - Running setup.py (path:/tmp/pip-CFds3n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:03 INFO - Running setup.py (path:/tmp/pip-KmRWHU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:03 INFO - Running setup.py (path:/tmp/pip-BkcI3_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:03 INFO - Running setup.py (path:/tmp/pip-QYcv72-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:03 INFO - Running setup.py (path:/tmp/pip-mjl4Jw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:04 INFO - Running setup.py (path:/tmp/pip-4zoSWA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:04 INFO - Running setup.py (path:/tmp/pip-a4VlrE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:04 INFO - Running setup.py (path:/tmp/pip-I4vHEw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:04 INFO - Running setup.py (path:/tmp/pip-sVSqv8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:04 INFO - Running setup.py (path:/tmp/pip-3FfyJ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:04 INFO - Running setup.py (path:/tmp/pip-lhfFqU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:04 INFO - Running setup.py (path:/tmp/pip-JEwlEX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:04 INFO - Running setup.py (path:/tmp/pip-XsRoM0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:04 INFO - Running setup.py (path:/tmp/pip-qoS5d0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:04 INFO - Running setup.py (path:/tmp/pip-MVpDzm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:04 INFO - Running setup.py (path:/tmp/pip-V7WMgK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:04 INFO - Running setup.py (path:/tmp/pip-36g80H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:00:04 INFO - Running setup.py install for manifestparser 02:00:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:00:05 INFO - Running setup.py install for mozcrash 02:00:05 INFO - Running setup.py install for mozdebug 02:00:05 INFO - Running setup.py install for mozdevice 02:00:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:00:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:00:05 INFO - Running setup.py install for mozfile 02:00:05 INFO - Running setup.py install for mozhttpd 02:00:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:00:05 INFO - Running setup.py install for mozinfo 02:00:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:00:05 INFO - Running setup.py install for mozInstall 02:00:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:00:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:00:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:00:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:00:05 INFO - Running setup.py install for mozleak 02:00:05 INFO - Running setup.py install for mozlog 02:00:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:00:05 INFO - Running setup.py install for moznetwork 02:00:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:00:06 INFO - Running setup.py install for mozprocess 02:00:06 INFO - Running setup.py install for mozprofile 02:00:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:00:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:00:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:00:06 INFO - Running setup.py install for mozrunner 02:00:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:00:06 INFO - Running setup.py install for mozscreenshot 02:00:06 INFO - Running setup.py install for moztest 02:00:06 INFO - Running setup.py install for mozversion 02:00:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:00:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:00:06 INFO - Cleaning up... 02:00:06 INFO - Return code: 0 02:00:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:00:06 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')]} 02:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:06 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')]} 02:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:06 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 0x7fc59b392f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda350>, '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 0x1cdb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb6e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', '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 02:00:06 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 02:00:06 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 02:00:06 INFO - Using env: {'DISPLAY': ':0', 02:00:06 INFO - 'HOME': '/home/cltbld', 02:00:06 INFO - 'LANG': 'en_US.UTF-8', 02:00:06 INFO - 'LANGUAGE': 'en_US:en', 02:00:06 INFO - 'LOGNAME': 'cltbld', 02:00:06 INFO - 'MAIL': '/var/mail/cltbld', 02:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:06 INFO - 'MOZ_NO_REMOTE': '1', 02:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:06 INFO - 'NO_EM_RESTART': '1', 02:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:06 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:06 INFO - 'SHELL': '/bin/bash', 02:00:06 INFO - 'SHLVL': '1', 02:00:06 INFO - 'TERM': 'linux', 02:00:06 INFO - 'TMOUT': '86400', 02:00:06 INFO - 'USER': 'cltbld', 02:00:06 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', 02:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:06 INFO - '_': '/tools/buildbot/bin/python'} 02:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:06 INFO - Running setup.py (path:/tmp/pip-OlyVSW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:07 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)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:07 INFO - Running setup.py (path:/tmp/pip-SG8bt0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:07 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)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:07 INFO - Running setup.py (path:/tmp/pip-Pd_sZ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:07 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)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:07 INFO - Running setup.py (path:/tmp/pip-xcivyK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:07 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)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:07 INFO - Running setup.py (path:/tmp/pip-iA7LJk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:07 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)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:07 INFO - Running setup.py (path:/tmp/pip-pBUFt3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:07 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)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:07 INFO - Running setup.py (path:/tmp/pip-Kq2GEx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:07 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)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:07 INFO - Running setup.py (path:/tmp/pip-zS_y3U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:07 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)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:07 INFO - Running setup.py (path:/tmp/pip-lQuzJQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:07 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)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:07 INFO - Running setup.py (path:/tmp/pip-tETbQc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:07 INFO - Running setup.py (path:/tmp/pip-g1wTBB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:07 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)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:07 INFO - Running setup.py (path:/tmp/pip-3CA867-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:07 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)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:07 INFO - Running setup.py (path:/tmp/pip-ij6JL3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:07 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)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:07 INFO - Running setup.py (path:/tmp/pip-GX_HDl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:07 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)) 02:00:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:07 INFO - Running setup.py (path:/tmp/pip-C41EqA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:08 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)) 02:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:08 INFO - Running setup.py (path:/tmp/pip-As6cqM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:08 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)) 02:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:08 INFO - Running setup.py (path:/tmp/pip-kpeLXz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:08 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)) 02:00:08 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)) 02:00: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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 02:00:08 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)) 02:00: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 mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 02:00:08 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)) 02:00:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:09 INFO - Downloading blessings-1.5.1.tar.gz 02:00:09 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 02:00:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:00:09 INFO - Installing collected packages: blessings 02:00:09 INFO - Running setup.py install for blessings 02:00:10 INFO - Successfully installed blessings 02:00:10 INFO - Cleaning up... 02:00:10 INFO - Return code: 0 02:00:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:00:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:00:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:00:10 INFO - Reading from file tmpfile_stdout 02:00:10 INFO - Current package versions: 02:00:10 INFO - argparse == 1.2.1 02:00:10 INFO - blessings == 1.5.1 02:00:10 INFO - blobuploader == 1.2.4 02:00:10 INFO - docopt == 0.6.1 02:00:10 INFO - manifestparser == 1.1 02:00:10 INFO - mozInstall == 1.12 02:00:10 INFO - mozcrash == 0.16 02:00:10 INFO - mozdebug == 0.1 02:00:10 INFO - mozdevice == 0.47 02:00:10 INFO - mozfile == 1.2 02:00:10 INFO - mozhttpd == 0.7 02:00:10 INFO - mozinfo == 0.9 02:00:10 INFO - mozleak == 0.1 02:00:10 INFO - mozlog == 3.1 02:00:10 INFO - moznetwork == 0.27 02:00:10 INFO - mozprocess == 0.22 02:00:10 INFO - mozprofile == 0.27 02:00:10 INFO - mozrunner == 6.11 02:00:10 INFO - mozscreenshot == 0.1 02:00:10 INFO - mozsystemmonitor == 0.0 02:00:10 INFO - moztest == 0.7 02:00:10 INFO - mozversion == 1.4 02:00:10 INFO - psutil == 3.1.1 02:00:10 INFO - requests == 1.2.3 02:00:10 INFO - wsgiref == 0.1.2 02:00:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:00:10 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')]} 02:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:10 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')]} 02:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:10 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 0x7fc59b392f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda350>, '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 0x1cdb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb6e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', '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 02:00:10 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 02:00:10 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 02:00:10 INFO - Using env: {'DISPLAY': ':0', 02:00:10 INFO - 'HOME': '/home/cltbld', 02:00:10 INFO - 'LANG': 'en_US.UTF-8', 02:00:10 INFO - 'LANGUAGE': 'en_US:en', 02:00:10 INFO - 'LOGNAME': 'cltbld', 02:00:10 INFO - 'MAIL': '/var/mail/cltbld', 02:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:10 INFO - 'MOZ_NO_REMOTE': '1', 02:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:10 INFO - 'NO_EM_RESTART': '1', 02:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:10 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:10 INFO - 'SHELL': '/bin/bash', 02:00:10 INFO - 'SHLVL': '1', 02:00:10 INFO - 'TERM': 'linux', 02:00:10 INFO - 'TMOUT': '86400', 02:00:10 INFO - 'USER': 'cltbld', 02:00:10 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', 02:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:10 INFO - '_': '/tools/buildbot/bin/python'} 02:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:10 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)) 02:00:10 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)) 02:00:10 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)) 02:00:10 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)) 02:00:10 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)) 02:00:10 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)) 02:00:10 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)) 02:00:10 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)) 02:00:10 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)) 02:00:10 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)) 02:00:10 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)) 02:00:10 INFO - Cleaning up... 02:00:10 INFO - Return code: 0 02:00:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:00:10 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')]} 02:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:10 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')]} 02:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc59b392f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda350>, '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 0x1cdb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb6e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', '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 02:00:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 02:00:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:00:10 INFO - Using env: {'DISPLAY': ':0', 02:00:10 INFO - 'HOME': '/home/cltbld', 02:00:10 INFO - 'LANG': 'en_US.UTF-8', 02:00:10 INFO - 'LANGUAGE': 'en_US:en', 02:00:10 INFO - 'LOGNAME': 'cltbld', 02:00:10 INFO - 'MAIL': '/var/mail/cltbld', 02:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:10 INFO - 'MOZ_NO_REMOTE': '1', 02:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:10 INFO - 'NO_EM_RESTART': '1', 02:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:10 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:10 INFO - 'SHELL': '/bin/bash', 02:00:10 INFO - 'SHLVL': '1', 02:00:10 INFO - 'TERM': 'linux', 02:00:10 INFO - 'TMOUT': '86400', 02:00:10 INFO - 'USER': 'cltbld', 02:00:10 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', 02:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:10 INFO - '_': '/tools/buildbot/bin/python'} 02:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:10 INFO - Downloading/unpacking jsonschema 02:00:10 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 02:00:10 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 02:00:10 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 02:00:10 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 02:00:10 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 02:00:10 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 02:00:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:00:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 02:00:12 INFO - Downloading/unpacking functools32 (from jsonschema) 02:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:12 INFO - Downloading functools32-3.2.3-2.tar.gz 02:00:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:00:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:00:12 INFO - warning: no files found matching '*.txt' 02:00:12 INFO - no previously-included directories found matching 'build' 02:00:12 INFO - no previously-included directories found matching 'dist' 02:00:12 INFO - no previously-included directories found matching '.git*' 02:00:12 INFO - Installing collected packages: jsonschema, functools32 02:00:12 INFO - Running setup.py install for functools32 02:00:12 INFO - warning: no files found matching '*.txt' 02:00:12 INFO - no previously-included directories found matching 'build' 02:00:12 INFO - no previously-included directories found matching 'dist' 02:00:12 INFO - no previously-included directories found matching '.git*' 02:00:12 INFO - Successfully installed jsonschema functools32 02:00:12 INFO - Cleaning up... 02:00:12 INFO - Return code: 0 02:00:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:00:12 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')]} 02:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:12 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')]} 02:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc59b392f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cda350>, '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 0x1cdb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb6e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', '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 02:00:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 02:00:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:00:12 INFO - Using env: {'DISPLAY': ':0', 02:00:12 INFO - 'HOME': '/home/cltbld', 02:00:12 INFO - 'LANG': 'en_US.UTF-8', 02:00:12 INFO - 'LANGUAGE': 'en_US:en', 02:00:12 INFO - 'LOGNAME': 'cltbld', 02:00:12 INFO - 'MAIL': '/var/mail/cltbld', 02:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:12 INFO - 'MOZ_NO_REMOTE': '1', 02:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:12 INFO - 'NO_EM_RESTART': '1', 02:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:12 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:12 INFO - 'SHELL': '/bin/bash', 02:00:12 INFO - 'SHLVL': '1', 02:00:12 INFO - 'TERM': 'linux', 02:00:12 INFO - 'TMOUT': '86400', 02:00:12 INFO - 'USER': 'cltbld', 02:00:12 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', 02:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:12 INFO - '_': '/tools/buildbot/bin/python'} 02:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:13 INFO - Downloading/unpacking flake8 02:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:00:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 02:00:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:00:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 02:00:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 02:00:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:00:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:00:15 INFO - no previously-included directories found matching 'docs/_build' 02:00:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:00:15 INFO - Running setup.py install for pep8 02:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:00:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:00:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:00:15 INFO - no previously-included directories found matching 'docs/_build' 02:00:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:00:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:00:15 INFO - Cleaning up... 02:00:15 INFO - Return code: 0 02:00:15 INFO - Running post-action listener: _resource_record_post_action 02:00:15 INFO - Running post-action listener: _start_resource_monitoring 02:00:15 INFO - Starting resource monitoring. 02:00:15 INFO - ##### 02:00:15 INFO - ##### Running install step. 02:00:15 INFO - ##### 02:00:15 INFO - Running pre-action listener: _resource_record_pre_action 02:00:15 INFO - Running main action method: install 02:00:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:00:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:00:15 INFO - Reading from file tmpfile_stdout 02:00:15 INFO - Detecting whether we're running mozinstall >=1.0... 02:00:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:00:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:00:15 INFO - Reading from file tmpfile_stdout 02:00:15 INFO - Output received: 02:00:15 INFO - Usage: mozinstall [options] installer 02:00:15 INFO - Options: 02:00:15 INFO - -h, --help show this help message and exit 02:00:15 INFO - -d DEST, --destination=DEST 02:00:15 INFO - Directory to install application into. [default: 02:00:15 INFO - "/builds/slave/test-pgo"] 02:00:15 INFO - --app=APP Application being installed. [default: firefox] 02:00:15 INFO - mkdir: /builds/slave/test-pgo/build/application 02:00:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 02:00:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 02:00:30 INFO - Reading from file tmpfile_stdout 02:00:30 INFO - Output received: 02:00:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:00:30 INFO - Running post-action listener: _resource_record_post_action 02:00:30 INFO - ##### 02:00:30 INFO - ##### Running run-tests step. 02:00:30 INFO - ##### 02:00:30 INFO - Running pre-action listener: _resource_record_pre_action 02:00:30 INFO - Running main action method: run_tests 02:00:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:00:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:00:30 INFO - Python 2.7.3 02:00:30 INFO - Return code: 0 02:00:30 INFO - grabbing minidump binary from tooltool 02:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:30 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 0x1cda350>, '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 0x1cdb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdb6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:00:30 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 02:00:30 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 02:00:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:00:30 INFO - Return code: 0 02:00:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:00:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:00:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:00:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:00:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:00:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:00:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:00:31 INFO - Return code: 0 02:00:31 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/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 02:00:31 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/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 02:00:31 INFO - Using env: {'DISPLAY': ':0', 02:00:31 INFO - 'HOME': '/home/cltbld', 02:00:31 INFO - 'LANG': 'en_US.UTF-8', 02:00:31 INFO - 'LANGUAGE': 'en_US:en', 02:00:31 INFO - 'LOGNAME': 'cltbld', 02:00:31 INFO - 'MAIL': '/var/mail/cltbld', 02:00:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:00:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:31 INFO - 'MOZ_NO_REMOTE': '1', 02:00:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:31 INFO - 'NO_EM_RESTART': '1', 02:00:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:31 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:00:31 INFO - 'SHELL': '/bin/bash', 02:00:31 INFO - 'SHLVL': '1', 02:00:31 INFO - 'TERM': 'linux', 02:00:31 INFO - 'TMOUT': '86400', 02:00:31 INFO - 'USER': 'cltbld', 02:00:31 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383', 02:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:31 INFO - '_': '/tools/buildbot/bin/python'} 02:00:31 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/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 02:00:32 INFO - mozversion INFO | application_buildid: 20151216233005 02:00:32 INFO - mozversion INFO | application_changeset: 1afbb237019de001797d566cd33dd8fa5a9395d1 02:00:32 INFO - mozversion INFO | application_display_name: Nightly 02:00:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:00:32 INFO - mozversion INFO | application_name: Firefox 02:00:32 INFO - mozversion INFO | application_remotingname: firefox 02:00:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:00:32 INFO - mozversion INFO | application_vendor: Mozilla 02:00:32 INFO - mozversion INFO | application_version: 46.0a1 02:00:32 INFO - mozversion INFO | platform_buildid: 20151216233005 02:00:32 INFO - mozversion INFO | platform_changeset: 1afbb237019de001797d566cd33dd8fa5a9395d1 02:00:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:00:32 INFO - mozversion INFO | platform_version: 46.0a1 02:00:32 INFO - 2015-12-17 02:00:32,035 DEBUG : using testdate: 1450346432 02:00:32 INFO - 2015-12-17 02:00:32,035 DEBUG : actual date: 1450346432 02:00:32 INFO - 2015-12-17 02:00:32,043 INFO : starting webserver on 'localhost:35694' 02:00:32 INFO - 2015-12-17 02:00:32,044 INFO : Starting test suite talos-linux64-ix-027.e 02:00:32 INFO - 2015-12-17 02:00:32,044 INFO : Starting test dromaeo_css 02:00:32 INFO - 2015-12-17 02:00:32,044 DEBUG : operating with platform_type : linux_ 02:00:32 INFO - 2015-12-17 02:00:32,044 INFO : Initialising browser for dromaeo_css test... 02:00:32 INFO - 2015-12-17 02:00:32,056 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkNyfNZ/profile http://localhost:35694/getInfo.html 02:00:36 INFO - 2015-12-17 02:00:36,777 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:00:36 INFO - 2015-12-17 02:00:36,777 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:00:36 INFO - 2015-12-17 02:00:36,777 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:00:36 INFO - 2015-12-17 02:00:36,777 DEBUG : BROWSER_OUTPUT: __metrics 02:00:36 INFO - 2015-12-17 02:00:36,898 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:00:37 INFO - 2015-12-17 02:00:37,821 INFO : Browser initialized. 02:00:37 INFO - 2015-12-17 02:00:37,822 INFO : Running cycle 1/1 for dromaeo_css test... 02:00:37 INFO - 2015-12-17 02:00:37,822 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkNyfNZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:00:49 INFO - 2015-12-17 02:00:49,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 143831040 02:00:49 INFO - 2015-12-17 02:00:49,784 DEBUG : BROWSER_OUTPUT: 02:01:39 INFO - 2015-12-17 02:01:39,378 DEBUG : BROWSER_OUTPUT: 1450346499374 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] 02:03:48 INFO - 2015-12-17 02:03:48,998 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35694/tests/dromaeo/cssquery-ext.html) 02:03:50 INFO - 2015-12-17 02:03:50,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 148086784 02:03:50 INFO - 2015-12-17 02:03:50,063 DEBUG : BROWSER_OUTPUT: 02:06:52 INFO - 2015-12-17 02:06:52,053 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/dromaeo/cssquery-ext.html (next: http://localhost:35694/tests/dromaeo/cssquery-jquery.html) 02:06:52 INFO - 2015-12-17 02:06:52,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 144359424 02:06:52 INFO - 2015-12-17 02:06:52,640 DEBUG : BROWSER_OUTPUT: 02:09:54 INFO - 2015-12-17 02:09:54,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35694/tests/dromaeo/cssquery-mootools.html) 02:09:54 INFO - 2015-12-17 02:09:54,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 146034688 02:09:54 INFO - 2015-12-17 02:09:54,929 DEBUG : BROWSER_OUTPUT: 02:12:56 INFO - 2015-12-17 02:12:56,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35694/tests/dromaeo/cssquery-prototype.html) 02:12:57 INFO - 2015-12-17 02:12:57,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 144752640 02:12:57 INFO - 2015-12-17 02:12:57,185 DEBUG : BROWSER_OUTPUT: 02:15:59 INFO - 2015-12-17 02:15:59,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35694/tests/dromaeo/cssquery-yui.html) 02:16:00 INFO - 2015-12-17 02:16:00,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 145596416 02:16:00 INFO - 2015-12-17 02:16:00,135 DEBUG : BROWSER_OUTPUT: 02:19:02 INFO - 2015-12-17 02:19:02,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/dromaeo/cssquery-yui.html (next: http://localhost:35694/tests/dromaeo/cssquery-dojo.html) 02:19:02 INFO - 2015-12-17 02:19:02,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 147374080 02:19:02 INFO - 2015-12-17 02:19:02,675 DEBUG : BROWSER_OUTPUT: 02:19:02 INFO - 2015-12-17 02:19:02,677 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:19:02 INFO - 2015-12-17 02:19:02,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:19:02 INFO - 2015-12-17 02:19:02,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:19:02 INFO - 2015-12-17 02:19:02,677 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:19:02 INFO - 2015-12-17 02:19:02,678 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3234.9514757278644;3262.4453842846697;3288.3916475452056;3303.966960330397;3320.3193345364202;5333.799895023618;5379.193121031847;5411.0530657135;5443.591730620199;5457.590680698949;5469.097598896187;5484.698341591211;5506.449355064502;5508.421615730351;5543.584231182657;4758;5016.7742451589675;5198.298229738974;5209.32278803755;5212.244224587452;4932.112219800434;5134.691918484884;5138.075146473633;5156.407013193474;5207.166853303473;4931.778069986841;4948.331975183341;4954.826581069645;4967.329410529586;5083.38999320084;4954.504549545053;4959.231319145538;4966.180580204298;4967.850964471072;5016.548510634024;4900.362952816111;4946.72792996385;4949.257611358289;4965.652404331699;4969.0807200668;5255.737213139366;5361.597880159004;5385.461453854622;5423.538999185074;5424.891502169974;5876.177335173079;5935;5948.643081415129;5961.761529538813;5964.1650168976375;5889.558283128783;5915.408459154093;5915.852103697399;5929.14027466015;5930.822075337746;5537.141743029837;5597.6641401516035;5644.350899646511;5683.204351390808;5704.34400043992;6033.456988871023;6077.908831367533;6086.817395478054;6106.328303886569;6109.908351374733;5676.744546495418;5768.769249229984;5889.204957330791;5908.675022873697;5916.083007133901;5872.17789509469;5896.115582662549;5909.23179986599;5909.231799866076;5920.2303700519515;5859.033259512133;5866.530677545786;5871.266091738533;5874.148248504029;5893.852653683606;5878.059510478389;5879.265091863517;5940.524758019348;6001.789937352171;6051.364606716319;4515.864524064284;4560.749158796298;4575.084983003413;4576.908461830745;4576.908461830745;4065.8170382332273;4070;4077.347624380085;4077.4495443115393;4116.547179810218;5433.8369848904595;5500.257465242221;5535.778568857281;5566.137248726453;5584.050711379075;6074;6077.878442431127;6109.236345456818;6120.051392034242;6130.049842274455;5422.40353561108;5731.054376027909;5742.167385729046;5755.827325180251;5768.682722450306;5113.258577506241;5179.870503237449;5181.5854731621375;5207.739613019334;5241.292425522582;6029.939700602938;6052.455279024909;6077.696115194222;6090.695465226721;6100.0544915537275;5748.166515855261;5847.912281315868;5923.437273459014;5925.496332811759;5929.673867937305;6022.5784195105925;6094.664793436404;6107.206063211754;6107.9404219779035;6116.092308610808;5969.403059693996;5980.252468441445;6007.8197654070445;6007.90988135187;6021.42796434338;5759.827205183851;5888.411158884077;5899.026660601125;6095.51235901118;6096.420840020191;5823.330317013598;5823.94176058234;5829.329627092939;5839.5036421904615;5846.912296315473;5717.714114294352;5758.740856661544;5781.335146458211;5786.971065144816;5796.94203057964;5480.205370221375;5563.082091455027;5670.829875103588;5677.347105082803;5802.65184088956;5917.142014407801;5973.49225315853;5978.970105149447;5984.700764961822;5994.700264986646;5823.155642431909;5826.941730582809;5867.9413205867395;5877.794277200277;5878.882422351444 02:19:02 INFO - 2015-12-17 02:19:02,680 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.2351766321308;589.2604780999844;597.8834127345167;601.9909701354478;603.8339456649423;39273.80363098184;39910;39920.60079399205;39947.40078898819;40118;42906.57093429065;43355.56644433555;43528.12943741123;43597.34603980935;43646;8733.257673097794;8823.382363234576;8898.644054237855;8899.93200815903;8912.955435222848;8632.870506942401;8682.30541556674;8686.391952563323;8739.650413983432;8768.123187681245;8661.783455413633;8680.522571258578;8701.7824554386;8723.520206388646;8768.903887014123;8689.869651955225;8738.519381434018;8749.343799215052;8759.649614015432;8795.07651696569;8642.524661143634;8695.347848911357;8747.868781968276;8759;8763.298936085097;39602.40596391028;40162.79918600417;40317.79841100805;40321.59678403208;40426.595734042574;3312.2216279174377;3535.805530695811;3681.9263614727824;3826.9617303826885;3879.825407856625;29934.55098173529;30241.09276721702;30446.84776576103;31577.684223157932;31653.52519712206;3939.428782826503;3947.1118998225456;3960.2871483133313;4041.595840415964;4094.529129150156;261397;261707.69146154338;261851;261983;262519;55041.1743823843;55642.44357556454;55671.443285566624;55680.721596391755;55698.16452753212;54090.45909540933;55358;61687;63030.369696303365;63037;14051.578452646438;14161.929190353982;14162.64593385153;14223.502177423741;14286.357113929898;10938.124950003981;11058.612948546763;11077.889221107847;11125.888741112485;11156.776864462665;18744.906275468536;19084.04579771006;19130.139143738565;19213.615727685366;19269.903650481658;7496.6251687415415;7820.217978202134;7821.335186509096;7827.45207835446;7910.16943220965;979.3780949097375;1005.7083445800636;1009.8939611340703;1025.190099821148;1079.5627770752858;28479.430411391655;28617.14148575546;28805.42389152247;29328.853355733085;29407.85296073506;1049.9317544359592;1062.8033813744482;1081.670090622352;1092.082650573522;1106.9981666591586;14796;14850.257487125817;14893;15080.849191508163;15153.696926061417;327695;328242;330717;331752;331985;51952;52050.73974630103;52297.47702523002;52314.47685523096;52316.21525677118;1283.3583208395803;1284.6338793443824;1296.7341694952702;1299.2918859221747;1304.699919018612;27788.44423111486;27982.440351192454;28235.72939217781;28508.714912851436;28677;46076.539234607226;46577.53422465867;46634.300485493426;46666.300005499266;46679;309060;309063;311499;312984;313903;31512.36975260528;31937;32286.19284517812;32308.515372268965;32433.51349729803;37626.24747505089;37674.49302027888;38463.423048653734;38484;38492.42261366138;32886.177845554055;35574.288514229054;36510.4523432154;36837;37406.62593374032;33818.32363352768;35090.298194035466;35450.64549354473;35484.46773298454;36090.09774755652;34987.30025399427;34988.65011349854;34989;35280.823595881855;35465.29069418545;30682.539761903143;31531.52702709507;31698.524522132648;31967.840160799045;32113.678863212004;24281.271561853173;24456.755432445447;24799.256022319358;24809.25572232836;24843.254702358958 02:19:02 INFO - 2015-12-17 02:19:02,680 DEBUG : BROWSER_OUTPUT: |2;jquery.html;358.6771905285243;360.19316730523633;363.9927201455973;366.4905780964459;367.68930253935423;16360.672786544263;16699.916500417497;17304.999999999985;17675.292988280486;18218.81781182188;15909;16226.675466490693;16567.337306507725;16602.25289861956;16686.916565417185;4826.396700412449;5011.774470148834;5032.773525191357;5033.647644664875;5043.5208655177885;4950.133726597849;5042.84871453857;5045.419776725668;5054.1660625996665;5275.155975043994;5176.482351764831;5324.41431442541;5405.054115529786;5408.215808707735;5409.24270602116;5311.575073994071;5317.361916569997;5326.280952071479;5340.599455040888;5343.893122137555;5142.537171654569;5357.598180136466;5360.088784906537;5365.946340536584;5370.194470829368;12635.1787133836;12926.159799612995;16596.419125330554;20289.39131826033;20502.5899482011;2131.381899249216;2149.0758973641327;2160.0387827416807;2189.9233526826483;2277.749447560767;9671.70984870455;9683.612655493771;9724.173445257162;11960.521579136825;12483.438245278985;1825.9908700456413;1833.7524434201346;1843.6957901946162;1863.67385707502;1886.028695221948;61354.69322653358;63816;64016.35983640197;65063.99999999953;66851.66019189305;9962.252831037702;10304.742381440525;10341.9482902585;10389.53247103867;10427.165826733843;13400.329983500786;13469.326533673277;13502.594922152352;13574.117682350814;13586.524471643643;7272;7455.254474552501;7574.962125189449;7581.962090189514;7716.807079823049;7267.854642907218;7392.519486233377;7476.439267054884;7482.027336446227;7513.661885215179;4463.642908567307;4504.211762941472;4517.209488339593;4568.132054909556;4570.88572785683;1884.1709647755217;1886;1902.5909429472454;1957.9706304405445;1979.4853338132189;434.88910327866193;439.8064851465345;454.1847383945825;457.45562780291345;477.3817905811982;10819.188560857967;11386.487608057658;11587.478563464496;16715.08067056299;16893.15534223284;915.6200176926501;929.7077062882598;937.1659223291276;962.2157941277836;963.2149797914677;9621.18219951298;9897.35667181631;9957.651482198089;10000.0999910007;10052.949735251277;560461;563721;567975;569641;576298;80515.19484805193;82056.17943820605;83480;86157.56921215354;86575.13424865797;1146.6273461125002;1155.3183621663259;1161.814109742454;1171.4845467994055;1172.1794743679459;15169.696606068037;15555.922220388826;15645.921770391074;15661.921690391475;15669.373225071326;33880.83059584686;35139.472907906915;35462;36640.45039324359;37012;44544.331835021854;45087;45499.545004550855;45718;48254.03491930071;9624.470654114091;9693.176080032994;9778.65774697882;9834.901650983398;9860.605575776888;12906.943816540592;17572.648547029243;18084.276628934695;18280.360187393377;18391.080445977914;14140.363683634056;14439.85560144385;14921.104733716013;14977.453832848223;15322.310496027929;14321.928390357982;14397.42410303618;14406.351714173097;14468.638284042561;15004.474843380429;14256.073355231876;14272.429102835771;14334.713305734036;14431.278436077944;14717.705645886808;9351.53242337894;9408.858867116862;9454.432734035705;9684.95157524208;9689.515524223902;10179.880213176693;10188.89811101909;13962.58112256634;14805;14882.851171488579 02:19:02 INFO - 2015-12-17 02:19:02,681 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1494.4694633405134;1664.3425846790517;1708.7009773289678;1725.2150271626404;1729.7059499885017;7181.317774811398;7432.182459929417;7548.962255188723;7559.6598153083105;7646.92353076469;7620.65707043183;7658.770236892902;7679.7312094076715;7687.2312768723095;7741.303282704555;2180.814630756384;2212.9889350553226;2214.324630987548;2215.1139544182297;2227.187076716995;2244.136007637055;2272.36373815332;2303.1133013789727;2311.029367665576;2314.6296592545195;2185.1696355384934;2220.6113930062256;2221.911123555056;2222.388843068161;2249.718785151856;2189.4088596079127;2205.44863784054;2219.6004719150465;2222.0334154642783;2225.9109635614554;2246.8764217968005;2267.943301417461;2271.65925111233;2274.8976296066717;2276.658501224813;7420.628968551605;7460.179380268166;7478.962605186939;7521.05986751656;7522.172561018284;4537.818487260505;4584.426946631671;4589.931151032737;4622.976885115553;4626.352310676508;3000.6249218847643;3042.404627938871;3098.8760449582214;3098.8915387961315;3133.7336326412283;1007.4660429972126;1013.1185868294557;1043.9008294212038;1045.6078970386104;1050.2858056521563;9899.554520046544;9917.75205619858;9979.15177209938;10017.09846113846;10050.095491405735;3965.7422267553093;3990;3996.640302372742;4016.176683779818;4057.0668746188544;8178.223068808454;8262.876056859152;8269.669213231524;8273.793155171048;8286.171382861665;4481.663875209372;4498.932516012263;4500.909981800346;4513.029698614813;4538.546145385435;3792.4500947362476;3848.6536211741077;4125.711200215956;4156.709030367906;4208.579142085829;3581.0331210573;3596.1369271375206;3604.801735904498;3628;3647.1429214134655;1154.7748189103045;1155.7168493718925;1159.675290918544;1166.78414493319;1169.1757311095657;1340.376724822962;1342.2617560341773;1360.2178747220387;1364.7611667958067;1371.7942308653783;6369.681515924278;6450.8064758057335;6506.934930650727;6509.511786616023;7019.087518622547;1134.4214450630238;1137.4710759496875;1137.5449820071872;1137.9772404551863;1155.96532104037;5351.518363347317;5393.83818485446;5414.214938833847;5421.701806400607;5424.294841670637;8534.829303413897;8538.188872057144;8706.52114133716;8735.737927862174;8761.299096072298;8575.142485751376;8603.827923441497;8658.437201582003;8699.739007829776;8780.209781119729;6786.4570834333135;6803.727850885909;6948.5483443576;6952.339527744856;6976.162860456676;6679.165104361955;6716.6977486012265;6731.259561448139;6740.865182696417;6765.255821859493;7645.426593005435;7825.765227043198;7829.8825517618425;7860.253275938777;7927.603619819101;7889.289963903277;7952.84094318122;8044.477108987897;8058.435909486279;8060.952076230053;5579.972100139474;5701.087825947829;5964.075568286922;6352.587081839665;6434.8391290218115;7097.858042839218;7126.964365178141;7127.073480447509;7159.928400715926;7165.104361954755;6529.412352888263;6607.108040414675;6683.699233534599;6693.598384096969;6749.223839258548;6427.839304017437;6486.481081513373;6635.933640663531;6681.732730690718;6771.86456270862;6745;6757.290484499057;6772.051912732123;6772.0857684212;6785.830354240986;6028.0181089018315;6155.507559395327;6191.133241346305;6201.10084037821;6201.379862013762;6202.7208775606105;6204.286507051746;6213.1922850029205;6218.315985241529;6236.126942228182 02:19:02 INFO - 2015-12-17 02:19:02,685 DEBUG : BROWSER_OUTPUT: |4;prototype.html;333.225251290749;338.734093736417;341.9675130862567;345.0992908508792;347.67492394611025;6319.810405687826;6389.520785941049;6419.743210271589;6432;6481.449076828475;6349.253955162333;6355.3009168991375;6407.231132264134;6409.839754006152;6420.133282006927;4837.951620483803;4837.975810120962;4841.724389536912;4845.2247640377545;4853.150698627726;4847.6606637535215;4853.296272040552;4854.296127061574;4855.077535268305;4857.319975203474;4560.749158796265;4638.605718513931;4744.525547445245;4746.21687421575;4746.5490778376;4729.6452766042685;4740.123077230689;4741.857744267678;4746.074515469485;4751.477337492873;4109.137081212949;4114.115465174972;4117.629413352783;4122.051928056564;4128.483939507561;6012.729427175744;6027.065804800263;6027.945109605801;6029.366916473751;6042.728077236535;5460.372057213432;5550.611457197998;5555.166724991243;5556.16657501378;5556.222128901957;6658.533902626818;6679.666016699194;6679.9980002999455;6688.63212523311;6694;4558.544145585448;4570.405847239871;4577.427821522309;4583.610393116589;4588.357629931812;6782.694778734969;6906.654667266666;6969.163700355939;6999.12510936133;7000.334968178015;4681.063787242565;4687.109449204709;4692.741899195509;4693.155232058262;4693.78877950493;4739.218029025241;4749.738764367924;4751.714897106184;4756.21522448799;4766.285057241372;5526.364468086222;5530.087535556588;5534.169874518854;5535.391106978229;5540;6623.503237257225;6734.629595372302;6746.515766531355;6749.763758268437;6754.898676519856;1665.0592415285325;1681.0502066332483;1684.7388654758531;1685.292177285543;1688.2487293154675;1108.6064447121316;1116.17403121691;1116.3357802107896;1127.2954403497813;1130.1354463835173;6502.544821862424;6502.967485162639;6503.8699226015215;6514.022896565553;6514.934850651528;6963.547369420971;6987.720491180397;6997.230304666483;7011.263817299212;7013.929860701328;6457.3865482779065;6466.418022378009;6510.414062734377;6586.73653053882;6593.175853018372;3786.3373909565717;3806.3909774435956;3820.4460353248624;3828.1769419574925;3849.8075096245075;7292.161401438902;7300.8174795629475;7303.087114110736;7342.77971660851;7358.448116391292;7087.220405755363;7264.091988501437;7269.927300726925;7271.309225623558;7279;7266.709331626781;7290.890636640454;7315.378192853667;7326.816829579303;7331.706731730777;6927.480438966997;7016.5790052597;7024.8595028098125;7032.050673159262;7034.753783617549;6912.239653637996;6958;6969.895451568129;6971.860562788817;6973.442124630119;7309.451791115581;7311.086114235721;7325.340719335285;7332.523385979895;7338.522996005243;4721.504242054535;4755.334253204624;4764.118638051971;4768.594669452997;4771.1888978872985;6879.6560171992205;6963.9303606963285;7014.649267536704;7021.332973367522;7022.332878376546;6824.4199243064895;6840.931590684029;6841.726330946706;6853.725850965906;6854.725810967506;6668.133142691419;6789.456843452611;6789.89815152783;6796.932030679828;6827;6627.834304142242;6628.138342015507;6675.0654908313845;6679.265280819203;6679.632620205741;6849.726010959505;6853.109095817512;6858.417034552119;6860.965695171492;6868.793936181923;6502.837429064311;6607.47140228771;6683.331666833472;6690.531662783558;6696.59820410777 02:19:02 INFO - 2015-12-17 02:19:02,686 DEBUG : BROWSER_OUTPUT: |5;yui.html;839.6557411461303;851.5444237333028;853.7908212487941;865.0354854337412;867.8481265778489;11669.591564295251;12024.939875300612;12029.398530073495;12074.939625301884;12137.089718271121;12977.091603587753;13047.543335983242;14365.35355908984;14565.344559494823;14633.195174265411;811.419834818105;816.6610856494577;819.4304958054155;823.4112609484217;825.9504429734235;815.7389635316702;817.7873752824279;819.9996004874045;820.0528389709895;825.7440193539992;851.5188918261193;862.0431321233426;864.6627815152095;867.0419186798591;867.440500876934;846.1200351634293;848.7368915636173;849.9022612399591;858.2447446247324;867.5402036920442;631.1763149090435;631.4664108828033;633.2907143998705;634.1692382978313;643.893757530007;13367.732645347136;13618.795718064237;13734.381952812148;13758.449662013507;13775.104618199784;11414.657560273205;11592.710182245428;12007.339596322287;12326.630201093893;13022.088453808237;9646.710598682052;10280.434576098312;10412.895871041344;10549.9472502637;10813.567457301699;3513.350030244387;3608.1340478285283;3635.3638113330326;3664.5052917856015;3671.320805650963;44144.779276103414;44527;46465.53534464646;46685.29972050456;50413.747931260106;9408.96501384847;9719.125278724949;9877.703668889944;10015.483742070797;10193.643222487177;15808.288627011812;15817.604559886095;15851.207439628202;15852.44516441919;15939.203039847962;7709.614519274014;7737.8452430951065;7743.109542402583;7865.921340786519;8070.798230044295;4415.050764085737;4418.60232579063;4423.181711383404;4424.358468022118;4429.379886815848;3039.6200474940633;3047.207725991258;3070.631524217108;3079.7228249457658;3087.768417368706;541.5992165797281;562.3392513796273;567.8722287485283;569.4533248081888;570.6034306157264;602.9872581872792;624.8687775567091;675.8546912413756;702.034702284359;728.457299312016;8564.3148548116;8585.527795971157;8638.308935285162;8706.956465217634;8776.692815751545;692.3768608252612;698.2458944340101;713.7252157919238;729.3144444222414;734.1483878700682;3664.6518580734787;4007.7595344279434;4092.161106973123;4101.097758493186;4132.297509423405;60469.09296360558;60476;60646.69676651677;61009;62343.37656623466;54948.17577736337;55392;55641.443585563626;56402;57025.71487142621;46563.534364656596;48147.75926120347;50654.74672626613;50917.236241456405;53145.734271328394;8283.95858020706;8372.28835548985;8577.528235946833;8627.482351058956;8897.73306800797;34007.63969441195;34295.828520857234;34493.827530863186;34671;34716.47925281173;41486;41616.3757543631;42833.78583107064;45077.77461112673;45091.77454112709;10760.730981725519;11005.944970275417;11013.614523491638;11284.548618055185;11349.943250283695;11468.756039904492;11966.401679916144;12329.14338222422;12492.812607811073;12548;10608.575656973635;10674.62638807638;10739.194560407845;10815.51330190159;11312.490937907978;11299.152563557602;11594.88405115938;11775.76448471043;11957.402129893644;12020.579279725167;10320.845187322346;10391.740206494596;10408.219383546113;10413.895861041292;10418.583256669648;9722.465264410524;9952.154066904393;10036.749081273027;10236.232282578687;10551.683449496528;8846.446833193137;9320.300977426585;9435.575399107194;9958.15355694745;10118.59525618967 02:19:02 INFO - 2015-12-17 02:19:02,686 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:19:02 INFO - 2015-12-17 02:19:02,686 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:19:02 INFO - 2015-12-17 02:19:02,686 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,316 02:19:02 INFO - 2015-12-17 02:19:02,686 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:19:02 INFO - 2015-12-17 02:19:02,686 DEBUG : BROWSER_OUTPUT: __startTimestamp1450347542676__endTimestamp 02:19:02 INFO - 2015-12-17 02:19:02,687 DEBUG : BROWSER_OUTPUT: 02:19:02 INFO - 2015-12-17 02:19:02,687 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:19:02 INFO - 2015-12-17 02:19:02,687 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:19:02 INFO - 2015-12-17 02:19:02,687 DEBUG : BROWSER_OUTPUT: 02:19:02 INFO - 2015-12-17 02:19:02,687 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5513.84 Median:5759.83 stddev:624.49 (10.8%) stddev-sans-first:600.27 02:19:02 INFO - 2015-12-17 02:19:02,687 DEBUG : BROWSER_OUTPUT: Values: 3235.0 3262.4 3288.4 3304.0 3320.3 5333.8 5379.2 5411.1 5443.6 5457.6 5469.1 5484.7 5506.4 5508.4 5543.6 4758.0 5016.8 5198.3 5209.3 5212.2 4932.1 5134.7 5138.1 5156.4 5207.2 4931.8 4948.3 4954.8 4967.3 5083.4 4954.5 4959.2 4966.2 4967.9 5016.5 4900.4 4946.7 4949.3 4965.7 4969.1 5255.7 5361.6 5385.5 5423.5 5424.9 5876.2 5935.0 5948.6 5961.8 5964.2 5889.6 5915.4 5915.9 5929.1 5930.8 5537.1 5597.7 5644.4 5683.2 5704.3 6033.5 6077.9 6086.8 6106.3 6109.9 5676.7 5768.8 5889.2 5908.7 5916.1 5872.2 5896.1 5909.2 5909.2 5920.2 5859.0 5866.5 5871.3 5874.1 5893.9 5878.1 5879.3 5940.5 6001.8 6051.4 4515.9 4560.7 4575.1 4576.9 4576.9 4065.8 4070.0 4077.3 4077.4 4116.5 5433.8 5500.3 5535.8 5566.1 5584.1 6074.0 6077.9 6109.2 6120.1 6130.0 5422.4 5731.1 5742.2 5755.8 5768.7 5113.3 5179.9 5181.6 5207.7 5241.3 6029.9 6052.5 6077.7 6090.7 6100.1 5748.2 5847.9 5923.4 5925.5 5929.7 6022.6 6094.7 6107.2 6107.9 6116.1 5969.4 5980.3 6007.8 6007.9 6021.4 5759.8 5888.4 5899.0 6095.5 6096.4 5823.3 5823.9 5829.3 5839.5 5846.9 5717.7 5758.7 5781.3 5787.0 5796.9 5480.2 5563.1 5670.8 5677.3 5802.7 5917.1 5973.5 5979.0 5984.7 5994.7 5823.2 5826.9 5867.9 5877.8 5878.9 02:19:02 INFO - 2015-12-17 02:19:02,687 DEBUG : BROWSER_OUTPUT: 02:19:02 INFO - 2015-12-17 02:19:02,687 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46760.89 Median:35529.38 stddev:79130.57 (222.7%) stddev-sans-first:79276.50 02:19:02 INFO - 2015-12-17 02:19:02,687 DEBUG : BROWSER_OUTPUT: Values: 556.2 589.3 597.9 602.0 603.8 39273.8 39910.0 39920.6 39947.4 40118.0 42906.6 43355.6 43528.1 43597.3 43646.0 8733.3 8823.4 8898.6 8899.9 8913.0 8632.9 8682.3 8686.4 8739.7 8768.1 8661.8 8680.5 8701.8 8723.5 8768.9 8689.9 8738.5 8749.3 8759.6 8795.1 8642.5 8695.3 8747.9 8759.0 8763.3 39602.4 40162.8 40317.8 40321.6 40426.6 3312.2 3535.8 3681.9 3827.0 3879.8 29934.6 30241.1 30446.8 31577.7 31653.5 3939.4 3947.1 3960.3 4041.6 4094.5 261397.0 261707.7 261851.0 261983.0 262519.0 55041.2 55642.4 55671.4 55680.7 55698.2 54090.5 55358.0 61687.0 63030.4 63037.0 14051.6 14161.9 14162.6 14223.5 14286.4 10938.1 11058.6 11077.9 11125.9 11156.8 18744.9 19084.0 19130.1 19213.6 19269.9 7496.6 7820.2 7821.3 7827.5 7910.2 979.4 1005.7 1009.9 1025.2 1079.6 28479.4 28617.1 28805.4 29328.9 29407.9 1049.9 1062.8 1081.7 1092.1 1107.0 14796.0 14850.3 14893.0 15080.8 15153.7 327695.0 328242.0 330717.0 331752.0 331985.0 51952.0 52050.7 52297.5 52314.5 52316.2 1283.4 1284.6 1296.7 1299.3 1304.7 27788.4 27982.4 28235.7 28508.7 28677.0 46076.5 46577.5 46634.3 46666.3 46679.0 309060.0 309063.0 311499.0 312984.0 313903.0 31512.4 31937.0 32286.2 32308.5 32433.5 37626.2 37674.5 38463.4 38484.0 38492.4 32886.2 35574.3 36510.5 36837.0 37406.6 33818.3 35090.3 35450.6 35484.5 36090.1 34987.3 34988.7 34989.0 35280.8 35465.3 30682.5 31531.5 31698.5 31967.8 32113.7 24281.3 24456.8 24799.3 24809.3 24843.3 02:19:02 INFO - 2015-12-17 02:19:02,687 DEBUG : BROWSER_OUTPUT: 02:19:02 INFO - 2015-12-17 02:19:02,687 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29664.37 Median:18504.07 stddev:92817.03 (501.6%) stddev-sans-first:93051.32 02:19:02 INFO - 2015-12-17 02:19:02,689 DEBUG : BROWSER_OUTPUT: Values: 358.7 360.2 364.0 366.5 367.7 16360.7 16699.9 17305.0 17675.3 18218.8 15909.0 16226.7 16567.3 16602.3 16686.9 4826.4 5011.8 5032.8 5033.6 5043.5 4950.1 5042.8 5045.4 5054.2 5275.2 5176.5 5324.4 5405.1 5408.2 5409.2 5311.6 5317.4 5326.3 5340.6 5343.9 5142.5 5357.6 5360.1 5365.9 5370.2 12635.2 12926.2 16596.4 20289.4 20502.6 2131.4 2149.1 2160.0 2189.9 2277.7 9671.7 9683.6 9724.2 11960.5 12483.4 1826.0 1833.8 1843.7 1863.7 1886.0 61354.7 63816.0 64016.4 65064.0 66851.7 9962.3 10304.7 10341.9 10389.5 10427.2 13400.3 13469.3 13502.6 13574.1 13586.5 7272.0 7455.3 7575.0 7582.0 7716.8 7267.9 7392.5 7476.4 7482.0 7513.7 4463.6 4504.2 4517.2 4568.1 4570.9 1884.2 1886.0 1902.6 1958.0 1979.5 434.9 439.8 454.2 457.5 477.4 10819.2 11386.5 11587.5 16715.1 16893.2 915.6 929.7 937.2 962.2 963.2 9621.2 9897.4 9957.7 10000.1 10052.9 560461.0 563721.0 567975.0 569641.0 576298.0 80515.2 82056.2 83480.0 86157.6 86575.1 1146.6 1155.3 1161.8 1171.5 1172.2 15169.7 15555.9 15645.9 15661.9 15669.4 33880.8 35139.5 35462.0 36640.5 37012.0 44544.3 45087.0 45499.5 45718.0 48254.0 9624.5 9693.2 9778.7 9834.9 9860.6 12906.9 17572.6 18084.3 18280.4 18391.1 14140.4 14439.9 14921.1 14977.5 15322.3 14321.9 14397.4 14406.4 14468.6 15004.5 14256.1 14272.4 14334.7 14431.3 14717.7 9351.5 9408.9 9454.4 9685.0 9689.5 10179.9 10188.9 13962.6 14805.0 14882.9 02:19:02 INFO - 2015-12-17 02:19:02,689 DEBUG : BROWSER_OUTPUT: 02:19:02 INFO - 2015-12-17 02:19:02,689 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5180.32 Median:6091.76 stddev:2586.40 (42.5%) stddev-sans-first:2578.82 02:19:02 INFO - 2015-12-17 02:19:02,689 DEBUG : BROWSER_OUTPUT: Values: 1494.5 1664.3 1708.7 1725.2 1729.7 7181.3 7432.2 7549.0 7559.7 7646.9 7620.7 7658.8 7679.7 7687.2 7741.3 2180.8 2213.0 2214.3 2215.1 2227.2 2244.1 2272.4 2303.1 2311.0 2314.6 2185.2 2220.6 2221.9 2222.4 2249.7 2189.4 2205.4 2219.6 2222.0 2225.9 2246.9 2267.9 2271.7 2274.9 2276.7 7420.6 7460.2 7479.0 7521.1 7522.2 4537.8 4584.4 4589.9 4623.0 4626.4 3000.6 3042.4 3098.9 3098.9 3133.7 1007.5 1013.1 1043.9 1045.6 1050.3 9899.6 9917.8 9979.2 10017.1 10050.1 3965.7 3990.0 3996.6 4016.2 4057.1 8178.2 8262.9 8269.7 8273.8 8286.2 4481.7 4498.9 4500.9 4513.0 4538.5 3792.5 3848.7 4125.7 4156.7 4208.6 3581.0 3596.1 3604.8 3628.0 3647.1 1154.8 1155.7 1159.7 1166.8 1169.2 1340.4 1342.3 1360.2 1364.8 1371.8 6369.7 6450.8 6506.9 6509.5 7019.1 1134.4 1137.5 1137.5 1138.0 1156.0 5351.5 5393.8 5414.2 5421.7 5424.3 8534.8 8538.2 8706.5 8735.7 8761.3 8575.1 8603.8 8658.4 8699.7 8780.2 6786.5 6803.7 6948.5 6952.3 6976.2 6679.2 6716.7 6731.3 6740.9 6765.3 7645.4 7825.8 7829.9 7860.3 7927.6 7889.3 7952.8 8044.5 8058.4 8061.0 5580.0 5701.1 5964.1 6352.6 6434.8 7097.9 7127.0 7127.1 7159.9 7165.1 6529.4 6607.1 6683.7 6693.6 6749.2 6427.8 6486.5 6635.9 6681.7 6771.9 6745.0 6757.3 6772.1 6772.1 6785.8 6028.0 6155.5 6191.1 6201.1 6201.4 6202.7 6204.3 6213.2 6218.3 6236.1 02:19:02 INFO - 2015-12-17 02:19:02,690 DEBUG : BROWSER_OUTPUT: 02:19:02 INFO - 2015-12-17 02:19:02,690 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5642.47 Median:6473.93 stddev:1734.21 (26.8%) stddev-sans-first:1692.67 02:19:02 INFO - 2015-12-17 02:19:02,690 DEBUG : BROWSER_OUTPUT: Values: 333.2 338.7 342.0 345.1 347.7 6319.8 6389.5 6419.7 6432.0 6481.4 6349.3 6355.3 6407.2 6409.8 6420.1 4838.0 4838.0 4841.7 4845.2 4853.2 4847.7 4853.3 4854.3 4855.1 4857.3 4560.7 4638.6 4744.5 4746.2 4746.5 4729.6 4740.1 4741.9 4746.1 4751.5 4109.1 4114.1 4117.6 4122.1 4128.5 6012.7 6027.1 6027.9 6029.4 6042.7 5460.4 5550.6 5555.2 5556.2 5556.2 6658.5 6679.7 6680.0 6688.6 6694.0 4558.5 4570.4 4577.4 4583.6 4588.4 6782.7 6906.7 6969.2 6999.1 7000.3 4681.1 4687.1 4692.7 4693.2 4693.8 4739.2 4749.7 4751.7 4756.2 4766.3 5526.4 5530.1 5534.2 5535.4 5540.0 6623.5 6734.6 6746.5 6749.8 6754.9 1665.1 1681.1 1684.7 1685.3 1688.2 1108.6 1116.2 1116.3 1127.3 1130.1 6502.5 6503.0 6503.9 6514.0 6514.9 6963.5 6987.7 6997.2 7011.3 7013.9 6457.4 6466.4 6510.4 6586.7 6593.2 3786.3 3806.4 3820.4 3828.2 3849.8 7292.2 7300.8 7303.1 7342.8 7358.4 7087.2 7264.1 7269.9 7271.3 7279.0 7266.7 7290.9 7315.4 7326.8 7331.7 6927.5 7016.6 7024.9 7032.1 7034.8 6912.2 6958.0 6969.9 6971.9 6973.4 7309.5 7311.1 7325.3 7332.5 7338.5 4721.5 4755.3 4764.1 4768.6 4771.2 6879.7 6963.9 7014.6 7021.3 7022.3 6824.4 6840.9 6841.7 6853.7 6854.7 6668.1 6789.5 6789.9 6796.9 6827.0 6627.8 6628.1 6675.1 6679.3 6679.6 6849.7 6853.1 6858.4 6861.0 6868.8 6502.8 6607.5 6683.3 6690.5 6696.6 02:19:02 INFO - 2015-12-17 02:19:02,690 DEBUG : BROWSER_OUTPUT: 02:19:02 INFO - 2015-12-17 02:19:02,690 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13924.55 Median:45084.77 stddev:16546.56 (36.7%) stddev-sans-first:16563.80 02:19:02 INFO - 2015-12-17 02:19:02,691 DEBUG : BROWSER_OUTPUT: Values: 839.7 851.5 853.8 865.0 867.8 11669.6 12024.9 12029.4 12074.9 12137.1 12977.1 13047.5 14365.4 14565.3 14633.2 811.4 816.7 819.4 823.4 826.0 815.7 817.8 820.0 820.1 825.7 851.5 862.0 864.7 867.0 867.4 846.1 848.7 849.9 858.2 867.5 631.2 631.5 633.3 634.2 643.9 13367.7 13618.8 13734.4 13758.4 13775.1 11414.7 11592.7 12007.3 12326.6 13022.1 9646.7 10280.4 10412.9 10549.9 10813.6 3513.4 3608.1 3635.4 3664.5 3671.3 44144.8 44527.0 46465.5 46685.3 50413.7 9409.0 9719.1 9877.7 10015.5 10193.6 15808.3 15817.6 15851.2 15852.4 15939.2 7709.6 7737.8 7743.1 7865.9 8070.8 4415.1 4418.6 4423.2 4424.4 4429.4 3039.6 3047.2 3070.6 3079.7 3087.8 541.6 562.3 567.9 569.5 570.6 603.0 624.9 675.9 702.0 728.5 8564.3 8585.5 8638.3 8707.0 8776.7 692.4 698.2 713.7 729.3 734.1 3664.7 4007.8 4092.2 4101.1 4132.3 60469.1 60476.0 60646.7 61009.0 62343.4 54948.2 55392.0 55641.4 56402.0 57025.7 46563.5 48147.8 50654.7 50917.2 53145.7 8284.0 8372.3 8577.5 8627.5 8897.7 34007.6 34295.8 34493.8 34671.0 34716.5 41486.0 41616.4 42833.8 45077.8 45091.8 10760.7 11005.9 11013.6 11284.5 11349.9 11468.8 11966.4 12329.1 12492.8 12548.0 10608.6 10674.6 10739.2 10815.5 11312.5 11299.2 11594.9 11775.8 11957.4 12020.6 10320.8 10391.7 10408.2 10413.9 10418.6 9722.5 9952.2 10036.7 10236.2 10551.7 8846.4 9320.3 9435.6 9958.2 10118.6 02:19:02 INFO - 2015-12-17 02:19:02,691 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:19:02 INFO - 2015-12-17 02:19:02,691 DEBUG : BROWSER_OUTPUT: 02:19:03 INFO - 2015-12-17 02:19:03,357 INFO : Browser exited with error code: 0 02:19:03 INFO - 2015-12-17 02:19:03,378 INFO : Completed test dromaeo_css (00:18:31) 02:19:03 INFO - 2015-12-17 02:19:03,378 INFO : Starting test kraken 02:19:03 INFO - 2015-12-17 02:19:03,378 DEBUG : operating with platform_type : linux_ 02:19:03 INFO - 2015-12-17 02:19:03,379 INFO : Initialising browser for kraken test... 02:19:03 INFO - 2015-12-17 02:19:03,385 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppxVpqx/profile http://localhost:35694/getInfo.html 02:19:07 INFO - 2015-12-17 02:19:07,945 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:19:07 INFO - 2015-12-17 02:19:07,945 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:19:07 INFO - 2015-12-17 02:19:07,945 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:19:07 INFO - 2015-12-17 02:19:07,945 DEBUG : BROWSER_OUTPUT: __metrics 02:19:08 INFO - 2015-12-17 02:19:08,086 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:19:08 INFO - 2015-12-17 02:19:08,949 INFO : Browser initialized. 02:19:08 INFO - 2015-12-17 02:19:08,950 INFO : Running cycle 1/1 for kraken test... 02:19:08 INFO - 2015-12-17 02:19:08,950 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppxVpqx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:19:20 INFO - 2015-12-17 02:19:20,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 143138816 02:19:20 INFO - 2015-12-17 02:19:20,846 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2015-12-17 02:19:23,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35694/tests/kraken/driver.html?testName=audio-beat-detection) 02:19:23 INFO - 2015-12-17 02:19:23,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 144748544 02:19:23 INFO - 2015-12-17 02:19:23,936 DEBUG : BROWSER_OUTPUT: 02:19:26 INFO - 2015-12-17 02:19:26,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35694/tests/kraken/driver.html?testName=audio-dft) 02:19:27 INFO - 2015-12-17 02:19:27,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 144142336 02:19:27 INFO - 2015-12-17 02:19:27,196 DEBUG : BROWSER_OUTPUT: 02:19:30 INFO - 2015-12-17 02:19:30,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35694/tests/kraken/driver.html?testName=audio-fft) 02:19:30 INFO - 2015-12-17 02:19:30,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 137748480 02:19:30 INFO - 2015-12-17 02:19:30,640 DEBUG : BROWSER_OUTPUT: 02:19:32 INFO - 2015-12-17 02:19:32,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35694/tests/kraken/driver.html?testName=audio-oscillator) 02:19:33 INFO - 2015-12-17 02:19:33,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 138387456 02:19:33 INFO - 2015-12-17 02:19:33,437 DEBUG : BROWSER_OUTPUT: 02:19:35 INFO - 2015-12-17 02:19:35,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35694/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:19:36 INFO - 2015-12-17 02:19:36,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 139280384 02:19:36 INFO - 2015-12-17 02:19:36,225 DEBUG : BROWSER_OUTPUT: 02:19:39 INFO - 2015-12-17 02:19:39,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35694/tests/kraken/driver.html?testName=imaging-darkroom) 02:19:39 INFO - 2015-12-17 02:19:39,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 140136448 02:19:39 INFO - 2015-12-17 02:19:39,764 DEBUG : BROWSER_OUTPUT: 02:19:43 INFO - 2015-12-17 02:19:43,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35694/tests/kraken/driver.html?testName=imaging-desaturate) 02:19:43 INFO - 2015-12-17 02:19:43,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 141676544 02:19:43 INFO - 2015-12-17 02:19:43,736 DEBUG : BROWSER_OUTPUT: 02:19:46 INFO - 2015-12-17 02:19:46,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35694/tests/kraken/driver.html?testName=json-parse-financial) 02:19:47 INFO - 2015-12-17 02:19:47,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 140177408 02:19:47 INFO - 2015-12-17 02:19:47,171 DEBUG : BROWSER_OUTPUT: 02:19:48 INFO - 2015-12-17 02:19:48,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35694/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:19:49 INFO - 2015-12-17 02:19:49,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 141791232 02:19:49 INFO - 2015-12-17 02:19:49,331 DEBUG : BROWSER_OUTPUT: 02:19:51 INFO - 2015-12-17 02:19:51,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35694/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:19:51 INFO - 2015-12-17 02:19:51,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 140808192 02:19:51 INFO - 2015-12-17 02:19:51,757 DEBUG : BROWSER_OUTPUT: 02:19:53 INFO - 2015-12-17 02:19:53,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35694/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:19:54 INFO - 2015-12-17 02:19:54,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 141090816 02:19:54 INFO - 2015-12-17 02:19:54,465 DEBUG : BROWSER_OUTPUT: 02:19:56 INFO - 2015-12-17 02:19:56,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:19:57 INFO - 2015-12-17 02:19:57,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 141598720 02:19:57 INFO - 2015-12-17 02:19:57,534 DEBUG : BROWSER_OUTPUT: 02:20:00 INFO - 2015-12-17 02:20:00,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:20:00 INFO - 2015-12-17 02:20:00,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 141008896 02:20:00 INFO - 2015-12-17 02:20:00,700 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35694/tests/kraken/driver.html?testName=ai-astar) 02:20:02 INFO - 2015-12-17 02:20:02,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 142221312 02:20:02 INFO - 2015-12-17 02:20:02,605 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,605 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:20:02 INFO - 2015-12-17 02:20:02,606 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:20:02 INFO - 2015-12-17 02:20:02,607 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:20:02 INFO - 2015-12-17 02:20:02,607 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:20:02 INFO - 2015-12-17 02:20:02,607 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;107;110;111;114;122;112;111;112;111 02:20:02 INFO - 2015-12-17 02:20:02,607 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;124;149;164;131;161;159;125;159;124 02:20:02 INFO - 2015-12-17 02:20:02,608 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;163;162;160;165;166;171;162 02:20:02 INFO - 2015-12-17 02:20:02,608 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;73;73;73;71;71;141;71;71 02:20:02 INFO - 2015-12-17 02:20:02,608 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;140;94;94;94;134;93;94;143 02:20:02 INFO - 2015-12-17 02:20:02,608 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;110;110;109;110;111;109;109 02:20:02 INFO - 2015-12-17 02:20:02,608 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;146;146;146;147;146;147;147 02:20:02 INFO - 2015-12-17 02:20:02,608 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;96;96;97;100;96;96;96;96 02:20:02 INFO - 2015-12-17 02:20:02,608 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;59;61;62;62;59;60;58;62 02:20:02 INFO - 2015-12-17 02:20:02,609 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;68;69;70;69;68;68;71;72 02:20:02 INFO - 2015-12-17 02:20:02,609 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;85;86;85;93;86;87;87;86;95 02:20:02 INFO - 2015-12-17 02:20:02,609 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;116;117;126;126;121;129;128;134;123 02:20:02 INFO - 2015-12-17 02:20:02,609 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;152;151;149;152;140;156;150;154;147 02:20:02 INFO - 2015-12-17 02:20:02,609 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;67;66;67;68;66;67;67;67 02:20:02 INFO - 2015-12-17 02:20:02,609 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:20:02 INFO - 2015-12-17 02:20:02,609 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:20:02 INFO - 2015-12-17 02:20:02,610 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,724 02:20:02 INFO - 2015-12-17 02:20:02,610 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:20:02 INFO - 2015-12-17 02:20:02,610 DEBUG : BROWSER_OUTPUT: __startTimestamp1450347602604__endTimestamp 02:20:02 INFO - 2015-12-17 02:20:02,610 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,617 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:3.90 (3.5%) stddev-sans-first:4.12 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: Values: 111.0 107.0 110.0 111.0 114.0 122.0 112.0 111.0 112.0 111.0 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.70 Median:155.00 stddev:16.79 (10.8%) stddev-sans-first:17.66 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: Values: 151.0 124.0 149.0 164.0 131.0 161.0 159.0 125.0 159.0 124.0 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.10 (1.9%) stddev-sans-first:3.23 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 163.0 162.0 160.0 165.0 166.0 171.0 162.0 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.60 Median:71.00 stddev:21.95 (30.9%) stddev-sans-first:23.10 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 73.0 73.0 73.0 71.0 71.0 141.0 71.0 71.0 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.00 stddev:21.99 (23.4%) stddev-sans-first:22.70 02:20:02 INFO - 2015-12-17 02:20:02,618 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 140.0 94.0 94.0 94.0 134.0 93.0 94.0 143.0 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 110.0 110.0 109.0 110.0 111.0 109.0 109.0 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.25 (1.3%) stddev-sans-first:1.32 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 96.0 96.0 97.0 100.0 96.0 96.0 96.0 96.0 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.50 stddev:1.42 (2.3%) stddev-sans-first:1.50 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 59.0 61.0 62.0 62.0 59.0 60.0 58.0 62.0 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:1.52 (2.2%) stddev-sans-first:1.41 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 68.0 69.0 70.0 69.0 68.0 68.0 71.0 72.0 02:20:02 INFO - 2015-12-17 02:20:02,619 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,620 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.00 stddev:3.43 (3.9%) stddev-sans-first:3.63 02:20:02 INFO - 2015-12-17 02:20:02,620 DEBUG : BROWSER_OUTPUT: Values: 87.0 85.0 86.0 85.0 93.0 86.0 87.0 87.0 86.0 95.0 02:20:02 INFO - 2015-12-17 02:20:02,620 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,620 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:126.00 stddev:5.96 (4.7%) stddev-sans-first:5.81 02:20:02 INFO - 2015-12-17 02:20:02,620 DEBUG : BROWSER_OUTPUT: Values: 117.0 116.0 117.0 126.0 126.0 121.0 129.0 128.0 134.0 123.0 02:20:02 INFO - 2015-12-17 02:20:02,620 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,620 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:151.50 stddev:5.22 (3.4%) stddev-sans-first:4.62 02:20:02 INFO - 2015-12-17 02:20:02,620 DEBUG : BROWSER_OUTPUT: Values: 141.0 152.0 151.0 149.0 152.0 140.0 156.0 150.0 154.0 147.0 02:20:02 INFO - 2015-12-17 02:20:02,620 DEBUG : BROWSER_OUTPUT: 02:20:02 INFO - 2015-12-17 02:20:02,620 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 02:20:02 INFO - 2015-12-17 02:20:02,620 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 66.0 67.0 68.0 66.0 67.0 67.0 67.0 02:20:02 INFO - 2015-12-17 02:20:02,620 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:20:02 INFO - 2015-12-17 02:20:02,620 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2015-12-17 02:20:03,449 INFO : Browser exited with error code: 0 02:20:03 INFO - 2015-12-17 02:20:03,503 INFO : Completed test kraken (00:01:00) 02:20:03 INFO - 2015-12-17 02:20:03,503 INFO : Starting test v8_7 02:20:03 INFO - 2015-12-17 02:20:03,503 DEBUG : operating with platform_type : linux_ 02:20:03 INFO - 2015-12-17 02:20:03,503 INFO : Initialising browser for v8_7 test... 02:20:03 INFO - 2015-12-17 02:20:03,509 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX7m6c2/profile http://localhost:35694/getInfo.html 02:20:08 INFO - 2015-12-17 02:20:08,252 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:20:08 INFO - 2015-12-17 02:20:08,252 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:20:08 INFO - 2015-12-17 02:20:08,252 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:20:08 INFO - 2015-12-17 02:20:08,252 DEBUG : BROWSER_OUTPUT: __metrics 02:20:08 INFO - 2015-12-17 02:20:08,357 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:20:09 INFO - 2015-12-17 02:20:09,205 INFO : Browser initialized. 02:20:09 INFO - 2015-12-17 02:20:09,206 INFO : Running cycle 1/1 for v8_7 test... 02:20:09 INFO - 2015-12-17 02:20:09,206 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX7m6c2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:20:21 INFO - 2015-12-17 02:20:21,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 143802368 02:20:21 INFO - 2015-12-17 02:20:21,083 DEBUG : BROWSER_OUTPUT: 02:20:42 INFO - 2015-12-17 02:20:42,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35694/tests/v8_7/run.html (next: http://localhost:35694/tests/v8_7/run.html) 02:20:42 INFO - 2015-12-17 02:20:42,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 138620928 02:20:42 INFO - 2015-12-17 02:20:42,737 DEBUG : BROWSER_OUTPUT: 02:20:42 INFO - 2015-12-17 02:20:42,737 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:20:42 INFO - 2015-12-17 02:20:42,737 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:20:42 INFO - 2015-12-17 02:20:42,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:20:42 INFO - 2015-12-17 02:20:42,738 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:20:42 INFO - 2015-12-17 02:20:42,738 DEBUG : BROWSER_OUTPUT: |0;Richards;168.54879487611663 02:20:42 INFO - 2015-12-17 02:20:42,738 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.65246762994934 02:20:42 INFO - 2015-12-17 02:20:42,738 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.37310073157005 02:20:42 INFO - 2015-12-17 02:20:42,739 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 02:20:42 INFO - 2015-12-17 02:20:42,739 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1048.2180293501049 02:20:42 INFO - 2015-12-17 02:20:42,739 DEBUG : BROWSER_OUTPUT: |5;Earley;695.4102920723227 02:20:42 INFO - 2015-12-17 02:20:42,739 DEBUG : BROWSER_OUTPUT: |6;Boyer;12280.487804878048 02:20:42 INFO - 2015-12-17 02:20:42,739 DEBUG : BROWSER_OUTPUT: |7;RegExp;25100 02:20:42 INFO - 2015-12-17 02:20:42,739 DEBUG : BROWSER_OUTPUT: |8;Splay;695.0796950796951 02:20:42 INFO - 2015-12-17 02:20:42,740 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 02:20:42 INFO - 2015-12-17 02:20:42,740 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:20:42 INFO - 2015-12-17 02:20:42,740 DEBUG : BROWSER_OUTPUT: __startTimestamp1450347642735__endTimestamp 02:20:42 INFO - 2015-12-17 02:20:42,740 DEBUG : BROWSER_OUTPUT: 02:20:42 INFO - 2015-12-17 02:20:42,740 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:20:42 INFO - 2015-12-17 02:20:42,740 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:20:42 INFO - 2015-12-17 02:20:42,741 DEBUG : BROWSER_OUTPUT: 02:20:42 INFO - 2015-12-17 02:20:42,741 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.55 Median:168.55 stddev:0.00 (0.0%) 02:20:42 INFO - 2015-12-17 02:20:42,741 DEBUG : BROWSER_OUTPUT: Values: 168.5 02:20:42 INFO - 2015-12-17 02:20:42,741 DEBUG : BROWSER_OUTPUT: 02:20:42 INFO - 2015-12-17 02:20:42,741 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.65 Median:187.65 stddev:0.00 (0.0%) 02:20:42 INFO - 2015-12-17 02:20:42,741 DEBUG : BROWSER_OUTPUT: Values: 187.7 02:20:42 INFO - 2015-12-17 02:20:42,741 DEBUG : BROWSER_OUTPUT: 02:20:42 INFO - 2015-12-17 02:20:42,741 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 02:20:42 INFO - 2015-12-17 02:20:42,742 DEBUG : BROWSER_OUTPUT: Values: 281.4 02:20:42 INFO - 2015-12-17 02:20:42,742 DEBUG : BROWSER_OUTPUT: 02:20:42 INFO - 2015-12-17 02:20:42,742 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 02:20:42 INFO - 2015-12-17 02:20:42,742 DEBUG : BROWSER_OUTPUT: Values: 5170.1 02:20:42 INFO - 2015-12-17 02:20:42,743 DEBUG : BROWSER_OUTPUT: 02:20:42 INFO - 2015-12-17 02:20:42,743 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1048.22 Median:1048.22 stddev:0.00 (0.0%) 02:20:42 INFO - 2015-12-17 02:20:42,743 DEBUG : BROWSER_OUTPUT: Values: 1048.2 02:20:42 INFO - 2015-12-17 02:20:42,743 DEBUG : BROWSER_OUTPUT: 02:20:42 INFO - 2015-12-17 02:20:42,743 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:695.41 Median:695.41 stddev:0.00 (0.0%) 02:20:42 INFO - 2015-12-17 02:20:42,743 DEBUG : BROWSER_OUTPUT: Values: 695.4 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: Values: 12280.5 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25100.00 Median:25100.00 stddev:0.00 (0.0%) 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: Values: 25100.0 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:695.08 Median:695.08 stddev:0.00 (0.0%) 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: Values: 695.1 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: Values: 4840.6 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:20:42 INFO - 2015-12-17 02:20:42,744 DEBUG : BROWSER_OUTPUT: 02:20:43 INFO - 2015-12-17 02:20:43,629 INFO : Browser exited with error code: 0 02:20:43 INFO - 2015-12-17 02:20:43,644 INFO : Completed test v8_7 (00:00:40) 02:20:43 INFO - 2015-12-17 02:20:43,768 INFO : Completed test suite (00:20:11) 02:20:43 INFO - 2015-12-17 02:20:43,769 DEBUG : Working with test: dromaeo_css 02:20:43 INFO - 2015-12-17 02:20:43,769 DEBUG : Generating results file: dromaeo_css 02:20:43 INFO - 2015-12-17 02:20:43,770 DEBUG : Working with test: kraken 02:20:43 INFO - 2015-12-17 02:20:43,770 DEBUG : Generating results file: kraken 02:20:43 INFO - 2015-12-17 02:20:43,770 INFO : javascript benchmark 02:20:43 INFO - 2015-12-17 02:20:43,770 DEBUG : Working with test: v8_7 02:20:43 INFO - 2015-12-17 02:20:43,771 DEBUG : Generating results file: v8_7 02:20:43 INFO - 2015-12-17 02:20:43,771 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:43 INFO - 2015-12-17 02:20:43,826 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 02:20:43 INFO - 2015-12-17 02:20:43,826 DEBUG : process_Request line: dromaeo_css 7041.39 graph.html#tests=[[72,64,43]] 02:20:43 INFO - 2015-12-17 02:20:43,826 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:43 INFO - 2015-12-17 02:20:43,858 DEBUG : process_Request line: kraken 1516.30 graph.html#tests=[[232,64,43]] 02:20:43 INFO - 2015-12-17 02:20:43,858 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:43 INFO - 2015-12-17 02:20:43,976 DEBUG : process_Request line: v8_7 21151.75 graph.html#tests=[[230,64,43]] 02:20:43 INFO - 2015-12-17 02:20:43,977 INFO : javascript benchmark 02:20:44 INFO - 2015-12-17 02:20:43,981 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3234.9514757278644, 3262.4453842846697, 3288.3916475452056, 3303.966960330397, 3320.3193345364202, 5333.799895023618, 5379.193121031847, 5411.0530657135, 5443.591730620199, 5457.590680698949, 5469.097598896187, 5484.698341591211, 5506.449355064502, 5508.421615730351, 5543.584231182657, 4758.0, 5016.7742451589675, 5198.298229738974, 5209.32278803755, 5212.244224587452, 4932.112219800434, 5134.691918484884, 5138.075146473633, 5156.407013193474, 5207.166853303473, 4931.778069986841, 4948.331975183341, 4954.826581069645, 4967.329410529586, 5083.38999320084, 4954.504549545053, 4959.231319145538, 4966.180580204298, 4967.850964471072, 5016.548510634024, 4900.362952816111, 4946.72792996385, 4949.257611358289, 4965.652404331699, 4969.0807200668, 5255.737213139366, 5361.597880159004, 5385.461453854622, 5423.538999185074, 5424.891502169974, 5876.177335173079, 5935.0, 5948.643081415129, 5961.761529538813, 5964.1650168976375, 5889.558283128783, 5915.408459154093, 5915.852103697399, 5929.14027466015, 5930.822075337746, 5537.141743029837, 5597.6641401516035, 5644.350899646511, 5683.204351390808, 5704.34400043992, 6033.456988871023, 6077.908831367533, 6086.817395478054, 6106.328303886569, 6109.908351374733, 5676.744546495418, 5768.769249229984, 5889.204957330791, 5908.675022873697, 5916.083007133901, 5872.17789509469, 5896.115582662549, 5909.23179986599, 5909.231799866076, 5920.2303700519515, 5859.033259512133, 5866.530677545786, 5871.266091738533, 5874.148248504029, 5893.852653683606, 5878.059510478389, 5879.265091863517, 5940.524758019348, 6001.789937352171, 6051.364606716319, 4515.864524064284, 4560.749158796298, 4575.084983003413, 4576.908461830745, 4576.908461830745, 4065.8170382332273, 4070.0, 4077.347624380085, 4077.4495443115393, 4116.547179810218, 5433.8369848904595, 5500.257465242221, 5535.778568857281, 5566.137248726453, 5584.050711379075, 6074.0, 6077.878442431127, 6109.236345456818, 6120.051392034242, 6130.049842274455, 5422.40353561108, 5731.054376027909, 5742.167385729046, 5755.827325180251, 5768.682722450306, 5113.258577506241, 5179.870503237449, 5181.5854731621375, 5207.739613019334, 5241.292425522582, 6029.939700602938, 6052.455279024909, 6077.696115194222, 6090.695465226721, 6100.0544915537275, 5748.166515855261, 5847.912281315868, 5923.437273459014, 5925.496332811759, 5929.673867937305, 6022.5784195105925, 6094.664793436404, 6107.206063211754, 6107.9404219779035, 6116.092308610808, 5969.403059693996, 5980.252468441445, 6007.8197654070445, 6007.90988135187, 6021.42796434338, 5759.827205183851, 5888.411158884077, 5899.026660601125, 6095.51235901118, 6096.420840020191, 5823.330317013598, 5823.94176058234, 5829.329627092939, 5839.5036421904615, 5846.912296315473, 5717.714114294352, 5758.740856661544, 5781.335146458211, 5786.971065144816, 5796.94203057964, 5480.205370221375, 5563.082091455027, 5670.829875103588, 5677.347105082803, 5802.65184088956, 5917.142014407801, 5973.49225315853, 5978.970105149447, 5984.700764961822, 5994.700264986646, 5823.155642431909, 5826.941730582809, 5867.9413205867395, 5877.794277200277, 5878.882422351444], "unit": "score", "name": "dojo.html", "value": 5472.541972619766}, {"lowerIsBetter": false, "replicates": [556.2351766321308, 589.2604780999844, 597.8834127345167, 601.9909701354478, 603.8339456649423, 39273.80363098184, 39910.0, 39920.60079399205, 39947.40078898819, 40118.0, 42906.57093429065, 43355.56644433555, 43528.12943741123, 43597.34603980935, 43646.0, 8733.257673097794, 8823.382363234576, 8898.644054237855, 8899.93200815903, 8912.955435222848, 8632.870506942401, 8682.30541556674, 8686.391952563323, 8739.650413983432, 8768.123187681245, 8661.783455413633, 8680.522571258578, 8701.7824554386, 8723.520206388646, 8768.903887014123, 8689.869651955225, 8738.519381434018, 8749.343799215052, 8759.649614015432, 8795.07651696569, 8642.524661143634, 8695.347848911357, 8747.868781968276, 8759.0, 8763.298936085097, 39602.40596391028, 40162.79918600417, 40317.79841100805, 40321.59678403208, 40426.595734042574, 3312.2216279174377, 3535.805530695811, 3681.9263614727824, 3826.9617303826885, 3879.825407856625, 29934.55098173529, 30241.09276721702, 30446.84776576103, 31577.684223157932, 31653.52519712206, 3939.428782826503, 3947.1118998225456, 3960.2871483133313, 4041.595840415964, 4094.529129150156, 261397.0, 261707.69146154338, 261851.0, 261983.0, 262519.0, 55041.1743823843, 55642.44357556454, 55671.443285566624, 55680.721596391755, 55698.16452753212, 54090.45909540933, 55358.0, 61687.0, 63030.369696303365, 63037.0, 14051.578452646438, 14161.929190353982, 14162.64593385153, 14223.502177423741, 14286.357113929898, 10938.124950003981, 11058.612948546763, 11077.889221107847, 11125.888741112485, 11156.776864462665, 18744.906275468536, 19084.04579771006, 19130.139143738565, 19213.615727685366, 19269.903650481658, 7496.6251687415415, 7820.217978202134, 7821.335186509096, 7827.45207835446, 7910.16943220965, 979.3780949097375, 1005.7083445800636, 1009.8939611340703, 1025.190099821148, 1079.5627770752858, 28479.430411391655, 28617.14148575546, 28805.42389152247, 29328.853355733085, 29407.85296073506, 1049.9317544359592, 1062.8033813744482, 1081.670090622352, 1092.082650573522, 1106.9981666591586, 14796.0, 14850.257487125817, 14893.0, 15080.849191508163, 15153.696926061417, 327695.0, 328242.0, 330717.0, 331752.0, 331985.0, 51952.0, 52050.73974630103, 52297.47702523002, 52314.47685523096, 52316.21525677118, 1283.3583208395803, 1284.6338793443824, 1296.7341694952702, 1299.2918859221747, 1304.699919018612, 27788.44423111486, 27982.440351192454, 28235.72939217781, 28508.714912851436, 28677.0, 46076.539234607226, 46577.53422465867, 46634.300485493426, 46666.300005499266, 46679.0, 309060.0, 309063.0, 311499.0, 312984.0, 313903.0, 31512.36975260528, 31937.0, 32286.19284517812, 32308.515372268965, 32433.51349729803, 37626.24747505089, 37674.49302027888, 38463.423048653734, 38484.0, 38492.42261366138, 32886.177845554055, 35574.288514229054, 36510.4523432154, 36837.0, 37406.62593374032, 33818.32363352768, 35090.298194035466, 35450.64549354473, 35484.46773298454, 36090.09774755652, 34987.30025399427, 34988.65011349854, 34989.0, 35280.823595881855, 35465.29069418545, 30682.539761903143, 31531.52702709507, 31698.524522132648, 31967.840160799045, 32113.678863212004, 24281.271561853173, 24456.755432445447, 24799.256022319358, 24809.25572232836, 24843.254702358958], "unit": "score", "name": "ext.html", "value": 18410.583104927024}, {"lowerIsBetter": false, "replicates": [358.6771905285243, 360.19316730523633, 363.9927201455973, 366.4905780964459, 367.68930253935423, 16360.672786544263, 16699.916500417497, 17304.999999999985, 17675.292988280486, 18218.81781182188, 15909.0, 16226.675466490693, 16567.337306507725, 16602.25289861956, 16686.916565417185, 4826.396700412449, 5011.774470148834, 5032.773525191357, 5033.647644664875, 5043.5208655177885, 4950.133726597849, 5042.84871453857, 5045.419776725668, 5054.1660625996665, 5275.155975043994, 5176.482351764831, 5324.41431442541, 5405.054115529786, 5408.215808707735, 5409.24270602116, 5311.575073994071, 5317.361916569997, 5326.280952071479, 5340.599455040888, 5343.893122137555, 5142.537171654569, 5357.598180136466, 5360.088784906537, 5365.946340536584, 5370.194470829368, 12635.1787133836, 12926.159799612995, 16596.419125330554, 20289.39131826033, 20502.5899482011, 2131.381899249216, 2149.0758973641327, 2160.0387827416807, 2189.9233526826483, 2277.749447560767, 9671.70984870455, 9683.612655493771, 9724.173445257162, 11960.521579136825, 12483.438245278985, 1825.9908700456413, 1833.7524434201346, 1843.6957901946162, 1863.67385707502, 1886.028695221948, 61354.69322653358, 63816.0, 64016.35983640197, 65063.99999999953, 66851.66019189305, 9962.252831037702, 10304.742381440525, 10341.9482902585, 10389.53247103867, 10427.165826733843, 13400.329983500786, 13469.326533673277, 13502.594922152352, 13574.117682350814, 13586.524471643643, 7272.0, 7455.254474552501, 7574.962125189449, 7581.962090189514, 7716.807079823049, 7267.854642907218, 7392.519486233377, 7476.439267054884, 7482.027336446227, 7513.661885215179, 4463.642908567307, 4504.211762941472, 4517.209488339593, 4568.132054909556, 4570.88572785683, 1884.1709647755217, 1886.0, 1902.5909429472454, 1957.9706304405445, 1979.4853338132189, 434.88910327866193, 439.8064851465345, 454.1847383945825, 457.45562780291345, 477.3817905811982, 10819.188560857967, 11386.487608057658, 11587.478563464496, 16715.08067056299, 16893.15534223284, 915.6200176926501, 929.7077062882598, 937.1659223291276, 962.2157941277836, 963.2149797914677, 9621.18219951298, 9897.35667181631, 9957.651482198089, 10000.0999910007, 10052.949735251277, 560461.0, 563721.0, 567975.0, 569641.0, 576298.0, 80515.19484805193, 82056.17943820605, 83480.0, 86157.56921215354, 86575.13424865797, 1146.6273461125002, 1155.3183621663259, 1161.814109742454, 1171.4845467994055, 1172.1794743679459, 15169.696606068037, 15555.922220388826, 15645.921770391074, 15661.921690391475, 15669.373225071326, 33880.83059584686, 35139.472907906915, 35462.0, 36640.45039324359, 37012.0, 44544.331835021854, 45087.0, 45499.545004550855, 45718.0, 48254.03491930071, 9624.470654114091, 9693.176080032994, 9778.65774697882, 9834.901650983398, 9860.605575776888, 12906.943816540592, 17572.648547029243, 18084.276628934695, 18280.360187393377, 18391.080445977914, 14140.363683634056, 14439.85560144385, 14921.104733716013, 14977.453832848223, 15322.310496027929, 14321.928390357982, 14397.42410303618, 14406.351714173097, 14468.638284042561, 15004.474843380429, 14256.073355231876, 14272.429102835771, 14334.713305734036, 14431.278436077944, 14717.705645886808, 9351.53242337894, 9408.858867116862, 9454.432734035705, 9684.95157524208, 9689.515524223902, 10179.880213176693, 10188.89811101909, 13962.58112256634, 14805.0, 14882.851171488579], "unit": "score", "name": "jquery.html", "value": 8681.389823645457}, {"lowerIsBetter": false, "replicates": [1494.4694633405134, 1664.3425846790517, 1708.7009773289678, 1725.2150271626404, 1729.7059499885017, 7181.317774811398, 7432.182459929417, 7548.962255188723, 7559.6598153083105, 7646.92353076469, 7620.65707043183, 7658.770236892902, 7679.7312094076715, 7687.2312768723095, 7741.303282704555, 2180.814630756384, 2212.9889350553226, 2214.324630987548, 2215.1139544182297, 2227.187076716995, 2244.136007637055, 2272.36373815332, 2303.1133013789727, 2311.029367665576, 2314.6296592545195, 2185.1696355384934, 2220.6113930062256, 2221.911123555056, 2222.388843068161, 2249.718785151856, 2189.4088596079127, 2205.44863784054, 2219.6004719150465, 2222.0334154642783, 2225.9109635614554, 2246.8764217968005, 2267.943301417461, 2271.65925111233, 2274.8976296066717, 2276.658501224813, 7420.628968551605, 7460.179380268166, 7478.962605186939, 7521.05986751656, 7522.172561018284, 4537.818487260505, 4584.426946631671, 4589.931151032737, 4622.976885115553, 4626.352310676508, 3000.6249218847643, 3042.404627938871, 3098.8760449582214, 3098.8915387961315, 3133.7336326412283, 1007.4660429972126, 1013.1185868294557, 1043.9008294212038, 1045.6078970386104, 1050.2858056521563, 9899.554520046544, 9917.75205619858, 9979.15177209938, 10017.09846113846, 10050.095491405735, 3965.7422267553093, 3990.0, 3996.640302372742, 4016.176683779818, 4057.0668746188544, 8178.223068808454, 8262.876056859152, 8269.669213231524, 8273.793155171048, 8286.171382861665, 4481.663875209372, 4498.932516012263, 4500.909981800346, 4513.029698614813, 4538.546145385435, 3792.4500947362476, 3848.6536211741077, 4125.711200215956, 4156.709030367906, 4208.579142085829, 3581.0331210573, 3596.1369271375206, 3604.801735904498, 3628.0, 3647.1429214134655, 1154.7748189103045, 1155.7168493718925, 1159.675290918544, 1166.78414493319, 1169.1757311095657, 1340.376724822962, 1342.2617560341773, 1360.2178747220387, 1364.7611667958067, 1371.7942308653783, 6369.681515924278, 6450.8064758057335, 6506.934930650727, 6509.511786616023, 7019.087518622547, 1134.4214450630238, 1137.4710759496875, 1137.5449820071872, 1137.9772404551863, 1155.96532104037, 5351.518363347317, 5393.83818485446, 5414.214938833847, 5421.701806400607, 5424.294841670637, 8534.829303413897, 8538.188872057144, 8706.52114133716, 8735.737927862174, 8761.299096072298, 8575.142485751376, 8603.827923441497, 8658.437201582003, 8699.739007829776, 8780.209781119729, 6786.4570834333135, 6803.727850885909, 6948.5483443576, 6952.339527744856, 6976.162860456676, 6679.165104361955, 6716.6977486012265, 6731.259561448139, 6740.865182696417, 6765.255821859493, 7645.426593005435, 7825.765227043198, 7829.8825517618425, 7860.253275938777, 7927.603619819101, 7889.289963903277, 7952.84094318122, 8044.477108987897, 8058.435909486279, 8060.952076230053, 5579.972100139474, 5701.087825947829, 5964.075568286922, 6352.587081839665, 6434.8391290218115, 7097.858042839218, 7126.964365178141, 7127.073480447509, 7159.928400715926, 7165.104361954755, 6529.412352888263, 6607.108040414675, 6683.699233534599, 6693.598384096969, 6749.223839258548, 6427.839304017437, 6486.481081513373, 6635.933640663531, 6681.732730690718, 6771.86456270862, 6745.0, 6757.290484499057, 6772.051912732123, 6772.0857684212, 6785.830354240986, 6028.0181089018315, 6155.507559395327, 6191.133241346305, 6201.10084037821, 6201.379862013762, 6202.7208775606105, 6204.286507051746, 6213.1922850029205, 6218.315985241529, 6236.126942228182], "unit": "score", "name": "mootools.html", "value": 4335.533821351248}, {"lowerIsBetter": false, "replicates": [333.225251290749, 338.734093736417, 341.9675130862567, 345.0992908508792, 347.67492394611025, 6319.810405687826, 6389.520785941049, 6419.743210271589, 6432.0, 6481.449076828475, 6349.253955162333, 6355.3009168991375, 6407.231132264134, 6409.839754006152, 6420.133282006927, 4837.951620483803, 4837.975810120962, 4841.724389536912, 4845.2247640377545, 4853.150698627726, 4847.6606637535215, 4853.296272040552, 4854.296127061574, 4855.077535268305, 4857.319975203474, 4560.749158796265, 4638.605718513931, 4744.525547445245, 4746.21687421575, 4746.5490778376, 4729.6452766042685, 4740.123077230689, 4741.857744267678, 4746.074515469485, 4751.477337492873, 4109.137081212949, 4114.115465174972, 4117.629413352783, 4122.051928056564, 4128.483939507561, 6012.729427175744, 6027.065804800263, 6027.945109605801, 6029.366916473751, 6042.728077236535, 5460.372057213432, 5550.611457197998, 5555.166724991243, 5556.16657501378, 5556.222128901957, 6658.533902626818, 6679.666016699194, 6679.9980002999455, 6688.63212523311, 6694.0, 4558.544145585448, 4570.405847239871, 4577.427821522309, 4583.610393116589, 4588.357629931812, 6782.694778734969, 6906.654667266666, 6969.163700355939, 6999.12510936133, 7000.334968178015, 4681.063787242565, 4687.109449204709, 4692.741899195509, 4693.155232058262, 4693.78877950493, 4739.218029025241, 4749.738764367924, 4751.714897106184, 4756.21522448799, 4766.285057241372, 5526.364468086222, 5530.087535556588, 5534.169874518854, 5535.391106978229, 5540.0, 6623.503237257225, 6734.629595372302, 6746.515766531355, 6749.763758268437, 6754.898676519856, 1665.0592415285325, 1681.0502066332483, 1684.7388654758531, 1685.292177285543, 1688.2487293154675, 1108.6064447121316, 1116.17403121691, 1116.3357802107896, 1127.2954403497813, 1130.1354463835173, 6502.544821862424, 6502.967485162639, 6503.8699226015215, 6514.022896565553, 6514.934850651528, 6963.547369420971, 6987.720491180397, 6997.230304666483, 7011.263817299212, 7013.929860701328, 6457.3865482779065, 6466.418022378009, 6510.414062734377, 6586.73653053882, 6593.175853018372, 3786.3373909565717, 3806.3909774435956, 3820.4460353248624, 3828.1769419574925, 3849.8075096245075, 7292.161401438902, 7300.8174795629475, 7303.087114110736, 7342.77971660851, 7358.448116391292, 7087.220405755363, 7264.091988501437, 7269.927300726925, 7271.309225623558, 7279.0, 7266.709331626781, 7290.890636640454, 7315.378192853667, 7326.816829579303, 7331.706731730777, 6927.480438966997, 7016.5790052597, 7024.8595028098125, 7032.050673159262, 7034.753783617549, 6912.239653637996, 6958.0, 6969.895451568129, 6971.860562788817, 6973.442124630119, 7309.451791115581, 7311.086114235721, 7325.340719335285, 7332.523385979895, 7338.522996005243, 4721.504242054535, 4755.334253204624, 4764.118638051971, 4768.594669452997, 4771.1888978872985, 6879.6560171992205, 6963.9303606963285, 7014.649267536704, 7021.332973367522, 7022.332878376546, 6824.4199243064895, 6840.931590684029, 6841.726330946706, 6853.725850965906, 6854.725810967506, 6668.133142691419, 6789.456843452611, 6789.89815152783, 6796.932030679828, 6827.0, 6627.834304142242, 6628.138342015507, 6675.0654908313845, 6679.265280819203, 6679.632620205741, 6849.726010959505, 6853.109095817512, 6858.417034552119, 6860.965695171492, 6868.793936181923, 6502.837429064311, 6607.47140228771, 6683.331666833472, 6690.531662783558, 6696.59820410777], "unit": "score", "name": "prototype.html", "value": 5071.67834361626}, {"lowerIsBetter": false, "replicates": [839.6557411461303, 851.5444237333028, 853.7908212487941, 865.0354854337412, 867.8481265778489, 11669.591564295251, 12024.939875300612, 12029.398530073495, 12074.939625301884, 12137.089718271121, 12977.091603587753, 13047.543335983242, 14365.35355908984, 14565.344559494823, 14633.195174265411, 811.419834818105, 816.6610856494577, 819.4304958054155, 823.4112609484217, 825.9504429734235, 815.7389635316702, 817.7873752824279, 819.9996004874045, 820.0528389709895, 825.7440193539992, 851.5188918261193, 862.0431321233426, 864.6627815152095, 867.0419186798591, 867.440500876934, 846.1200351634293, 848.7368915636173, 849.9022612399591, 858.2447446247324, 867.5402036920442, 631.1763149090435, 631.4664108828033, 633.2907143998705, 634.1692382978313, 643.893757530007, 13367.732645347136, 13618.795718064237, 13734.381952812148, 13758.449662013507, 13775.104618199784, 11414.657560273205, 11592.710182245428, 12007.339596322287, 12326.630201093893, 13022.088453808237, 9646.710598682052, 10280.434576098312, 10412.895871041344, 10549.9472502637, 10813.567457301699, 3513.350030244387, 3608.1340478285283, 3635.3638113330326, 3664.5052917856015, 3671.320805650963, 44144.779276103414, 44527.0, 46465.53534464646, 46685.29972050456, 50413.747931260106, 9408.96501384847, 9719.125278724949, 9877.703668889944, 10015.483742070797, 10193.643222487177, 15808.288627011812, 15817.604559886095, 15851.207439628202, 15852.44516441919, 15939.203039847962, 7709.614519274014, 7737.8452430951065, 7743.109542402583, 7865.921340786519, 8070.798230044295, 4415.050764085737, 4418.60232579063, 4423.181711383404, 4424.358468022118, 4429.379886815848, 3039.6200474940633, 3047.207725991258, 3070.631524217108, 3079.7228249457658, 3087.768417368706, 541.5992165797281, 562.3392513796273, 567.8722287485283, 569.4533248081888, 570.6034306157264, 602.9872581872792, 624.8687775567091, 675.8546912413756, 702.034702284359, 728.457299312016, 8564.3148548116, 8585.527795971157, 8638.308935285162, 8706.956465217634, 8776.692815751545, 692.3768608252612, 698.2458944340101, 713.7252157919238, 729.3144444222414, 734.1483878700682, 3664.6518580734787, 4007.7595344279434, 4092.161106973123, 4101.097758493186, 4132.297509423405, 60469.09296360558, 60476.0, 60646.69676651677, 61009.0, 62343.37656623466, 54948.17577736337, 55392.0, 55641.443585563626, 56402.0, 57025.71487142621, 46563.534364656596, 48147.75926120347, 50654.74672626613, 50917.236241456405, 53145.734271328394, 8283.95858020706, 8372.28835548985, 8577.528235946833, 8627.482351058956, 8897.73306800797, 34007.63969441195, 34295.828520857234, 34493.827530863186, 34671.0, 34716.47925281173, 41486.0, 41616.3757543631, 42833.78583107064, 45077.77461112673, 45091.77454112709, 10760.730981725519, 11005.944970275417, 11013.614523491638, 11284.548618055185, 11349.943250283695, 11468.756039904492, 11966.401679916144, 12329.14338222422, 12492.812607811073, 12548.0, 10608.575656973635, 10674.62638807638, 10739.194560407845, 10815.51330190159, 11312.490937907978, 11299.152563557602, 11594.88405115938, 11775.76448471043, 11957.402129893644, 12020.579279725167, 10320.845187322346, 10391.740206494596, 10408.219383546113, 10413.895861041292, 10418.583256669648, 9722.465264410524, 9952.154066904393, 10036.749081273027, 10236.232282578687, 10551.683449496528, 8846.446833193137, 9320.300977426585, 9435.575399107194, 9958.15355694745, 10118.59525618967], "unit": "score", "name": "yui.html", "value": 6336.844938555841}], "name": "dromaeo_css", "value": 7041.390285079543}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 110.0, 111.0, 114.0, 122.0, 112.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 149.0, 164.0, 131.0, 161.0, 159.0, 125.0, 159.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 163.0, 162.0, 160.0, 165.0, 166.0, 171.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 73.0, 73.0, 73.0, 71.0, 71.0, 141.0, 71.0, 71.0], "unit": "score", "name": "audio-fft", "value": 78.6}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 140.0, 94.0, 94.0, 94.0, 134.0, 93.0, 94.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 111.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 96.0, 97.0, 100.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 59.0, 61.0, 62.0, 62.0, 59.0, 60.0, 58.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 69.0, 70.0, 69.0, 68.0, 68.0, 71.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 86.0, 85.0, 93.0, 86.0, 87.0, 87.0, 86.0, 95.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 126.0, 126.0, 121.0, 129.0, 128.0, 134.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [141.0, 152.0, 151.0, 149.0, 152.0, 140.0, 156.0, 150.0, 154.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 66.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1516.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.54879487611663], "unit": "score", "name": "Richards", "value": 209.44676600000008}, {"lowerIsBetter": false, "replicates": [187.65246762994934], "unit": "score", "name": "DeltaBlue", "value": 352.34282199999996}, {"lowerIsBetter": false, "replicates": [281.37310073157005], "unit": "score", "name": "Encrypt", "value": 946.0072739999998}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1048.2180293501049], "unit": "score", "name": "RayTrace", "value": 705.9495059999997}, {"lowerIsBetter": false, "replicates": [695.4102920723227], "unit": "score", "name": "Earley", "value": 958.3737939999997}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [25100.0], "unit": "score", "name": "RegExp", "value": 36.294223107569735}, {"lowerIsBetter": false, "replicates": [695.0796950796951], "unit": "score", "name": "Splay", "value": 117.23979361914256}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21151.748053827414}]} 02:20:44 INFO - RETURN: dromaeo_css: 7041.39 02:20:44 INFO - RETURN: kraken: 1516.30 02:20:44 INFO - RETURN: v8_7: 21151.75 02:20:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21151.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1516.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7041.39"}}} 02:20:44 INFO - Return code: 0 02:20:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:20:44 INFO - # TBPL SUCCESS # 02:20:44 INFO - Running post-action listener: _resource_record_post_action 02:20:44 INFO - Running post-run listener: _resource_record_post_run 02:20:45 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 528576512; Read time: 12; Write time: 581664 02:20:45 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 250138624; Read time: 0; Write time: 380984 02:20:45 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278437888; Read time: 12; Write time: 200680 02:20:45 INFO - Running post-run listener: _upload_blobber_files 02:20:45 INFO - Blob upload gear active. 02:20:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:20:45 INFO - Copying logs to upload dir... 02:20:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.358360 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-17 02:20:44.933322) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 02:20:44.936444) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010171 build_url: 'https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 02:20:44.986939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 02:20:44.987261) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450343162.454596-1089135383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 02:20:45.036803) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 02:20:45.037120) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 02:20:45.037398) ========= ========= Total master_lag: 0.26 =========