builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1450497513.47 results: success (0) buildid: 20151218173004 builduid: 5f4ebf00ba0a4a20a2368b54d5b3e551 revision: 36aa441232b7e8cc82b0a83d1b343fd3ace134a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.470987) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.471460) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.471753) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006375 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.501662) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.502001) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.522737) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.523240) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.572786) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.573058) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.573425) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.573721) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 19:58:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 98.3M=0s 2015-12-18 19:58:33 (98.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110837 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.697159) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.697472) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022095 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.747841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:33.748173) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 36aa441232b7e8cc82b0a83d1b343fd3ace134a7 --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 36aa441232b7e8cc82b0a83d1b343fd3ace134a7 --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=752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 19:58:33,877 truncating revision to first 12 chars 2015-12-18 19:58:33,877 Setting DEBUG logging. 2015-12-18 19:58:33,878 attempt 1/10 2015-12-18 19:58:33,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/36aa441232b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 19:58:34,213 unpacking tar archive at: fx-team-36aa441232b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.597017 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.358256) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.358534) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.370131) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.370399) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.370752) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-18 19:58:34.371029) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:58:34 INFO - MultiFileLogger online at 20151218 19:58:34 in /builds/slave/test-pgo 19:58:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 19:58:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:58:34 INFO - {'append_to_log': False, 19:58:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:58:34 INFO - 'blob_upload_branch': 'Fx-Team', 19:58:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:58:34 INFO - 'branch': 'Fx-Team', 19:58:34 INFO - 'buildbot_json_path': 'buildprops.json', 19:58:34 INFO - 'config_files': ('talos/linux_config.py',), 19:58:34 INFO - 'default_actions': ('clobber', 19:58:34 INFO - 'read-buildbot-config', 19:58:34 INFO - 'download-and-extract', 19:58:34 INFO - 'populate-webroot', 19:58:34 INFO - 'create-virtualenv', 19:58:34 INFO - 'install', 19:58:34 INFO - 'run-tests'), 19:58:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:58:34 INFO - 'download_minidump_stackwalk': True, 19:58:34 INFO - 'download_symbols': 'ondemand', 19:58:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:58:34 INFO - 'tooltool.py': '/tools/tooltool.py', 19:58:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:58:34 INFO - '/tools/misc-python/virtualenv.py')}, 19:58:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:58:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:58:34 INFO - 'installer_path': 'installer.exe', 19:58:34 INFO - 'log_level': 'info', 19:58:34 INFO - 'log_name': 'talos', 19:58:34 INFO - 'log_to_console': True, 19:58:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:58:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:58:34 INFO - 'opt_config_files': (), 19:58:34 INFO - 'pip_index': False, 19:58:34 INFO - 'sps_profile': False, 19:58:34 INFO - 'sps_profile_interval': 0, 19:58:34 INFO - 'suite': 'dromaeojs', 19:58:34 INFO - 'system_bits': '64', 19:58:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:58:34 INFO - 'title': 'talos-linux64-ix-054', 19:58:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:58:34 INFO - 'use_talos_json': True, 19:58:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:58:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:58:34 INFO - 'work_dir': 'build'} 19:58:34 INFO - ##### 19:58:34 INFO - ##### Running clobber step. 19:58:34 INFO - ##### 19:58:34 INFO - Running pre-action listener: _resource_record_pre_action 19:58:34 INFO - Running main action method: clobber 19:58:34 INFO - rmtree: /builds/slave/test-pgo/build 19:58:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:58:35 INFO - Running post-action listener: _resource_record_post_action 19:58:35 INFO - ##### 19:58:35 INFO - ##### Running read-buildbot-config step. 19:58:35 INFO - ##### 19:58:35 INFO - Running pre-action listener: _resource_record_pre_action 19:58:35 INFO - Running main action method: read_buildbot_config 19:58:35 INFO - Using buildbot properties: 19:58:35 INFO - { 19:58:35 INFO - "project": "", 19:58:35 INFO - "product": "firefox", 19:58:35 INFO - "script_repo_revision": "production", 19:58:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:58:35 INFO - "repository": "", 19:58:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:58:35 INFO - "buildid": "20151218173004", 19:58:35 INFO - "pgo_build": "True", 19:58:35 INFO - "basedir": "/builds/slave/test-pgo", 19:58:35 INFO - "buildnumber": 376, 19:58:35 INFO - "slavename": "talos-linux64-ix-054", 19:58:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:58:35 INFO - "platform": "ubuntu64_hw", 19:58:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:58:35 INFO - "branch": "fx-team", 19:58:35 INFO - "repo_path": "integration/fx-team", 19:58:35 INFO - "revision": "36aa441232b7e8cc82b0a83d1b343fd3ace134a7", 19:58:35 INFO - "stage_platform": "linux64-pgo", 19:58:35 INFO - "builduid": "5f4ebf00ba0a4a20a2368b54d5b3e551", 19:58:35 INFO - "slavebuilddir": "test" 19:58:35 INFO - } 19:58:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:58:35 INFO - Running post-action listener: _resource_record_post_action 19:58:35 INFO - ##### 19:58:35 INFO - ##### Running download-and-extract step. 19:58:35 INFO - ##### 19:58:35 INFO - Running pre-action listener: _resource_record_pre_action 19:58:35 INFO - Running main action method: download_and_extract 19:58:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:35 INFO - https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/test_packages.json 19:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/test_packages.json 19:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:58:40 INFO - Downloaded 1302 bytes. 19:58:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:58:40 INFO - Using the following test package requirements: 19:58:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:58:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'jsshell-linux-x86_64.zip'], 19:58:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:58:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:58:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:58:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:58:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:58:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:58: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')]} 19:58:40 INFO - https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/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 19:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/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 19:58:41 INFO - Downloaded 23121218 bytes. 19:58:41 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 19:58:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:41 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 19:58:42 INFO - Return code: 0 19:58:42 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 19:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:42 INFO - https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/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 19:58:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/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 19:58:46 INFO - Downloaded 23121218 bytes. 19:58:46 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 19:58:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:46 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 19:58:48 INFO - Return code: 0 19:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:48 INFO - https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:58:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/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 19:58:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/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 19:58:49 INFO - Downloaded 11132039 bytes. 19:58:49 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 19:58:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:49 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 19:58:50 INFO - Return code: 0 19:58: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')]} 19:58:50 INFO - https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:58:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/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 19:58:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/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 19:58:51 INFO - Downloaded 54637734 bytes. 19:58:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:51 INFO - mkdir: /builds/slave/test-pgo/properties 19:58:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:58:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:58:51 INFO - Contents: 19:58:51 INFO - build_url:https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:51 INFO - Running post-action listener: _resource_record_post_action 19:58:51 INFO - Running post-action listener: set_extra_try_arguments 19:58:51 INFO - ##### 19:58:51 INFO - ##### Running populate-webroot step. 19:58:51 INFO - ##### 19:58:51 INFO - Running pre-action listener: _resource_record_pre_action 19:58:51 INFO - Running main action method: populate_webroot 19:58:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:58:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:58:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:58:51 INFO - '--tppagecycles', 19:58:51 INFO - '7'], 19:58:51 INFO - 'tests': ['tsvgm']}}, 19:58:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:58:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:58:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:58:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:58:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:58:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:58:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:51 INFO - 'talos_options': ['--e10s'], 19:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:51 INFO - 'tests': ['damp', 'tps']}, 19:58:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:51 INFO - 'talos_options': ['--e10s'], 19:58:51 INFO - 'tests': ['damp', 'tps']}, 19:58:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:58:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:58:51 INFO - 'other': {'tests': ['a11yr', 19:58:51 INFO - 'ts_paint', 19:58:51 INFO - 'tpaint', 19:58:51 INFO - 'sessionrestore', 19:58:51 INFO - 'sessionrestore_no_auto_restore']}, 19:58:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:58:51 INFO - 'tests': ['a11yr', 19:58:51 INFO - 'ts_paint', 19:58:51 INFO - 'tpaint', 19:58:51 INFO - 'sessionrestore', 19:58:51 INFO - 'sessionrestore_no_auto_restore']}, 19:58:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:58:51 INFO - 'tests': ['a11yr', 19:58:51 INFO - 'ts_paint', 19:58:51 INFO - 'tpaint', 19:58:51 INFO - 'sessionrestore', 19:58:51 INFO - 'sessionrestore_no_auto_restore']}, 19:58:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:58:51 INFO - 'tests': ['a11yr', 19:58:51 INFO - 'ts_paint', 19:58:51 INFO - 'tpaint', 19:58:51 INFO - 'sessionrestore', 19:58:51 INFO - 'sessionrestore_no_auto_restore']}, 19:58:51 INFO - 'other_l64': {'tests': ['a11yr', 19:58:51 INFO - 'ts_paint', 19:58:51 INFO - 'tpaint', 19:58:51 INFO - 'sessionrestore', 19:58:51 INFO - 'sessionrestore_no_auto_restore']}, 19:58:51 INFO - 'other_nol64': {'tests': ['a11yr', 19:58:51 INFO - 'ts_paint', 19:58:51 INFO - 'tpaint', 19:58:51 INFO - 'sessionrestore', 19:58:51 INFO - 'sessionrestore_no_auto_restore']}, 19:58:51 INFO - 'svgr': {'tests': ['tsvgx', 19:58:51 INFO - 'tsvgr_opacity', 19:58:51 INFO - 'tart', 19:58:51 INFO - 'tscrollx', 19:58:51 INFO - 'cart']}, 19:58:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:58:51 INFO - 'tests': ['tsvgx', 19:58:51 INFO - 'tsvgr_opacity', 19:58:51 INFO - 'tart', 19:58:51 INFO - 'tscrollx', 19:58:51 INFO - 'cart']}, 19:58:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:51 INFO - 'tests': ['tp5o']}, 19:58:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:51 INFO - 'talos_options': ['--e10s'], 19:58:51 INFO - 'tests': ['tp5o']}, 19:58:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:51 INFO - 'talos_options': ['--xperf_path', 19:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:51 INFO - 'tests': ['tp5n']}, 19:58:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:51 INFO - 'talos_options': ['--e10s', 19:58:51 INFO - '--xperf_path', 19:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:51 INFO - 'tests': ['tp5n']}}, 19:58:51 INFO - 'talos.zip': {'path': '', 19:58:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:58:51 INFO - Running post-action listener: _resource_record_post_action 19:58:51 INFO - ##### 19:58:51 INFO - ##### Running create-virtualenv step. 19:58:51 INFO - ##### 19:58:51 INFO - Running pre-action listener: _resource_record_pre_action 19:58:51 INFO - Running main action method: create_virtualenv 19:58:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:58:51 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 19:58:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:58:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:58:51 INFO - Using real prefix '/usr' 19:58:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:58:52 INFO - Installing distribute.............................................................................................................................................................................................done. 19:58:54 INFO - Installing pip.................done. 19:58:54 INFO - Return code: 0 19:58:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:54 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 0x7fa4b745cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a350>, '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 0x1c8b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', '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 19:58:54 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 19:58:54 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 19:58:54 INFO - Using env: {'DISPLAY': ':0', 19:58:54 INFO - 'HOME': '/home/cltbld', 19:58:54 INFO - 'LANG': 'en_US.UTF-8', 19:58:54 INFO - 'LANGUAGE': 'en_US:en', 19:58:54 INFO - 'LOGNAME': 'cltbld', 19:58:54 INFO - 'MAIL': '/var/mail/cltbld', 19:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:54 INFO - 'MOZ_NO_REMOTE': '1', 19:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:54 INFO - 'NO_EM_RESTART': '1', 19:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:54 INFO - 'SHELL': '/bin/bash', 19:58:54 INFO - 'SHLVL': '1', 19:58:54 INFO - 'TERM': 'linux', 19:58:54 INFO - 'TMOUT': '86400', 19:58:54 INFO - 'USER': 'cltbld', 19:58:54 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', 19:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:54 INFO - '_': '/tools/buildbot/bin/python'} 19:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:54 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 19:58:54 INFO - Cleaning up... 19:58:54 INFO - Return code: 0 19:58:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:54 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 0x7fa4b745cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a350>, '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 0x1c8b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', '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 19:58:54 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 19:58:54 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 19:58:54 INFO - Using env: {'DISPLAY': ':0', 19:58:54 INFO - 'HOME': '/home/cltbld', 19:58:54 INFO - 'LANG': 'en_US.UTF-8', 19:58:54 INFO - 'LANGUAGE': 'en_US:en', 19:58:54 INFO - 'LOGNAME': 'cltbld', 19:58:54 INFO - 'MAIL': '/var/mail/cltbld', 19:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:54 INFO - 'MOZ_NO_REMOTE': '1', 19:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:54 INFO - 'NO_EM_RESTART': '1', 19:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:54 INFO - 'SHELL': '/bin/bash', 19:58:54 INFO - 'SHLVL': '1', 19:58:54 INFO - 'TERM': 'linux', 19:58:54 INFO - 'TMOUT': '86400', 19:58:54 INFO - 'USER': 'cltbld', 19:58:54 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', 19:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:54 INFO - '_': '/tools/buildbot/bin/python'} 19:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:54 INFO - Downloading/unpacking psutil>=0.7.1 19:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:58:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:58:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:58:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:56 INFO - Installing collected packages: psutil 19:58:56 INFO - Running setup.py install for psutil 19:58:56 INFO - building 'psutil._psutil_linux' extension 19:58:56 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 19:58:56 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 19:58:56 INFO - building 'psutil._psutil_posix' extension 19:58:56 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 19:58:56 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 19:58:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:56 INFO - Successfully installed psutil 19:58:56 INFO - Cleaning up... 19:58:56 INFO - Return code: 0 19:58:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4b745cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a350>, '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 0x1c8b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', '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 19:58:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:58:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:58:56 INFO - Using env: {'DISPLAY': ':0', 19:58:56 INFO - 'HOME': '/home/cltbld', 19:58:56 INFO - 'LANG': 'en_US.UTF-8', 19:58:56 INFO - 'LANGUAGE': 'en_US:en', 19:58:56 INFO - 'LOGNAME': 'cltbld', 19:58:56 INFO - 'MAIL': '/var/mail/cltbld', 19:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:56 INFO - 'MOZ_NO_REMOTE': '1', 19:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:56 INFO - 'NO_EM_RESTART': '1', 19:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:56 INFO - 'SHELL': '/bin/bash', 19:58:56 INFO - 'SHLVL': '1', 19:58:56 INFO - 'TERM': 'linux', 19:58:56 INFO - 'TMOUT': '86400', 19:58:56 INFO - 'USER': 'cltbld', 19:58:56 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', 19:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:56 INFO - '_': '/tools/buildbot/bin/python'} 19:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:58:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:58:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:58:58 INFO - Installing collected packages: mozsystemmonitor 19:58:58 INFO - Running setup.py install for mozsystemmonitor 19:58:58 INFO - Successfully installed mozsystemmonitor 19:58:58 INFO - Cleaning up... 19:58:58 INFO - Return code: 0 19:58:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:58: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')]} 19:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4b745cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a350>, '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 0x1c8b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', '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 19:58:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:58:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:58:58 INFO - Using env: {'DISPLAY': ':0', 19:58:58 INFO - 'HOME': '/home/cltbld', 19:58:58 INFO - 'LANG': 'en_US.UTF-8', 19:58:58 INFO - 'LANGUAGE': 'en_US:en', 19:58:58 INFO - 'LOGNAME': 'cltbld', 19:58:58 INFO - 'MAIL': '/var/mail/cltbld', 19:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:58 INFO - 'MOZ_NO_REMOTE': '1', 19:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:58 INFO - 'NO_EM_RESTART': '1', 19:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:58 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:58 INFO - 'SHELL': '/bin/bash', 19:58:58 INFO - 'SHLVL': '1', 19:58:58 INFO - 'TERM': 'linux', 19:58:58 INFO - 'TMOUT': '86400', 19:58:58 INFO - 'USER': 'cltbld', 19:58:58 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', 19:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:58 INFO - '_': '/tools/buildbot/bin/python'} 19:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:59 INFO - Downloading/unpacking blobuploader==1.2.4 19:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:00 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:59:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:59:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:59:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:01 INFO - Downloading docopt-0.6.1.tar.gz 19:59:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:59:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:01 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:01 INFO - Running setup.py install for blobuploader 19:59:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:59:01 INFO - Running setup.py install for requests 19:59:02 INFO - Running setup.py install for docopt 19:59:02 INFO - Successfully installed blobuploader requests docopt 19:59:02 INFO - Cleaning up... 19:59:02 INFO - Return code: 0 19:59:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:02 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')]} 19:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:02 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')]} 19:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:02 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 0x7fa4b745cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a350>, '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 0x1c8b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', '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 19:59:02 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 19:59:02 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 19:59:02 INFO - Using env: {'DISPLAY': ':0', 19:59:02 INFO - 'HOME': '/home/cltbld', 19:59:02 INFO - 'LANG': 'en_US.UTF-8', 19:59:02 INFO - 'LANGUAGE': 'en_US:en', 19:59:02 INFO - 'LOGNAME': 'cltbld', 19:59:02 INFO - 'MAIL': '/var/mail/cltbld', 19:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:02 INFO - 'MOZ_NO_REMOTE': '1', 19:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:02 INFO - 'NO_EM_RESTART': '1', 19:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:02 INFO - 'SHELL': '/bin/bash', 19:59:02 INFO - 'SHLVL': '1', 19:59:02 INFO - 'TERM': 'linux', 19:59:02 INFO - 'TMOUT': '86400', 19:59:02 INFO - 'USER': 'cltbld', 19:59:02 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', 19:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:02 INFO - '_': '/tools/buildbot/bin/python'} 19:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:02 INFO - Running setup.py (path:/tmp/pip-lMyROY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:02 INFO - Running setup.py (path:/tmp/pip-FvwAz5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:02 INFO - Running setup.py (path:/tmp/pip-uVHcnv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:02 INFO - Running setup.py (path:/tmp/pip-klitRE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:02 INFO - Running setup.py (path:/tmp/pip-C9sUKR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:02 INFO - Running setup.py (path:/tmp/pip-gYG7Y5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:03 INFO - Running setup.py (path:/tmp/pip-OWJHtt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:03 INFO - Running setup.py (path:/tmp/pip-NteEjX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:03 INFO - Running setup.py (path:/tmp/pip-LV1JNE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:03 INFO - Running setup.py (path:/tmp/pip-DTp_dR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:03 INFO - Running setup.py (path:/tmp/pip-kEKYFw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:03 INFO - Running setup.py (path:/tmp/pip-VwsGXP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:03 INFO - Running setup.py (path:/tmp/pip-OGuedy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:03 INFO - Running setup.py (path:/tmp/pip-z3dJMh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:03 INFO - Running setup.py (path:/tmp/pip-xKnTB6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:03 INFO - Running setup.py (path:/tmp/pip-0P1UEw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:03 INFO - Running setup.py (path:/tmp/pip-KtKif3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:59:03 INFO - Running setup.py install for manifestparser 19:59:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:59:03 INFO - Running setup.py install for mozcrash 19:59:03 INFO - Running setup.py install for mozdebug 19:59:04 INFO - Running setup.py install for mozdevice 19:59:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:59:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:59:04 INFO - Running setup.py install for mozfile 19:59:04 INFO - Running setup.py install for mozhttpd 19:59:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:59:04 INFO - Running setup.py install for mozinfo 19:59:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:59:04 INFO - Running setup.py install for mozInstall 19:59:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:59:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:59:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:59:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:59:04 INFO - Running setup.py install for mozleak 19:59:04 INFO - Running setup.py install for mozlog 19:59:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:59:04 INFO - Running setup.py install for moznetwork 19:59:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:59:04 INFO - Running setup.py install for mozprocess 19:59:05 INFO - Running setup.py install for mozprofile 19:59:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:59:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:59:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:59:05 INFO - Running setup.py install for mozrunner 19:59:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:59:05 INFO - Running setup.py install for mozscreenshot 19:59:05 INFO - Running setup.py install for moztest 19:59:05 INFO - Running setup.py install for mozversion 19:59:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:59:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:59:05 INFO - Cleaning up... 19:59:05 INFO - Return code: 0 19:59:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:05 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 0x7fa4b745cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a350>, '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 0x1c8b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', '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 19:59:05 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 19:59:05 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 19:59:05 INFO - Using env: {'DISPLAY': ':0', 19:59:05 INFO - 'HOME': '/home/cltbld', 19:59:05 INFO - 'LANG': 'en_US.UTF-8', 19:59:05 INFO - 'LANGUAGE': 'en_US:en', 19:59:05 INFO - 'LOGNAME': 'cltbld', 19:59:05 INFO - 'MAIL': '/var/mail/cltbld', 19:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:05 INFO - 'MOZ_NO_REMOTE': '1', 19:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:05 INFO - 'NO_EM_RESTART': '1', 19:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:05 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:05 INFO - 'SHELL': '/bin/bash', 19:59:05 INFO - 'SHLVL': '1', 19:59:05 INFO - 'TERM': 'linux', 19:59:05 INFO - 'TMOUT': '86400', 19:59:05 INFO - 'USER': 'cltbld', 19:59:05 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', 19:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:05 INFO - '_': '/tools/buildbot/bin/python'} 19:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:05 INFO - Running setup.py (path:/tmp/pip-mWGWwM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:05 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)) 19:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:05 INFO - Running setup.py (path:/tmp/pip-OhcQP4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:05 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)) 19:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:05 INFO - Running setup.py (path:/tmp/pip-dKzzFa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:05 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)) 19:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:06 INFO - Running setup.py (path:/tmp/pip-6o3afE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:06 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)) 19:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:06 INFO - Running setup.py (path:/tmp/pip-ubgkvP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:06 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)) 19:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:06 INFO - Running setup.py (path:/tmp/pip-dV4QIi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:06 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)) 19:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:06 INFO - Running setup.py (path:/tmp/pip-emlHuV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:06 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)) 19:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:06 INFO - Running setup.py (path:/tmp/pip-lmbpF2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:06 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)) 19:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:06 INFO - Running setup.py (path:/tmp/pip-jfJO0z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:06 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)) 19:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:06 INFO - Running setup.py (path:/tmp/pip-Vx_Izg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:06 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)) 19:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:06 INFO - Running setup.py (path:/tmp/pip-O2PXZk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:06 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)) 19:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:06 INFO - Running setup.py (path:/tmp/pip-peTu3O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:06 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)) 19:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:06 INFO - Running setup.py (path:/tmp/pip-2uJQzy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:06 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)) 19:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:06 INFO - Running setup.py (path:/tmp/pip-RPqtTf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:06 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)) 19:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:06 INFO - Running setup.py (path:/tmp/pip-s6y14m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:06 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)) 19:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:06 INFO - Running setup.py (path:/tmp/pip-3BFtcZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:06 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)) 19:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:06 INFO - Running setup.py (path:/tmp/pip-R0YyXQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:07 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)) 19:59:07 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)) 19:59:07 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)) 19:59:07 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)) 19:59:07 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)) 19:59:07 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)) 19:59:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:08 INFO - Downloading blessings-1.5.1.tar.gz 19:59:08 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 19:59:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:59:08 INFO - Installing collected packages: blessings 19:59:08 INFO - Running setup.py install for blessings 19:59:08 INFO - Successfully installed blessings 19:59:08 INFO - Cleaning up... 19:59:08 INFO - Return code: 0 19:59:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:59:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:59:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:59:09 INFO - Reading from file tmpfile_stdout 19:59:09 INFO - Current package versions: 19:59:09 INFO - argparse == 1.2.1 19:59:09 INFO - blessings == 1.5.1 19:59:09 INFO - blobuploader == 1.2.4 19:59:09 INFO - docopt == 0.6.1 19:59:09 INFO - manifestparser == 1.1 19:59:09 INFO - mozInstall == 1.12 19:59:09 INFO - mozcrash == 0.16 19:59:09 INFO - mozdebug == 0.1 19:59:09 INFO - mozdevice == 0.47 19:59:09 INFO - mozfile == 1.2 19:59:09 INFO - mozhttpd == 0.7 19:59:09 INFO - mozinfo == 0.9 19:59:09 INFO - mozleak == 0.1 19:59:09 INFO - mozlog == 3.1 19:59:09 INFO - moznetwork == 0.27 19:59:09 INFO - mozprocess == 0.22 19:59:09 INFO - mozprofile == 0.27 19:59:09 INFO - mozrunner == 6.11 19:59:09 INFO - mozscreenshot == 0.1 19:59:09 INFO - mozsystemmonitor == 0.0 19:59:09 INFO - moztest == 0.7 19:59:09 INFO - mozversion == 1.4 19:59:09 INFO - psutil == 3.1.1 19:59:09 INFO - requests == 1.2.3 19:59:09 INFO - wsgiref == 0.1.2 19:59:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:09 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')]} 19:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:09 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')]} 19:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:09 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 0x7fa4b745cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a350>, '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 0x1c8b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', '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 19:59:09 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 19:59:09 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 19:59:09 INFO - Using env: {'DISPLAY': ':0', 19:59:09 INFO - 'HOME': '/home/cltbld', 19:59:09 INFO - 'LANG': 'en_US.UTF-8', 19:59:09 INFO - 'LANGUAGE': 'en_US:en', 19:59:09 INFO - 'LOGNAME': 'cltbld', 19:59:09 INFO - 'MAIL': '/var/mail/cltbld', 19:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:09 INFO - 'MOZ_NO_REMOTE': '1', 19:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:09 INFO - 'NO_EM_RESTART': '1', 19:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:09 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:09 INFO - 'SHELL': '/bin/bash', 19:59:09 INFO - 'SHLVL': '1', 19:59:09 INFO - 'TERM': 'linux', 19:59:09 INFO - 'TMOUT': '86400', 19:59:09 INFO - 'USER': 'cltbld', 19:59:09 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', 19:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:09 INFO - '_': '/tools/buildbot/bin/python'} 19:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:09 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)) 19:59:09 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)) 19:59:09 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)) 19:59:09 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)) 19:59:09 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)) 19:59:09 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)) 19:59:09 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)) 19:59:09 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)) 19:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:59:09 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)) 19:59:09 INFO - Cleaning up... 19:59:09 INFO - Return code: 0 19:59:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:59:09 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')]} 19:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:09 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')]} 19:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:09 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 0x7fa4b745cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a350>, '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 0x1c8b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', '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 19:59:09 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 19:59:09 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 19:59:09 INFO - Using env: {'DISPLAY': ':0', 19:59:09 INFO - 'HOME': '/home/cltbld', 19:59:09 INFO - 'LANG': 'en_US.UTF-8', 19:59:09 INFO - 'LANGUAGE': 'en_US:en', 19:59:09 INFO - 'LOGNAME': 'cltbld', 19:59:09 INFO - 'MAIL': '/var/mail/cltbld', 19:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:09 INFO - 'MOZ_NO_REMOTE': '1', 19:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:09 INFO - 'NO_EM_RESTART': '1', 19:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:09 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:09 INFO - 'SHELL': '/bin/bash', 19:59:09 INFO - 'SHLVL': '1', 19:59:09 INFO - 'TERM': 'linux', 19:59:09 INFO - 'TMOUT': '86400', 19:59:09 INFO - 'USER': 'cltbld', 19:59:09 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', 19:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:09 INFO - '_': '/tools/buildbot/bin/python'} 19:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:09 INFO - Downloading/unpacking jsonschema 19:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:59:11 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 19:59:11 INFO - Downloading/unpacking functools32 (from jsonschema) 19:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:11 INFO - Downloading functools32-3.2.3-2.tar.gz 19:59:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:59:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:59:11 INFO - warning: no files found matching '*.txt' 19:59:11 INFO - no previously-included directories found matching 'build' 19:59:11 INFO - no previously-included directories found matching 'dist' 19:59:11 INFO - no previously-included directories found matching '.git*' 19:59:11 INFO - Installing collected packages: jsonschema, functools32 19:59:11 INFO - Running setup.py install for functools32 19:59:11 INFO - warning: no files found matching '*.txt' 19:59:11 INFO - no previously-included directories found matching 'build' 19:59:11 INFO - no previously-included directories found matching 'dist' 19:59:11 INFO - no previously-included directories found matching '.git*' 19:59:11 INFO - Successfully installed jsonschema functools32 19:59:11 INFO - Cleaning up... 19:59:11 INFO - Return code: 0 19:59:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4b745cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bfb600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8a350>, '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 0x1c8b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', '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 19:59:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:59:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:59:11 INFO - Using env: {'DISPLAY': ':0', 19:59:11 INFO - 'HOME': '/home/cltbld', 19:59:11 INFO - 'LANG': 'en_US.UTF-8', 19:59:11 INFO - 'LANGUAGE': 'en_US:en', 19:59:11 INFO - 'LOGNAME': 'cltbld', 19:59:11 INFO - 'MAIL': '/var/mail/cltbld', 19:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:11 INFO - 'MOZ_NO_REMOTE': '1', 19:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:11 INFO - 'NO_EM_RESTART': '1', 19:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:11 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:11 INFO - 'SHELL': '/bin/bash', 19:59:11 INFO - 'SHLVL': '1', 19:59:11 INFO - 'TERM': 'linux', 19:59:11 INFO - 'TMOUT': '86400', 19:59:11 INFO - 'USER': 'cltbld', 19:59:11 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', 19:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:11 INFO - '_': '/tools/buildbot/bin/python'} 19:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:11 INFO - Downloading/unpacking flake8 19:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:59:13 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 19:59:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:59:13 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 19:59:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:13 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 19:59:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:59:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:14 INFO - no previously-included directories found matching 'docs/_build' 19:59:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:59:14 INFO - Running setup.py install for pep8 19:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:14 INFO - no previously-included directories found matching 'docs/_build' 19:59:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:59:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:59:14 INFO - Cleaning up... 19:59:14 INFO - Return code: 0 19:59:14 INFO - Running post-action listener: _resource_record_post_action 19:59:14 INFO - Running post-action listener: _start_resource_monitoring 19:59:14 INFO - Starting resource monitoring. 19:59:14 INFO - ##### 19:59:14 INFO - ##### Running install step. 19:59:14 INFO - ##### 19:59:14 INFO - Running pre-action listener: _resource_record_pre_action 19:59:14 INFO - Running main action method: install 19:59:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:59:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:59:14 INFO - Reading from file tmpfile_stdout 19:59:14 INFO - Detecting whether we're running mozinstall >=1.0... 19:59:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:59:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:59:14 INFO - Reading from file tmpfile_stdout 19:59:14 INFO - Output received: 19:59:14 INFO - Usage: mozinstall [options] installer 19:59:14 INFO - Options: 19:59:14 INFO - -h, --help show this help message and exit 19:59:14 INFO - -d DEST, --destination=DEST 19:59:14 INFO - Directory to install application into. [default: 19:59:14 INFO - "/builds/slave/test-pgo"] 19:59:14 INFO - --app=APP Application being installed. [default: firefox] 19:59:14 INFO - mkdir: /builds/slave/test-pgo/build/application 19:59:14 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'] 19:59:14 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 19:59:30 INFO - Reading from file tmpfile_stdout 19:59:30 INFO - Output received: 19:59:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:59:30 INFO - Running post-action listener: _resource_record_post_action 19:59:30 INFO - ##### 19:59:30 INFO - ##### Running run-tests step. 19:59:30 INFO - ##### 19:59:30 INFO - Running pre-action listener: _resource_record_pre_action 19:59:30 INFO - Running main action method: run_tests 19:59:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:59:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:59:30 INFO - Python 2.7.3 19:59:30 INFO - Return code: 0 19:59:30 INFO - grabbing minidump binary from tooltool 19:59: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')]} 19:59: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 0x1c8a350>, '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 0x1c8b250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:59: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 19:59: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 19:59:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:30 INFO - Return code: 0 19:59:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:59:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:59:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:59:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:59:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:59:31 INFO - Return code: 0 19:59: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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 19:59: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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost 19:59:31 INFO - Using env: {'DISPLAY': ':0', 19:59:31 INFO - 'HOME': '/home/cltbld', 19:59:31 INFO - 'LANG': 'en_US.UTF-8', 19:59:31 INFO - 'LANGUAGE': 'en_US:en', 19:59:31 INFO - 'LOGNAME': 'cltbld', 19:59:31 INFO - 'MAIL': '/var/mail/cltbld', 19:59:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:31 INFO - 'MOZ_NO_REMOTE': '1', 19:59:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:31 INFO - 'NO_EM_RESTART': '1', 19:59:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:31 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:59:31 INFO - 'SHELL': '/bin/bash', 19:59:31 INFO - 'SHLVL': '1', 19:59:31 INFO - 'TERM': 'linux', 19:59:31 INFO - 'TMOUT': '86400', 19:59:31 INFO - 'USER': 'cltbld', 19:59:31 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997', 19:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:31 INFO - '_': '/tools/buildbot/bin/python'} 19:59: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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] with output_timeout 3600 19:59:31 INFO - mozversion INFO | application_buildid: 20151218173004 19:59:31 INFO - mozversion INFO | application_changeset: 36aa441232b7e8cc82b0a83d1b343fd3ace134a7 19:59:31 INFO - mozversion INFO | application_display_name: Nightly 19:59:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:31 INFO - mozversion INFO | application_name: Firefox 19:59:31 INFO - mozversion INFO | application_remotingname: firefox 19:59:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:59:31 INFO - mozversion INFO | application_vendor: Mozilla 19:59:31 INFO - mozversion INFO | application_version: 46.0a1 19:59:31 INFO - mozversion INFO | platform_buildid: 20151218173004 19:59:31 INFO - mozversion INFO | platform_changeset: 36aa441232b7e8cc82b0a83d1b343fd3ace134a7 19:59:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:59:31 INFO - mozversion INFO | platform_version: 46.0a1 19:59:31 INFO - 2015-12-18 19:59:31,727 DEBUG : using testdate: 1450497571 19:59:31 INFO - 2015-12-18 19:59:31,727 DEBUG : actual date: 1450497571 19:59:31 INFO - 2015-12-18 19:59:31,801 INFO : starting webserver on 'localhost:45647' 19:59:31 INFO - 2015-12-18 19:59:31,803 INFO : Starting test suite talos-linux64-ix-054 19:59:31 INFO - 2015-12-18 19:59:31,803 INFO : Starting test dromaeo_css 19:59:31 INFO - 2015-12-18 19:59:31,803 DEBUG : operating with platform_type : linux_ 19:59:31 INFO - 2015-12-18 19:59:31,803 INFO : Initialising browser for dromaeo_css test... 19:59:31 INFO - 2015-12-18 19:59:31,816 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVvj4Xo/profile http://localhost:45647/getInfo.html 19:59:36 INFO - 2015-12-18 19:59:36,248 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:59:36 INFO - 2015-12-18 19:59:36,248 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:59:36 INFO - 2015-12-18 19:59:36,248 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:59:36 INFO - 2015-12-18 19:59:36,248 DEBUG : BROWSER_OUTPUT: __metrics 19:59:36 INFO - 2015-12-18 19:59:36,377 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] 19:59:36 INFO - 2015-12-18 19:59:36,433 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:59:37 INFO - 2015-12-18 19:59:37,386 INFO : Browser initialized. 19:59:37 INFO - 2015-12-18 19:59:37,386 INFO : Running cycle 1/1 for dromaeo_css test... 19:59:37 INFO - 2015-12-18 19:59:37,387 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVvj4Xo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:59:49 INFO - 2015-12-18 19:59:49,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 149934080 19:59:49 INFO - 2015-12-18 19:59:49,203 DEBUG : BROWSER_OUTPUT: 20:00:39 INFO - 2015-12-18 20:00:39,870 DEBUG : BROWSER_OUTPUT: 1450497639867 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:02:49 INFO - 2015-12-18 20:02:49,794 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45647/tests/dromaeo/cssquery-ext.html) 20:02:50 INFO - 2015-12-18 20:02:50,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 274251776 20:02:50 INFO - 2015-12-18 20:02:50,923 DEBUG : BROWSER_OUTPUT: 20:05:53 INFO - 2015-12-18 20:05:53,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/dromaeo/cssquery-ext.html (next: http://localhost:45647/tests/dromaeo/cssquery-jquery.html) 20:05:53 INFO - 2015-12-18 20:05:53,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 232202240 20:05:53 INFO - 2015-12-18 20:05:53,874 DEBUG : BROWSER_OUTPUT: 20:08:55 INFO - 2015-12-18 20:08:55,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45647/tests/dromaeo/cssquery-mootools.html) 20:08:56 INFO - 2015-12-18 20:08:56,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 233062400 20:08:56 INFO - 2015-12-18 20:08:56,306 DEBUG : BROWSER_OUTPUT: 20:11:58 INFO - 2015-12-18 20:11:58,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45647/tests/dromaeo/cssquery-prototype.html) 20:11:58 INFO - 2015-12-18 20:11:58,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 210161664 20:11:58 INFO - 2015-12-18 20:11:58,745 DEBUG : BROWSER_OUTPUT: 20:15:01 INFO - 2015-12-18 20:15:01,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45647/tests/dromaeo/cssquery-yui.html) 20:15:01 INFO - 2015-12-18 20:15:01,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 214282240 20:15:01 INFO - 2015-12-18 20:15:01,765 DEBUG : BROWSER_OUTPUT: 20:18:04 INFO - 2015-12-18 20:18:04,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/dromaeo/cssquery-yui.html (next: http://localhost:45647/tests/dromaeo/cssquery-dojo.html) 20:18:04 INFO - 2015-12-18 20:18:04,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 261902336 20:18:04 INFO - 2015-12-18 20:18:04,635 DEBUG : BROWSER_OUTPUT: 20:18:04 INFO - 2015-12-18 20:18:04,635 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:18:04 INFO - 2015-12-18 20:18:04,635 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:18:04 INFO - 2015-12-18 20:18:04,635 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:18:04 INFO - 2015-12-18 20:18:04,635 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:18:04 INFO - 2015-12-18 20:18:04,635 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3121.672224416436;3182.2680783419796;3223.5325877747728;3227.1932016995765;3242.756793240506;5200.739963001844;5326.387465441476;5400.864978375537;5451.427600101987;5457.454254574545;5339.172428273614;5346.732663366826;5446.591505637083;5486.91769623456;5492.725363731817;4871.585915197204;4939.135651261015;4957.25641153828;4974.602031837444;5027.321311622939;4870.586000189988;5037.899242015157;5061.974690126544;5080.288759573663;5130.640855140142;4839.709617422948;4904.950950490521;4926.75366231687;4935.506449355072;4950.579200767939;4892.511492560405;4896.755162241873;4914.606831453475;4930.80276788928;4948.703077815343;4760.690555113941;4846.854594362139;4890.058409584779;4900.975495122537;4929.876753081166;5248.265242866002;5334.146536554172;5339.866503337447;5340.172273297606;5374.758135883894;5876.823695289106;5881.558883083786;5887.146363777271;5887.5584331174905;5906.143609176688;5673.404292549264;5819.970900145515;5842.2405087338375;5914.940850591482;5926.585139040269;5475.534579560703;5477.4248703886315;5480.232767412565;5480.369757477862;5503;5919.3192782829665;5930.55520835939;5931.911021334683;5934.465898069195;5936.1392598073035;5594.272744543265;5653.943460565424;5663.320401551758;5710.314762228559;5720.656760594377;5773.451522105393;5783.88432231353;5813.5349172066135;5892.499137573269;5904.7933322334375;5844.59087863854;5852.912206316909;5875.441833025856;5887.911681324784;5899.144624029492;5699.373068962411;5808.215890854765;5866.472017518444;5893;5896.115582662549;4385.320275357325;4402.581754733295;4442.378067070613;4450.354698568754;4480.439945006874;3967.2263908538134;3989.3018721723583;3999.7800120993043;4041.4948131483566;4044.757314561136;5321.175217841241;5463.617546771768;5468.234447177399;5472.589555783332;5475.342958844964;5750.051241545182;5810.070388737781;5836.970815145897;5882.941170588239;5898.115282707542;5401.270828438189;5549.5837812164245;5570.303712035996;5576.247206627054;5578;5042.39491261051;5082.161443361878;5110.540051395392;5110.795568177231;5156.92264616031;5809.970950145223;5836.299644042657;5960.04639257708;5963.582549221513;6004.819855404257;5829.650220986754;5879.529637629065;5893.057110862242;5907.911381329198;5910.379410162043;5991.580589358878;5992.910106348321;6001.969990150022;6001.969990150196;6003.87992240144;5582.051051321204;5593.105103183471;5649.774009039593;5723.771049157987;5807.361190268983;5845.18167456548;5849.707514624337;5854.677992710272;5856.707164641836;5857.297124345106;5663.518600918803;5664.688442135722;5708.115242137475;5726.79956201531;5730.684812335361;5480.931218412531;5542.196381524737;5634.492895639412;5681.829545113488;5684.431556844283;5537.972310138423;5546.58400619947;5559.471850174227;5593.272874526286;5594.692291923983;5677.489025987681;5686.658800471985;5689.943100568941;5697.487226149667;5740.368559458373;5462.9180562292395;5463.262459568066;5518.834434966958;5571.3592936811165;5571.8885622288135 20:18:04 INFO - 2015-12-18 20:18:04,635 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.6008560521345;591.2609238451935;594.2453084582583;597.4712379544103;600.8648054187805;29865.850670746644;37542;38605.22789544214;38719.225615487674;38723.99999999996;41977.58022419775;42368.78815605918;42436;42443.78778106113;42471.362929556;7479.9252007480045;7587.544747315151;8610.999999999984;8843;8847.646094156225;10395.480225988707;10589.311694739856;10598.682039538826;10603.416812075333;10612.522436490377;10164.593416263378;10245.743856403613;10253.84619230712;10256.641017564387;10268.024537668909;7700.345470635003;7878.487898286593;10269.948650256776;10357.274990750613;10429.582816687323;10068.89931100687;10119.544620492095;10167.288289819715;10170.44062576558;10239.84640230397;39014.804925975186;39425;39433;39445.60554394477;39494.60505394938;3186.6494685584566;3279.311344617633;3287.1946373138494;3345.631980482169;3574.195805943668;29405.264868378246;29956.400871982656;30013.549796753065;30023.849880750677;30371.392572148656;3435.811030393327;3446.6897979181745;3465.6187819339852;3513.5608048993877;3536.6580568249606;253805;253970;254220;255301;256681;58369;58859;58920;58955.410445894995;58961;61349.693251533456;61522.384776151666;61602;62040;62074.689626552485;13343;13433.731325373437;13502.527411540548;13520.459181632821;13559.932200339132;10297.12474439666;10394.532246048795;10404.814988852426;10411.635592754217;10416.791664166674;18209.307726134037;19595.11821968015;19810.50473738168;19824.90087549553;19841.503962401057;7682.846343073107;7781.299683028555;7862.2923936845955;7892.1463300070045;7910.920890791019;957.5882370580717;999.4303247149201;1003.5835128421769;1012.1649639047815;1082.3884505254507;28201;28486.287842804097;28513.193521635894;28657.28356791097;28770.712292876804;946.976325591852;1026.3892983674702;1060.5015642647943;1078.6710053433778;1108.14672702019;14562.41750329975;15360.071345405857;15868.682626347409;16008.742517944562;16092.356305747639;298093;299961;301763;302223;308361;43527.34708979368;44250.55749442529;49690.751546242034;51944;51994.74002629962;1322.3784821134052;1324.1062282958965;1329.3818374455732;1341.2086868747485;1349.015218890196;25924.48151036931;27340.72659273382;27771.44457110887;28483;28941.56587651229;42814;43740.781296093315;46584.06831863276;47731.28403074026;47853.521464784906;196264.01867990568;197038;197160;197295;197939;28583.285417863888;28816.135515934555;28893.27766805847;28990.27524311909;29006.854965725037;38862.6113738859;39985.40021899732;40282.597174027884;40543.594564055165;40674.38988415117;35934.460983085795;36404.453933190496;36654.26691466102;36769.26461470809;37871.43192852054;36373.45439818458;36847.63152368549;37065.81467092647;37081;37428.251434971695;35967.460488092176;36079.45880811843;36871;36946.44580331351;36953.815230923676;28400;29895.206287622812;31060.844695776377;31605;31616.525752114198;25430.872845635655;25449.745502544738;25454.872725636254;25566.48867022612;25743.356416089748 20:18:04 INFO - 2015-12-18 20:18:04,635 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.88036067736965;359.8686479435006;361.32612677356707;361.5679263280379;364.56434560699955;13979.833125865507;14107.435702571885;16154.353825846953;16284;16961.745573816403;13910.791338129937;14246.430142794276;14708.779368309457;15485.380584776623;16125.596860078504;5406.99999999999;5526.226328314039;5561.916571251434;5571.13647384656;5571.609987300891;3735.2902948439846;3806.200697853454;5163.974180129113;5541.5843811714085;5576.776928922838;5385.138377859544;5542.251796007527;5574.303212098488;5580.330360356763;5588.050031494636;5319.0957537218765;5382.9730851345885;5422.942526207371;5506.5870059745475;5533.501984821365;5124.718140502271;5159.845204643867;5173.068847607429;5173.5602473789395;5175.870603234912;12913.483460661562;12945.093843430963;12957.546485873043;12960.768726970922;19584.902075489532;1990.462575104728;1996.6805311150292;2050.5693804301113;2092.200348866185;2113.619548481273;9069.319801014884;11518.596849110325;13133.737325253536;13137.86862131376;13637.113587616774;1789.4005508154785;1810.8551315894697;1817.1277786662345;1853.4902901702005;1862.5622978600018;59484.70257648684;61729.07406388863;62672;62739;62800;10152.796944061078;10190.847137292947;10260.538275777608;10302.536385862653;10362.948185259025;13640.727185456235;13641.181529108286;13690.794638080437;13702.65743356424;13722.176669399869;7573.242675732493;7620.504667196615;7630;7630.847383052419;7705.229477052362;7390.778276651709;7428;7456.664450099758;7479.813004674817;7485.47601667878;4403.185410699031;4465.687401881837;4486.102779444124;4487.932681009787;4499.55004499554;1699.345751885533;1739.4694618141336;1761.7093179625474;1777.8044415114327;1812.864035197339;422.26525845029425;434.8021650149175;477.0387668847276;934.3506263147048;1054.2514814481651;10183.236257280734;10587.258891877495;10610.893891061145;10623.36259824413;10689.9465502672;410.60786948464147;440.5503916552269;453.19331589770263;455.72656406156705;467.306050514985;5634.352049514358;5772.6536407815665;5774.740136693859;5798.971005144947;5850.180974663551;519455;531030;542911;543386;555146;69629.65185174042;70442;73030.63484682543;80282.59858700786;81782;1175.1245322234818;1177.6879127031343;1191.7318603314186;1199.1366216324232;1231.655136561764;14918;15032.774508382601;15415.152166630944;15428.84571154274;15491.380344786083;35252.64747352596;35283.647163529065;36222;37006.814965925;37311.626883730816;46957.53042469532;47521.62391880462;47924.28113578369;49005;51592.48407515877;9610.327277090537;9719.27105467107;9818.950905245429;9850.113489785954;9855.852162217428;15002.399904003718;17344.13279336003;17605.735913961045;17669.469915902544;17751.55621109431;11174.385408802595;13209.933950330187;13665.248411337074;14080.929595351958;14482.493112741004;13457.528986485817;13690.726185476435;13771.931140344233;14211.147331160164;14404.711905762035;13891.583252502442;13984.370703318578;14085.295735213404;14093.788593171315;14712.117272963656;9414.952925235604;9578.760530986503;9579.13787759105;9603.471809050568;9615.663451779154;13816.861831381557;14363.784543231652;14517.491887783877;14623.41506339777;14805.259737013323 20:18:04 INFO - 2015-12-18 20:18:04,635 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1286.1575667937498;1292.198836721233;1352.6280272924944;1559.1658462722446;1610.5007447691216;6580.572262802921;7102.218755936849;7411.295926886951;7418.740344087958;7424.628768561577;7194.712211511546;7318.121825380962;7336.889946650791;7349.77950661481;7366.300201480864;1981.3758666020158;2022.302305704537;2167.9783202167932;2196.5057861981086;2203.22886989554;2219.655953327237;2220.0897631970897;2223.655333423322;2224.810891074261;2226.7105276314137;2177.6515757478805;2242.394553470562;2246.539459410825;2246.6068438023362;2247.606668832956;2237.5077482953807;2239.9552008959813;2261.1294651559106;2271.4775601611723;2278.1229226747737;2230.988845055764;2247.1910112359537;2260.762619924917;2262.1856131792542;2299.091858715798;7250.782476525713;7256.637168141625;7265;7314.34170924614;7330.560166390033;4366.978165109186;4417.028253784162;4422.800973956148;4437.9112417751785;4441.822327106912;2971.747401470856;3022.4710675631677;3046.2536678513907;3050.435669401168;3088.922776930572;996.4220751963844;1013.1692012549712;1036.0882423467376;1069.0485467933545;1088.3361149698678;9758.268129890286;9767.316287859852;9777.31558790885;9786.755331116708;9816;4004.959950400517;4060.939085913714;4080.265552200573;4080.7755573443746;4151;8365.8326833463;8380.287675547524;8389.790255243668;8398.874016889751;8410.537420441811;4435.35687325336;4441.800118994653;4466.709663871903;4468.061707041557;4476.843310484118;4097.528784189797;4120.938185927213;4128.6284234419045;4131.5248746393945;4133.545310015896;3075.7539396848197;3105.0219180957924;3448.896533104011;3549.254656522108;3568.411212150018;1133.7845809296207;1189.9405029748477;1190.1193117093462;1196.5692350753723;1201.2372143688647;1009.1018993096151;1066.8293073108266;1072.5816931396762;1159.640511441439;1248.581725122076;6958.860822783516;6960.269171736996;7077.752278670325;7077.787666370017;7078.1506219254015;1054.9894501055044;1060.4114716332356;1062.7715041266165;1083.160550573312;1117.4803716271972;5378.542823859937;5522;5528.419515950848;5536.280283563192;5538.335399752055;8450;8616.870746938675;8726.171013753683;8782.297416206688;8859.867101993346;8662.566871656392;8742.475451472805;8766.386352955233;8778.473291602397;8807.33944954131;6425.646589437626;6588.484648530864;6631.535792494479;6663.300353462817;6669.533132680763;6757.189137303555;6775.085363475868;6792.76225332111;6793.082933804071;6793.592384456949;7758.88361674564;7951.483153594998;7960.562169080757;7973.322267607318;7980.960095199487;7865.488743231672;8058.597070146587;8062.7581172564915;8075.5558444286125;8171.918280817354;6203.751849925952;6432.195975503062;6483.967580162069;6486.902696459462;6490.578112422678;6138.570300078952;6324.114623952558;6335.366463353628;6434.0670602763275;6793.354631310018;6206.503479721701;6291.087792270187;6330.272018717907;6372.490200784019;6381.680915954276;6258.12386265914;6317.368263173646;6326.841828954313;6329.30377658448;6353.110564521063;6321.778737744157;6340.778072767431;6352.555321127476;6361.554691171574;6362.045693146065;5904.409559044061;5919.704014799329;5926.970365148147;5927.644341339534;5932.110183472513;5899.17411562373;5944.524438045032;5981.880362392641;5993;6084.878302433838 20:18:04 INFO - 2015-12-18 20:18:04,639 DEBUG : BROWSER_OUTPUT: |4;prototype.html;332.74389180842326;338.09728026170126;339.794424373254;344.2959148541233;347.7808980342384;6002.159697642328;6086.421789929961;6115.969420152893;6125.418085281903;6129.785457508993;5703.600747947646;5734.455226753462;5804.158397032428;5982.940170598293;5992;4527.773611319437;4555.954440455586;4587.403637527117;4593.655475839309;4599.149157405874;4572.177008138534;4575.588197062264;4582.312653102028;4585.793639286224;4588.816447342119;4386.780660966955;4472.396226509412;4511.932321015187;4597.885052873671;4621.722696638196;4588.334691469735;4597.7241365518175;4602.125596136723;4615.930761038587;4626.953730462703;4077.245709543744;4080.510338759368;4083.9591604083876;4087.0804069084516;4087.8773636790943;5681.715914204273;5709.77160913563;5717.628354157008;5719.14212868069;5743.138529220609;5168.689878607295;5271;5338.839834804962;5340.465953404668;5345.545628621572;6357.936420635827;6359.650219237987;6359.713812878432;6360.650164240965;6377.3303803100935;4432.556744325574;4433.600975912151;4438.378626992224;4438.955610443919;4439.933400998988;6490.772822951221;6575.704093315812;6629.270780214172;6631.86736265272;6657.53397262187;4579.771011449481;4585.060062687141;4586.8165273388695;4587.770611469413;4592.2193227151465;4642.396488456479;4643.094596553708;4647;4649.790759415834;4650.767461626972;5350.705711185844;5356.571474282048;5357.946420535823;5360.0351936650995;5360.8123715670545;6229.906551401733;6361.236651601745;6420.454261387835;6424.0042793366165;6432.195975503062;1616.062683643484;1625.7805196298584;1633.3874796951143;1641.5321633334443;1644.3915751172142;1083.160550573312;1086.913086913087;1088;1092.7705181911888;1114.6210288501948;6158.645098078416;6162.291336496361;6166.8724290119835;6168.414000669929;6168.8766224675255;6648.833779155463;6650.634215118215;6654.201495820435;6658.43403310724;6658.9001164982565;5976.163337132805;6064.423879731418;6135.171751813537;6228.096925945803;6237.09562113491;3586.946195807065;3606.891793246207;3608.404613238839;3610.205754733954;3610.801405922647;6816.591004539743;6828.487863410165;6832.965835170892;6837;6839.487038472134;6725.899111513331;6851.657417129124;6879.071325371111;6881.793546193622;6882.931170688229;6817.11377520929;6821.079154314203;6827.1807383113355;6828.2147553031045;6828.7268509259075;6696.096027036482;6697.129373181455;6703.396694297537;6705.597664140168;6710.698018589273;6417.069524918954;6579;6579.605223686594;6583.275839657538;6583.407493325623;6763.458923286027;6771.695273712793;6825.692843822139;6830.965845170941;6839.213490448662;4527.026689261825;4560.5895469407915;4567.588916997353;4569.520200378913;4578.771061446981;6492.415682588401;6631.270560238467;6632.734690612321;6682.264950855305;6697.397234248941;6502.772402965874;6504.739810407531;6506.219253689587;6511.21865376139;6517.869642607026;6436.742530298923;6472.35276472349;6473.741050357933;6493.383128602775;6511.9348806511325;6211.409916057967;6405.19935008124;6410.0705397718;6413;6417.48660107181;6547.1161393211305;6551.279359270381;6551.737930482727;6554.4756419485375;6556.934430655632;6248.4376406123665;6395.360463953567;6406.103145559532;6406.679666016587;6409.647469389229 20:18:04 INFO - 2015-12-18 20:18:04,639 DEBUG : BROWSER_OUTPUT: |5;yui.html;720.9351158395743;722.5231347310776;760.6691089376121;781.9990412272293;789.0728394136895;12630.242185468878;12919.160254583445;12921.418536165871;12942.676433089178;12955.222686638808;11969;13169.341532923363;13190.208587484758;13202.603921882335;13211.867881321185;682.8634273145391;692.1763101908713;814.6293436486415;827.7971896885272;844.1263292492272;813.9186081391873;814.9837003259931;815.2988429950238;822.411975437562;822.5845947796355;712.1774350625011;858.6264974735979;861.7716305179133;863.9049704532528;865.6321063547967;716.2837162837163;857.6826574167567;870.2168048756107;871.0723079919928;873.1922971251566;638.0174531221912;638.4892086330917;639.1435476461564;639.6130341143588;640.0463309668606;12729.490820367175;12799.808002879965;12852.22886626796;12867.22796632205;12894.290814005226;11288.153388495813;11703.122265830098;12279.93860030703;12456.31490268035;12602.581179440394;9783.46190959497;9857.457839818808;9911.801763964753;9977.351472154287;10310.175185985103;3458.3774920514297;3496.947545786815;3499.91250218744;3549.94675079874;3557.8576856925692;44306.113877722586;44733.55266447327;44971;45034;45726;9398.060193980684;9413;9446.574904129331;9565.186959108414;9736.318457708034;16898.662026759397;17033.574160645836;17036.57408564771;17041.573960650836;17066.573335666708;7128.893066604005;7211.459140564479;7318.817029574303;7409.481336306407;7509.887351689729;4216.885367665263;4237.237297286456;4260.041490664576;4261.595148460891;4267.701260911706;3070.8925187618324;3086.90739277822;3099.3336432667083;3102.146909599878;3102.534619807047;577.8439821248323;578.0808514462026;593.0807248764484;625.6746491824226;662.1689779326914;591.961522501036;647.0876064748682;658.7858945842524;672.7843874446619;732.0775822463734;7844.450888437755;7952.880706789403;8033.758987230392;8084.627101908802;8276.29651479619;579.6782785553974;644.4672486701626;721.9314165154302;732.952358096722;746.0525133080956;3540.433530635086;3646.7447278690765;3657.451382292624;3780.4140358244517;3879.321118804198;52002.73998629983;52228;53278.46721532813;57486;57495.425045749005;47408.762956185;49248.75375623099;49783;50044.74977625089;50073.749631252336;43246.7837660816;43873.78063109664;44216.55783442189;44903.326450103275;45051.774741126086;7812.765617031499;7925.643346049326;7976.397292278302;8233.259006689426;8391.118932511998;33416.33167336688;34193.31613367768;34718.65281347154;35187.64812351946;35287.82356088203;41638.58361416347;41900.37149442822;42050.1589968205;42871.57128428676;43047.13905721805;10424.530896109542;10502.737431564272;11190.720231994264;11312.434378280888;11354.375509347065;11964;11981.700457488632;12045.397730113635;12695.492180312684;12841.422136003715;10631.840522392326;11014.669559913216;11212.27120237182;11557.942210288895;11582.725900151145;11043.779124417306;11183.161262905478;11300;11675.464047261214;11823.46794394237;11211.887881121085;11456.255343402652;11488.483018264365;11550.537978480766;11635.069194464253;9706.36378153932;9816.901830981598;9933;10008.14930730867;10039.69880903574;8875.047489552288;8985.371024028254;9261.72214833556;9273.67542136022;9597.568109434953 20:18:04 INFO - 2015-12-18 20:18:04,639 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:18:04 INFO - 2015-12-18 20:18:04,639 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:18:04 INFO - 2015-12-18 20:18:04,639 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,903 20:18:04 INFO - 2015-12-18 20:18:04,639 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:18:04 INFO - 2015-12-18 20:18:04,639 DEBUG : BROWSER_OUTPUT: __startTimestamp1450498684628__endTimestamp 20:18:04 INFO - 2015-12-18 20:18:04,639 DEBUG : BROWSER_OUTPUT: 20:18:04 INFO - 2015-12-18 20:18:04,639 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:18:04 INFO - 2015-12-18 20:18:04,639 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:18:04 INFO - 2015-12-18 20:18:04,639 DEBUG : BROWSER_OUTPUT: 20:18:04 INFO - 2015-12-18 20:18:04,640 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5397.10 Median:5571.89 stddev:604.49 (10.8%) stddev-sans-first:579.39 20:18:04 INFO - 2015-12-18 20:18:04,641 DEBUG : BROWSER_OUTPUT: Values: 3121.7 3182.3 3223.5 3227.2 3242.8 5200.7 5326.4 5400.9 5451.4 5457.5 5339.2 5346.7 5446.6 5486.9 5492.7 4871.6 4939.1 4957.3 4974.6 5027.3 4870.6 5037.9 5062.0 5080.3 5130.6 4839.7 4905.0 4926.8 4935.5 4950.6 4892.5 4896.8 4914.6 4930.8 4948.7 4760.7 4846.9 4890.1 4901.0 4929.9 5248.3 5334.1 5339.9 5340.2 5374.8 5876.8 5881.6 5887.1 5887.6 5906.1 5673.4 5820.0 5842.2 5914.9 5926.6 5475.5 5477.4 5480.2 5480.4 5503.0 5919.3 5930.6 5931.9 5934.5 5936.1 5594.3 5653.9 5663.3 5710.3 5720.7 5773.5 5783.9 5813.5 5892.5 5904.8 5844.6 5852.9 5875.4 5887.9 5899.1 5699.4 5808.2 5866.5 5893.0 5896.1 4385.3 4402.6 4442.4 4450.4 4480.4 3967.2 3989.3 3999.8 4041.5 4044.8 5321.2 5463.6 5468.2 5472.6 5475.3 5750.1 5810.1 5837.0 5882.9 5898.1 5401.3 5549.6 5570.3 5576.2 5578.0 5042.4 5082.2 5110.5 5110.8 5156.9 5810.0 5836.3 5960.0 5963.6 6004.8 5829.7 5879.5 5893.1 5907.9 5910.4 5991.6 5992.9 6002.0 6002.0 6003.9 5582.1 5593.1 5649.8 5723.8 5807.4 5845.2 5849.7 5854.7 5856.7 5857.3 5663.5 5664.7 5708.1 5726.8 5730.7 5480.9 5542.2 5634.5 5681.8 5684.4 5538.0 5546.6 5559.5 5593.3 5594.7 5677.5 5686.7 5689.9 5697.5 5740.4 5462.9 5463.3 5518.8 5571.4 5571.9 20:18:04 INFO - 2015-12-18 20:18:04,641 DEBUG : BROWSER_OUTPUT: 20:18:04 INFO - 2015-12-18 20:18:04,641 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42622.70 Median:166297.20 stddev:66452.64 (40.0%) stddev-sans-first:66563.95 20:18:04 INFO - 2015-12-18 20:18:04,641 DEBUG : BROWSER_OUTPUT: Values: 546.6 591.3 594.2 597.5 600.9 29865.9 37542.0 38605.2 38719.2 38724.0 41977.6 42368.8 42436.0 42443.8 42471.4 7479.9 7587.5 8611.0 8843.0 8847.6 10395.5 10589.3 10598.7 10603.4 10612.5 10164.6 10245.7 10253.8 10256.6 10268.0 7700.3 7878.5 10269.9 10357.3 10429.6 10068.9 10119.5 10167.3 10170.4 10239.8 39014.8 39425.0 39433.0 39445.6 39494.6 3186.6 3279.3 3287.2 3345.6 3574.2 29405.3 29956.4 30013.5 30023.8 30371.4 3435.8 3446.7 3465.6 3513.6 3536.7 253805.0 253970.0 254220.0 255301.0 256681.0 58369.0 58859.0 58920.0 58955.4 58961.0 61349.7 61522.4 61602.0 62040.0 62074.7 13343.0 13433.7 13502.5 13520.5 13559.9 10297.1 10394.5 10404.8 10411.6 10416.8 18209.3 19595.1 19810.5 19824.9 19841.5 7682.8 7781.3 7862.3 7892.1 7910.9 957.6 999.4 1003.6 1012.2 1082.4 28201.0 28486.3 28513.2 28657.3 28770.7 947.0 1026.4 1060.5 1078.7 1108.1 14562.4 15360.1 15868.7 16008.7 16092.4 298093.0 299961.0 301763.0 302223.0 308361.0 43527.3 44250.6 49690.8 51944.0 51994.7 1322.4 1324.1 1329.4 1341.2 1349.0 25924.5 27340.7 27771.4 28483.0 28941.6 42814.0 43740.8 46584.1 47731.3 47853.5 196264.0 197038.0 197160.0 197295.0 197939.0 28583.3 28816.1 28893.3 28990.3 29006.9 38862.6 39985.4 40282.6 40543.6 40674.4 35934.5 36404.5 36654.3 36769.3 37871.4 36373.5 36847.6 37065.8 37081.0 37428.3 35967.5 36079.5 36871.0 36946.4 36953.8 28400.0 29895.2 31060.8 31605.0 31616.5 25430.9 25449.7 25454.9 25566.5 25743.4 20:18:04 INFO - 2015-12-18 20:18:04,641 DEBUG : BROWSER_OUTPUT: 20:18:04 INFO - 2015-12-18 20:18:04,641 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28301.68 Median:18291.78 stddev:88022.43 (481.2%) stddev-sans-first:88244.33 20:18:04 INFO - 2015-12-18 20:18:04,641 DEBUG : BROWSER_OUTPUT: Values: 351.9 359.9 361.3 361.6 364.6 13979.8 14107.4 16154.4 16284.0 16961.7 13910.8 14246.4 14708.8 15485.4 16125.6 5407.0 5526.2 5561.9 5571.1 5571.6 3735.3 3806.2 5164.0 5541.6 5576.8 5385.1 5542.3 5574.3 5580.3 5588.1 5319.1 5383.0 5422.9 5506.6 5533.5 5124.7 5159.8 5173.1 5173.6 5175.9 12913.5 12945.1 12957.5 12960.8 19584.9 1990.5 1996.7 2050.6 2092.2 2113.6 9069.3 11518.6 13133.7 13137.9 13637.1 1789.4 1810.9 1817.1 1853.5 1862.6 59484.7 61729.1 62672.0 62739.0 62800.0 10152.8 10190.8 10260.5 10302.5 10362.9 13640.7 13641.2 13690.8 13702.7 13722.2 7573.2 7620.5 7630.0 7630.8 7705.2 7390.8 7428.0 7456.7 7479.8 7485.5 4403.2 4465.7 4486.1 4487.9 4499.6 1699.3 1739.5 1761.7 1777.8 1812.9 422.3 434.8 477.0 934.4 1054.3 10183.2 10587.3 10610.9 10623.4 10689.9 410.6 440.6 453.2 455.7 467.3 5634.4 5772.7 5774.7 5799.0 5850.2 519455.0 531030.0 542911.0 543386.0 555146.0 69629.7 70442.0 73030.6 80282.6 81782.0 1175.1 1177.7 1191.7 1199.1 1231.7 14918.0 15032.8 15415.2 15428.8 15491.4 35252.6 35283.6 36222.0 37006.8 37311.6 46957.5 47521.6 47924.3 49005.0 51592.5 9610.3 9719.3 9819.0 9850.1 9855.9 15002.4 17344.1 17605.7 17669.5 17751.6 11174.4 13209.9 13665.2 14080.9 14482.5 13457.5 13690.7 13771.9 14211.1 14404.7 13891.6 13984.4 14085.3 14093.8 14712.1 9415.0 9578.8 9579.1 9603.5 9615.7 13816.9 14363.8 14517.5 14623.4 14805.3 20:18:04 INFO - 2015-12-18 20:18:04,642 DEBUG : BROWSER_OUTPUT: 20:18:04 INFO - 2015-12-18 20:18:04,642 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5093.29 Median:5963.20 stddev:2575.95 (43.2%) stddev-sans-first:2567.28 20:18:04 INFO - 2015-12-18 20:18:04,643 DEBUG : BROWSER_OUTPUT: Values: 1286.2 1292.2 1352.6 1559.2 1610.5 6580.6 7102.2 7411.3 7418.7 7424.6 7194.7 7318.1 7336.9 7349.8 7366.3 1981.4 2022.3 2168.0 2196.5 2203.2 2219.7 2220.1 2223.7 2224.8 2226.7 2177.7 2242.4 2246.5 2246.6 2247.6 2237.5 2240.0 2261.1 2271.5 2278.1 2231.0 2247.2 2260.8 2262.2 2299.1 7250.8 7256.6 7265.0 7314.3 7330.6 4367.0 4417.0 4422.8 4437.9 4441.8 2971.7 3022.5 3046.3 3050.4 3088.9 996.4 1013.2 1036.1 1069.0 1088.3 9758.3 9767.3 9777.3 9786.8 9816.0 4005.0 4060.9 4080.3 4080.8 4151.0 8365.8 8380.3 8389.8 8398.9 8410.5 4435.4 4441.8 4466.7 4468.1 4476.8 4097.5 4120.9 4128.6 4131.5 4133.5 3075.8 3105.0 3448.9 3549.3 3568.4 1133.8 1189.9 1190.1 1196.6 1201.2 1009.1 1066.8 1072.6 1159.6 1248.6 6958.9 6960.3 7077.8 7077.8 7078.2 1055.0 1060.4 1062.8 1083.2 1117.5 5378.5 5522.0 5528.4 5536.3 5538.3 8450.0 8616.9 8726.2 8782.3 8859.9 8662.6 8742.5 8766.4 8778.5 8807.3 6425.6 6588.5 6631.5 6663.3 6669.5 6757.2 6775.1 6792.8 6793.1 6793.6 7758.9 7951.5 7960.6 7973.3 7981.0 7865.5 8058.6 8062.8 8075.6 8171.9 6203.8 6432.2 6484.0 6486.9 6490.6 6138.6 6324.1 6335.4 6434.1 6793.4 6206.5 6291.1 6330.3 6372.5 6381.7 6258.1 6317.4 6326.8 6329.3 6353.1 6321.8 6340.8 6352.6 6361.6 6362.0 5904.4 5919.7 5927.0 5927.6 5932.1 5899.2 5944.5 5981.9 5993.0 6084.9 20:18:04 INFO - 2015-12-18 20:18:04,643 DEBUG : BROWSER_OUTPUT: 20:18:04 INFO - 2015-12-18 20:18:04,643 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5369.73 Median:6127.60 stddev:1620.60 (26.4%) stddev-sans-first:1580.43 20:18:04 INFO - 2015-12-18 20:18:04,643 DEBUG : BROWSER_OUTPUT: Values: 332.7 338.1 339.8 344.3 347.8 6002.2 6086.4 6116.0 6125.4 6129.8 5703.6 5734.5 5804.2 5982.9 5992.0 4527.8 4556.0 4587.4 4593.7 4599.1 4572.2 4575.6 4582.3 4585.8 4588.8 4386.8 4472.4 4511.9 4597.9 4621.7 4588.3 4597.7 4602.1 4615.9 4627.0 4077.2 4080.5 4084.0 4087.1 4087.9 5681.7 5709.8 5717.6 5719.1 5743.1 5168.7 5271.0 5338.8 5340.5 5345.5 6357.9 6359.7 6359.7 6360.7 6377.3 4432.6 4433.6 4438.4 4439.0 4439.9 6490.8 6575.7 6629.3 6631.9 6657.5 4579.8 4585.1 4586.8 4587.8 4592.2 4642.4 4643.1 4647.0 4649.8 4650.8 5350.7 5356.6 5357.9 5360.0 5360.8 6229.9 6361.2 6420.5 6424.0 6432.2 1616.1 1625.8 1633.4 1641.5 1644.4 1083.2 1086.9 1088.0 1092.8 1114.6 6158.6 6162.3 6166.9 6168.4 6168.9 6648.8 6650.6 6654.2 6658.4 6658.9 5976.2 6064.4 6135.2 6228.1 6237.1 3586.9 3606.9 3608.4 3610.2 3610.8 6816.6 6828.5 6833.0 6837.0 6839.5 6725.9 6851.7 6879.1 6881.8 6882.9 6817.1 6821.1 6827.2 6828.2 6828.7 6696.1 6697.1 6703.4 6705.6 6710.7 6417.1 6579.0 6579.6 6583.3 6583.4 6763.5 6771.7 6825.7 6831.0 6839.2 4527.0 4560.6 4567.6 4569.5 4578.8 6492.4 6631.3 6632.7 6682.3 6697.4 6502.8 6504.7 6506.2 6511.2 6517.9 6436.7 6472.4 6473.7 6493.4 6511.9 6211.4 6405.2 6410.1 6413.0 6417.5 6547.1 6551.3 6551.7 6554.5 6556.9 6248.4 6395.4 6406.1 6406.7 6409.6 20:18:04 INFO - 2015-12-18 20:18:04,643 DEBUG : BROWSER_OUTPUT: 20:18:04 INFO - 2015-12-18 20:18:04,643 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13281.01 Median:45042.89 stddev:15163.13 (33.7%) stddev-sans-first:15176.33 20:18:04 INFO - 2015-12-18 20:18:04,643 DEBUG : BROWSER_OUTPUT: Values: 720.9 722.5 760.7 782.0 789.1 12630.2 12919.2 12921.4 12942.7 12955.2 11969.0 13169.3 13190.2 13202.6 13211.9 682.9 692.2 814.6 827.8 844.1 813.9 815.0 815.3 822.4 822.6 712.2 858.6 861.8 863.9 865.6 716.3 857.7 870.2 871.1 873.2 638.0 638.5 639.1 639.6 640.0 12729.5 12799.8 12852.2 12867.2 12894.3 11288.2 11703.1 12279.9 12456.3 12602.6 9783.5 9857.5 9911.8 9977.4 10310.2 3458.4 3496.9 3499.9 3549.9 3557.9 44306.1 44733.6 44971.0 45034.0 45726.0 9398.1 9413.0 9446.6 9565.2 9736.3 16898.7 17033.6 17036.6 17041.6 17066.6 7128.9 7211.5 7318.8 7409.5 7509.9 4216.9 4237.2 4260.0 4261.6 4267.7 3070.9 3086.9 3099.3 3102.1 3102.5 577.8 578.1 593.1 625.7 662.2 592.0 647.1 658.8 672.8 732.1 7844.5 7952.9 8033.8 8084.6 8276.3 579.7 644.5 721.9 733.0 746.1 3540.4 3646.7 3657.5 3780.4 3879.3 52002.7 52228.0 53278.5 57486.0 57495.4 47408.8 49248.8 49783.0 50044.7 50073.7 43246.8 43873.8 44216.6 44903.3 45051.8 7812.8 7925.6 7976.4 8233.3 8391.1 33416.3 34193.3 34718.7 35187.6 35287.8 41638.6 41900.4 42050.2 42871.6 43047.1 10424.5 10502.7 11190.7 11312.4 11354.4 11964.0 11981.7 12045.4 12695.5 12841.4 10631.8 11014.7 11212.3 11557.9 11582.7 11043.8 11183.2 11300.0 11675.5 11823.5 11211.9 11456.3 11488.5 11550.5 11635.1 9706.4 9816.9 9933.0 10008.1 10039.7 8875.0 8985.4 9261.7 9273.7 9597.6 20:18:04 INFO - 2015-12-18 20:18:04,643 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:18:04 INFO - 2015-12-18 20:18:04,644 DEBUG : BROWSER_OUTPUT: 20:18:05 INFO - 2015-12-18 20:18:05,314 INFO : Browser exited with error code: 0 20:18:05 INFO - 2015-12-18 20:18:05,335 INFO : Completed test dromaeo_css (00:18:33) 20:18:05 INFO - 2015-12-18 20:18:05,335 INFO : Starting test kraken 20:18:05 INFO - 2015-12-18 20:18:05,335 DEBUG : operating with platform_type : linux_ 20:18:05 INFO - 2015-12-18 20:18:05,335 INFO : Initialising browser for kraken test... 20:18:05 INFO - 2015-12-18 20:18:05,341 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ79AF3/profile http://localhost:45647/getInfo.html 20:18:09 INFO - 2015-12-18 20:18:09,605 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:18:09 INFO - 2015-12-18 20:18:09,606 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:18:09 INFO - 2015-12-18 20:18:09,606 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:18:09 INFO - 2015-12-18 20:18:09,606 DEBUG : BROWSER_OUTPUT: __metrics 20:18:09 INFO - 2015-12-18 20:18:09,708 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] 20:18:09 INFO - 2015-12-18 20:18:09,764 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:18:10 INFO - 2015-12-18 20:18:10,560 INFO : Browser initialized. 20:18:10 INFO - 2015-12-18 20:18:10,560 INFO : Running cycle 1/1 for kraken test... 20:18:10 INFO - 2015-12-18 20:18:10,561 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ79AF3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:18:22 INFO - 2015-12-18 20:18:22,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 150155264 20:18:22 INFO - 2015-12-18 20:18:22,346 DEBUG : BROWSER_OUTPUT: 20:18:24 INFO - 2015-12-18 20:18:24,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45647/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:25 INFO - 2015-12-18 20:18:25,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 185806848 20:18:25 INFO - 2015-12-18 20:18:25,374 DEBUG : BROWSER_OUTPUT: 20:18:27 INFO - 2015-12-18 20:18:27,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45647/tests/kraken/driver.html?testName=audio-dft) 20:18:28 INFO - 2015-12-18 20:18:28,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 176111616 20:18:28 INFO - 2015-12-18 20:18:28,569 DEBUG : BROWSER_OUTPUT: 20:18:31 INFO - 2015-12-18 20:18:31,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45647/tests/kraken/driver.html?testName=audio-fft) 20:18:32 INFO - 2015-12-18 20:18:32,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 160714752 20:18:32 INFO - 2015-12-18 20:18:32,010 DEBUG : BROWSER_OUTPUT: 20:18:33 INFO - 2015-12-18 20:18:33,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45647/tests/kraken/driver.html?testName=audio-oscillator) 20:18:34 INFO - 2015-12-18 20:18:34,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 164032512 20:18:34 INFO - 2015-12-18 20:18:34,562 DEBUG : BROWSER_OUTPUT: 20:18:36 INFO - 2015-12-18 20:18:36,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45647/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:37 INFO - 2015-12-18 20:18:37,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 164347904 20:18:37 INFO - 2015-12-18 20:18:37,318 DEBUG : BROWSER_OUTPUT: 20:18:40 INFO - 2015-12-18 20:18:40,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45647/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:40 INFO - 2015-12-18 20:18:40,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 164380672 20:18:40 INFO - 2015-12-18 20:18:40,752 DEBUG : BROWSER_OUTPUT: 20:18:44 INFO - 2015-12-18 20:18:44,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45647/tests/kraken/driver.html?testName=imaging-desaturate) 20:18:44 INFO - 2015-12-18 20:18:44,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 165416960 20:18:44 INFO - 2015-12-18 20:18:44,653 DEBUG : BROWSER_OUTPUT: 20:18:47 INFO - 2015-12-18 20:18:47,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45647/tests/kraken/driver.html?testName=json-parse-financial) 20:18:47 INFO - 2015-12-18 20:18:47,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 164683776 20:18:47 INFO - 2015-12-18 20:18:47,966 DEBUG : BROWSER_OUTPUT: 20:18:49 INFO - 2015-12-18 20:18:49,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45647/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:18:50 INFO - 2015-12-18 20:18:50,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 177610752 20:18:50 INFO - 2015-12-18 20:18:50,070 DEBUG : BROWSER_OUTPUT: 20:18:51 INFO - 2015-12-18 20:18:51,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:18:52 INFO - 2015-12-18 20:18:52,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 175673344 20:18:52 INFO - 2015-12-18 20:18:52,465 DEBUG : BROWSER_OUTPUT: 20:18:54 INFO - 2015-12-18 20:18:54,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:18:55 INFO - 2015-12-18 20:18:55,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 182837248 20:18:55 INFO - 2015-12-18 20:18:55,119 DEBUG : BROWSER_OUTPUT: 20:18:57 INFO - 2015-12-18 20:18:57,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:18:58 INFO - 2015-12-18 20:18:58,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 192253952 20:18:58 INFO - 2015-12-18 20:18:58,127 DEBUG : BROWSER_OUTPUT: 20:19:00 INFO - 2015-12-18 20:19:00,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:01 INFO - 2015-12-18 20:19:01,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 190140416 20:19:01 INFO - 2015-12-18 20:19:01,268 DEBUG : BROWSER_OUTPUT: 20:19:02 INFO - 2015-12-18 20:19:02,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45647/tests/kraken/driver.html?testName=ai-astar) 20:19:03 INFO - 2015-12-18 20:19:03,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 248741888 20:19:03 INFO - 2015-12-18 20:19:03,166 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,167 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:19:03 INFO - 2015-12-18 20:19:03,167 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:19:03 INFO - 2015-12-18 20:19:03,167 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:19:03 INFO - 2015-12-18 20:19:03,167 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:19:03 INFO - 2015-12-18 20:19:03,168 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;103;109;110;112;99;110;110;113 20:19:03 INFO - 2015-12-18 20:19:03,168 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;133;150;165;124;149;149;133;167;126 20:19:03 INFO - 2015-12-18 20:19:03,168 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;162;161;162;160;161;159;162;159 20:19:03 INFO - 2015-12-18 20:19:03,168 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;84;88;72;73;79;106;90;74 20:19:03 INFO - 2015-12-18 20:19:03,168 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;136;93;94;94;149;94;94;135 20:19:03 INFO - 2015-12-18 20:19:03,168 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;110;109;110;110;111;110 20:19:03 INFO - 2015-12-18 20:19:03,168 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;146;146;145;145;145;145 20:19:03 INFO - 2015-12-18 20:19:03,168 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;95;96;96;95;95 20:19:03 INFO - 2015-12-18 20:19:03,169 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;57;58;58;58;57;66;55;56 20:19:03 INFO - 2015-12-18 20:19:03,169 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;68;66;68;67;68;67;67;67;67 20:19:03 INFO - 2015-12-18 20:19:03,169 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;86;85;84;85;85;84;86;86;89 20:19:03 INFO - 2015-12-18 20:19:03,169 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;123;118;123;123;114;135;122;124;115 20:19:03 INFO - 2015-12-18 20:19:03,169 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;140;149;144;162;144;153;155;151;141 20:19:03 INFO - 2015-12-18 20:19:03,169 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;66;68;67;67;67;65;66;68;68 20:19:03 INFO - 2015-12-18 20:19:03,169 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:19:03 INFO - 2015-12-18 20:19:03,169 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:19:03 INFO - 2015-12-18 20:19:03,169 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,906 20:19:03 INFO - 2015-12-18 20:19:03,169 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:19:03 INFO - 2015-12-18 20:19:03,170 DEBUG : BROWSER_OUTPUT: __startTimestamp1450498743166__endTimestamp 20:19:03 INFO - 2015-12-18 20:19:03,170 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,173 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:19:03 INFO - 2015-12-18 20:19:03,173 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:19:03 INFO - 2015-12-18 20:19:03,173 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,173 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:4.25 (3.9%) stddev-sans-first:4.50 20:19:03 INFO - 2015-12-18 20:19:03,173 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 103.0 109.0 110.0 112.0 99.0 110.0 110.0 113.0 20:19:03 INFO - 2015-12-18 20:19:03,173 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,173 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.80 Median:149.50 stddev:15.20 (10.2%) stddev-sans-first:15.90 20:19:03 INFO - 2015-12-18 20:19:03,173 DEBUG : BROWSER_OUTPUT: Values: 152.0 133.0 150.0 165.0 124.0 149.0 149.0 133.0 167.0 126.0 20:19:03 INFO - 2015-12-18 20:19:03,173 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,174 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 20:19:03 INFO - 2015-12-18 20:19:03,174 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 162.0 161.0 162.0 160.0 161.0 159.0 162.0 159.0 20:19:03 INFO - 2015-12-18 20:19:03,174 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,174 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:76.50 stddev:11.09 (14.5%) stddev-sans-first:11.37 20:19:03 INFO - 2015-12-18 20:19:03,174 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 84.0 88.0 72.0 73.0 79.0 106.0 90.0 74.0 20:19:03 INFO - 2015-12-18 20:19:03,174 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,174 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.70 Median:94.00 stddev:22.59 (24.0%) stddev-sans-first:23.41 20:19:03 INFO - 2015-12-18 20:19:03,174 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 136.0 93.0 94.0 94.0 149.0 94.0 94.0 135.0 20:19:03 INFO - 2015-12-18 20:19:03,175 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,175 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 20:19:03 INFO - 2015-12-18 20:19:03,175 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 111.0 110.0 20:19:03 INFO - 2015-12-18 20:19:03,175 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,175 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 20:19:03 INFO - 2015-12-18 20:19:03,175 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 20:19:03 INFO - 2015-12-18 20:19:03,175 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,175 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:19:03 INFO - 2015-12-18 20:19:03,175 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 20:19:03 INFO - 2015-12-18 20:19:03,175 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,175 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.00 stddev:2.98 (5.1%) stddev-sans-first:3.15 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 57.0 58.0 58.0 58.0 57.0 66.0 55.0 56.0 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 66.0 68.0 67.0 68.0 67.0 67.0 67.0 67.0 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:2.49 (2.9%) stddev-sans-first:1.51 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: Values: 92.0 86.0 85.0 84.0 85.0 85.0 84.0 86.0 86.0 89.0 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:123.00 stddev:6.24 (5.1%) stddev-sans-first:6.17 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: Values: 129.0 123.0 118.0 123.0 123.0 114.0 135.0 122.0 124.0 115.0 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.20 Median:150.00 stddev:7.07 (4.7%) stddev-sans-first:7.24 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: Values: 143.0 140.0 149.0 144.0 162.0 144.0 153.0 155.0 151.0 141.0 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.05 (1.6%) stddev-sans-first:1.05 20:19:03 INFO - 2015-12-18 20:19:03,176 DEBUG : BROWSER_OUTPUT: Values: 68.0 66.0 68.0 67.0 67.0 67.0 65.0 66.0 68.0 68.0 20:19:03 INFO - 2015-12-18 20:19:03,177 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:19:03 INFO - 2015-12-18 20:19:03,177 DEBUG : BROWSER_OUTPUT: 20:19:04 INFO - 2015-12-18 20:19:04,013 INFO : Browser exited with error code: 0 20:19:04 INFO - 2015-12-18 20:19:04,062 INFO : Completed test kraken (00:00:58) 20:19:04 INFO - 2015-12-18 20:19:04,062 INFO : Starting test v8_7 20:19:04 INFO - 2015-12-18 20:19:04,062 DEBUG : operating with platform_type : linux_ 20:19:04 INFO - 2015-12-18 20:19:04,062 INFO : Initialising browser for v8_7 test... 20:19:04 INFO - 2015-12-18 20:19:04,068 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp40cmxA/profile http://localhost:45647/getInfo.html 20:19:08 INFO - 2015-12-18 20:19:08,333 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:19:08 INFO - 2015-12-18 20:19:08,333 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:19:08 INFO - 2015-12-18 20:19:08,333 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:19:08 INFO - 2015-12-18 20:19:08,333 DEBUG : BROWSER_OUTPUT: __metrics 20:19:08 INFO - 2015-12-18 20:19:08,442 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] 20:19:08 INFO - 2015-12-18 20:19:08,498 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:19:09 INFO - 2015-12-18 20:19:09,337 INFO : Browser initialized. 20:19:09 INFO - 2015-12-18 20:19:09,338 INFO : Running cycle 1/1 for v8_7 test... 20:19:09 INFO - 2015-12-18 20:19:09,338 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp40cmxA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:19:21 INFO - 2015-12-18 20:19:21,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 149667840 20:19:21 INFO - 2015-12-18 20:19:21,104 DEBUG : BROWSER_OUTPUT: 20:19:42 INFO - 2015-12-18 20:19:42,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45647/tests/v8_7/run.html (next: http://localhost:45647/tests/v8_7/run.html) 20:19:42 INFO - 2015-12-18 20:19:42,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 616247296 20:19:42 INFO - 2015-12-18 20:19:42,802 DEBUG : BROWSER_OUTPUT: 20:19:42 INFO - 2015-12-18 20:19:42,803 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:19:42 INFO - 2015-12-18 20:19:42,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:19:42 INFO - 2015-12-18 20:19:42,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:19:42 INFO - 2015-12-18 20:19:42,803 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:19:42 INFO - 2015-12-18 20:19:42,804 DEBUG : BROWSER_OUTPUT: |0;Richards;168.09547823163558 20:19:42 INFO - 2015-12-18 20:19:42,804 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.9287738522577 20:19:42 INFO - 2015-12-18 20:19:42,804 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.42624789680315 20:19:42 INFO - 2015-12-18 20:19:42,804 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 20:19:42 INFO - 2015-12-18 20:19:42,804 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1102.5358324145534 20:19:42 INFO - 2015-12-18 20:19:42,804 DEBUG : BROWSER_OUTPUT: |5;Earley;796.1783439490446 20:19:42 INFO - 2015-12-18 20:19:42,805 DEBUG : BROWSER_OUTPUT: |6;Boyer;11779.06976744186 20:19:42 INFO - 2015-12-18 20:19:42,805 DEBUG : BROWSER_OUTPUT: |7;RegExp;25923.076923076922 20:19:42 INFO - 2015-12-18 20:19:42,805 DEBUG : BROWSER_OUTPUT: |8;Splay;678.1376518218624 20:19:42 INFO - 2015-12-18 20:19:42,805 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 20:19:42 INFO - 2015-12-18 20:19:42,805 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:19:42 INFO - 2015-12-18 20:19:42,805 DEBUG : BROWSER_OUTPUT: __startTimestamp1450498782801__endTimestamp 20:19:42 INFO - 2015-12-18 20:19:42,805 DEBUG : BROWSER_OUTPUT: 20:19:42 INFO - 2015-12-18 20:19:42,806 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:19:42 INFO - 2015-12-18 20:19:42,806 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:19:42 INFO - 2015-12-18 20:19:42,806 DEBUG : BROWSER_OUTPUT: 20:19:42 INFO - 2015-12-18 20:19:42,806 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.10 Median:168.10 stddev:0.00 (0.0%) 20:19:42 INFO - 2015-12-18 20:19:42,806 DEBUG : BROWSER_OUTPUT: Values: 168.1 20:19:42 INFO - 2015-12-18 20:19:42,806 DEBUG : BROWSER_OUTPUT: 20:19:42 INFO - 2015-12-18 20:19:42,806 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.93 Median:188.93 stddev:0.00 (0.0%) 20:19:42 INFO - 2015-12-18 20:19:42,806 DEBUG : BROWSER_OUTPUT: Values: 188.9 20:19:42 INFO - 2015-12-18 20:19:42,806 DEBUG : BROWSER_OUTPUT: 20:19:42 INFO - 2015-12-18 20:19:42,806 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 20:19:42 INFO - 2015-12-18 20:19:42,806 DEBUG : BROWSER_OUTPUT: Values: 280.4 20:19:42 INFO - 2015-12-18 20:19:42,807 DEBUG : BROWSER_OUTPUT: 20:19:42 INFO - 2015-12-18 20:19:42,807 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 20:19:42 INFO - 2015-12-18 20:19:42,807 DEBUG : BROWSER_OUTPUT: Values: 5148.7 20:19:42 INFO - 2015-12-18 20:19:42,807 DEBUG : BROWSER_OUTPUT: 20:19:42 INFO - 2015-12-18 20:19:42,807 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1102.54 Median:1102.54 stddev:0.00 (0.0%) 20:19:42 INFO - 2015-12-18 20:19:42,807 DEBUG : BROWSER_OUTPUT: Values: 1102.5 20:19:42 INFO - 2015-12-18 20:19:42,807 DEBUG : BROWSER_OUTPUT: 20:19:42 INFO - 2015-12-18 20:19:42,807 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 20:19:42 INFO - 2015-12-18 20:19:42,807 DEBUG : BROWSER_OUTPUT: Values: 796.2 20:19:42 INFO - 2015-12-18 20:19:42,807 DEBUG : BROWSER_OUTPUT: 20:19:42 INFO - 2015-12-18 20:19:42,807 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11779.07 Median:11779.07 stddev:0.00 (0.0%) 20:19:42 INFO - 2015-12-18 20:19:42,808 DEBUG : BROWSER_OUTPUT: Values: 11779.1 20:19:42 INFO - 2015-12-18 20:19:42,808 DEBUG : BROWSER_OUTPUT: 20:19:42 INFO - 2015-12-18 20:19:42,808 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25923.08 Median:25923.08 stddev:0.00 (0.0%) 20:19:42 INFO - 2015-12-18 20:19:42,808 DEBUG : BROWSER_OUTPUT: Values: 25923.1 20:19:42 INFO - 2015-12-18 20:19:42,808 DEBUG : BROWSER_OUTPUT: 20:19:42 INFO - 2015-12-18 20:19:42,808 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:678.14 Median:678.14 stddev:0.00 (0.0%) 20:19:42 INFO - 2015-12-18 20:19:42,808 DEBUG : BROWSER_OUTPUT: Values: 678.1 20:19:42 INFO - 2015-12-18 20:19:42,808 DEBUG : BROWSER_OUTPUT: 20:19:42 INFO - 2015-12-18 20:19:42,808 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 20:19:42 INFO - 2015-12-18 20:19:42,809 DEBUG : BROWSER_OUTPUT: Values: 4845.4 20:19:42 INFO - 2015-12-18 20:19:42,809 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:19:42 INFO - 2015-12-18 20:19:42,809 DEBUG : BROWSER_OUTPUT: 20:19:43 INFO - 2015-12-18 20:19:43,614 INFO : Browser exited with error code: 0 20:19:43 INFO - 2015-12-18 20:19:43,632 INFO : Completed test v8_7 (00:00:39) 20:19:43 INFO - 2015-12-18 20:19:43,767 INFO : Completed test suite (00:20:11) 20:19:43 INFO - 2015-12-18 20:19:43,768 DEBUG : Working with test: dromaeo_css 20:19:43 INFO - 2015-12-18 20:19:43,768 DEBUG : Generating results file: dromaeo_css 20:19:43 INFO - 2015-12-18 20:19:43,769 DEBUG : Working with test: kraken 20:19:43 INFO - 2015-12-18 20:19:43,769 DEBUG : Generating results file: kraken 20:19:43 INFO - 2015-12-18 20:19:43,769 INFO : javascript benchmark 20:19:43 INFO - 2015-12-18 20:19:43,769 DEBUG : Working with test: v8_7 20:19:43 INFO - 2015-12-18 20:19:43,770 DEBUG : Generating results file: v8_7 20:19:43 INFO - 2015-12-18 20:19:43,770 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:43 INFO - 2015-12-18 20:19:43,824 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:19:43 INFO - 2015-12-18 20:19:43,824 DEBUG : process_Request line: dromaeo_css 6836.86 graph.html#tests=[[72,64,35]] 20:19:43 INFO - 2015-12-18 20:19:43,824 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:43 INFO - 2015-12-18 20:19:43,863 DEBUG : process_Request line: kraken 1503.20 graph.html#tests=[[232,64,35]] 20:19:43 INFO - 2015-12-18 20:19:43,863 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:43 INFO - 2015-12-18 20:19:43,894 DEBUG : process_Request line: v8_7 20836.97 graph.html#tests=[[230,64,35]] 20:19:43 INFO - 2015-12-18 20:19:43,895 INFO : javascript benchmark 20:19:43 INFO - 2015-12-18 20:19:43,898 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3121.672224416436, 3182.2680783419796, 3223.5325877747728, 3227.1932016995765, 3242.756793240506, 5200.739963001844, 5326.387465441476, 5400.864978375537, 5451.427600101987, 5457.454254574545, 5339.172428273614, 5346.732663366826, 5446.591505637083, 5486.91769623456, 5492.725363731817, 4871.585915197204, 4939.135651261015, 4957.25641153828, 4974.602031837444, 5027.321311622939, 4870.586000189988, 5037.899242015157, 5061.974690126544, 5080.288759573663, 5130.640855140142, 4839.709617422948, 4904.950950490521, 4926.75366231687, 4935.506449355072, 4950.579200767939, 4892.511492560405, 4896.755162241873, 4914.606831453475, 4930.80276788928, 4948.703077815343, 4760.690555113941, 4846.854594362139, 4890.058409584779, 4900.975495122537, 4929.876753081166, 5248.265242866002, 5334.146536554172, 5339.866503337447, 5340.172273297606, 5374.758135883894, 5876.823695289106, 5881.558883083786, 5887.146363777271, 5887.5584331174905, 5906.143609176688, 5673.404292549264, 5819.970900145515, 5842.2405087338375, 5914.940850591482, 5926.585139040269, 5475.534579560703, 5477.4248703886315, 5480.232767412565, 5480.369757477862, 5503.0, 5919.3192782829665, 5930.55520835939, 5931.911021334683, 5934.465898069195, 5936.1392598073035, 5594.272744543265, 5653.943460565424, 5663.320401551758, 5710.314762228559, 5720.656760594377, 5773.451522105393, 5783.88432231353, 5813.5349172066135, 5892.499137573269, 5904.7933322334375, 5844.59087863854, 5852.912206316909, 5875.441833025856, 5887.911681324784, 5899.144624029492, 5699.373068962411, 5808.215890854765, 5866.472017518444, 5893.0, 5896.115582662549, 4385.320275357325, 4402.581754733295, 4442.378067070613, 4450.354698568754, 4480.439945006874, 3967.2263908538134, 3989.3018721723583, 3999.7800120993043, 4041.4948131483566, 4044.757314561136, 5321.175217841241, 5463.617546771768, 5468.234447177399, 5472.589555783332, 5475.342958844964, 5750.051241545182, 5810.070388737781, 5836.970815145897, 5882.941170588239, 5898.115282707542, 5401.270828438189, 5549.5837812164245, 5570.303712035996, 5576.247206627054, 5578.0, 5042.39491261051, 5082.161443361878, 5110.540051395392, 5110.795568177231, 5156.92264616031, 5809.970950145223, 5836.299644042657, 5960.04639257708, 5963.582549221513, 6004.819855404257, 5829.650220986754, 5879.529637629065, 5893.057110862242, 5907.911381329198, 5910.379410162043, 5991.580589358878, 5992.910106348321, 6001.969990150022, 6001.969990150196, 6003.87992240144, 5582.051051321204, 5593.105103183471, 5649.774009039593, 5723.771049157987, 5807.361190268983, 5845.18167456548, 5849.707514624337, 5854.677992710272, 5856.707164641836, 5857.297124345106, 5663.518600918803, 5664.688442135722, 5708.115242137475, 5726.79956201531, 5730.684812335361, 5480.931218412531, 5542.196381524737, 5634.492895639412, 5681.829545113488, 5684.431556844283, 5537.972310138423, 5546.58400619947, 5559.471850174227, 5593.272874526286, 5594.692291923983, 5677.489025987681, 5686.658800471985, 5689.943100568941, 5697.487226149667, 5740.368559458373, 5462.9180562292395, 5463.262459568066, 5518.834434966958, 5571.3592936811165, 5571.8885622288135], "unit": "score", "name": "dojo.html", "value": 5357.243199098197}, {"lowerIsBetter": false, "replicates": [546.6008560521345, 591.2609238451935, 594.2453084582583, 597.4712379544103, 600.8648054187805, 29865.850670746644, 37542.0, 38605.22789544214, 38719.225615487674, 38723.99999999996, 41977.58022419775, 42368.78815605918, 42436.0, 42443.78778106113, 42471.362929556, 7479.9252007480045, 7587.544747315151, 8610.999999999984, 8843.0, 8847.646094156225, 10395.480225988707, 10589.311694739856, 10598.682039538826, 10603.416812075333, 10612.522436490377, 10164.593416263378, 10245.743856403613, 10253.84619230712, 10256.641017564387, 10268.024537668909, 7700.345470635003, 7878.487898286593, 10269.948650256776, 10357.274990750613, 10429.582816687323, 10068.89931100687, 10119.544620492095, 10167.288289819715, 10170.44062576558, 10239.84640230397, 39014.804925975186, 39425.0, 39433.0, 39445.60554394477, 39494.60505394938, 3186.6494685584566, 3279.311344617633, 3287.1946373138494, 3345.631980482169, 3574.195805943668, 29405.264868378246, 29956.400871982656, 30013.549796753065, 30023.849880750677, 30371.392572148656, 3435.811030393327, 3446.6897979181745, 3465.6187819339852, 3513.5608048993877, 3536.6580568249606, 253805.0, 253970.0, 254220.0, 255301.0, 256681.0, 58369.0, 58859.0, 58920.0, 58955.410445894995, 58961.0, 61349.693251533456, 61522.384776151666, 61602.0, 62040.0, 62074.689626552485, 13343.0, 13433.731325373437, 13502.527411540548, 13520.459181632821, 13559.932200339132, 10297.12474439666, 10394.532246048795, 10404.814988852426, 10411.635592754217, 10416.791664166674, 18209.307726134037, 19595.11821968015, 19810.50473738168, 19824.90087549553, 19841.503962401057, 7682.846343073107, 7781.299683028555, 7862.2923936845955, 7892.1463300070045, 7910.920890791019, 957.5882370580717, 999.4303247149201, 1003.5835128421769, 1012.1649639047815, 1082.3884505254507, 28201.0, 28486.287842804097, 28513.193521635894, 28657.28356791097, 28770.712292876804, 946.976325591852, 1026.3892983674702, 1060.5015642647943, 1078.6710053433778, 1108.14672702019, 14562.41750329975, 15360.071345405857, 15868.682626347409, 16008.742517944562, 16092.356305747639, 298093.0, 299961.0, 301763.0, 302223.0, 308361.0, 43527.34708979368, 44250.55749442529, 49690.751546242034, 51944.0, 51994.74002629962, 1322.3784821134052, 1324.1062282958965, 1329.3818374455732, 1341.2086868747485, 1349.015218890196, 25924.48151036931, 27340.72659273382, 27771.44457110887, 28483.0, 28941.56587651229, 42814.0, 43740.781296093315, 46584.06831863276, 47731.28403074026, 47853.521464784906, 196264.01867990568, 197038.0, 197160.0, 197295.0, 197939.0, 28583.285417863888, 28816.135515934555, 28893.27766805847, 28990.27524311909, 29006.854965725037, 38862.6113738859, 39985.40021899732, 40282.597174027884, 40543.594564055165, 40674.38988415117, 35934.460983085795, 36404.453933190496, 36654.26691466102, 36769.26461470809, 37871.43192852054, 36373.45439818458, 36847.63152368549, 37065.81467092647, 37081.0, 37428.251434971695, 35967.460488092176, 36079.45880811843, 36871.0, 36946.44580331351, 36953.815230923676, 28400.0, 29895.206287622812, 31060.844695776377, 31605.0, 31616.525752114198, 25430.872845635655, 25449.745502544738, 25454.872725636254, 25566.48867022612, 25743.356416089748], "unit": "score", "name": "ext.html", "value": 18159.441099766318}, {"lowerIsBetter": false, "replicates": [351.88036067736965, 359.8686479435006, 361.32612677356707, 361.5679263280379, 364.56434560699955, 13979.833125865507, 14107.435702571885, 16154.353825846953, 16284.0, 16961.745573816403, 13910.791338129937, 14246.430142794276, 14708.779368309457, 15485.380584776623, 16125.596860078504, 5406.99999999999, 5526.226328314039, 5561.916571251434, 5571.13647384656, 5571.609987300891, 3735.2902948439846, 3806.200697853454, 5163.974180129113, 5541.5843811714085, 5576.776928922838, 5385.138377859544, 5542.251796007527, 5574.303212098488, 5580.330360356763, 5588.050031494636, 5319.0957537218765, 5382.9730851345885, 5422.942526207371, 5506.5870059745475, 5533.501984821365, 5124.718140502271, 5159.845204643867, 5173.068847607429, 5173.5602473789395, 5175.870603234912, 12913.483460661562, 12945.093843430963, 12957.546485873043, 12960.768726970922, 19584.902075489532, 1990.462575104728, 1996.6805311150292, 2050.5693804301113, 2092.200348866185, 2113.619548481273, 9069.319801014884, 11518.596849110325, 13133.737325253536, 13137.86862131376, 13637.113587616774, 1789.4005508154785, 1810.8551315894697, 1817.1277786662345, 1853.4902901702005, 1862.5622978600018, 59484.70257648684, 61729.07406388863, 62672.0, 62739.0, 62800.0, 10152.796944061078, 10190.847137292947, 10260.538275777608, 10302.536385862653, 10362.948185259025, 13640.727185456235, 13641.181529108286, 13690.794638080437, 13702.65743356424, 13722.176669399869, 7573.242675732493, 7620.504667196615, 7630.0, 7630.847383052419, 7705.229477052362, 7390.778276651709, 7428.0, 7456.664450099758, 7479.813004674817, 7485.47601667878, 4403.185410699031, 4465.687401881837, 4486.102779444124, 4487.932681009787, 4499.55004499554, 1699.345751885533, 1739.4694618141336, 1761.7093179625474, 1777.8044415114327, 1812.864035197339, 422.26525845029425, 434.8021650149175, 477.0387668847276, 934.3506263147048, 1054.2514814481651, 10183.236257280734, 10587.258891877495, 10610.893891061145, 10623.36259824413, 10689.9465502672, 410.60786948464147, 440.5503916552269, 453.19331589770263, 455.72656406156705, 467.306050514985, 5634.352049514358, 5772.6536407815665, 5774.740136693859, 5798.971005144947, 5850.180974663551, 519455.0, 531030.0, 542911.0, 543386.0, 555146.0, 69629.65185174042, 70442.0, 73030.63484682543, 80282.59858700786, 81782.0, 1175.1245322234818, 1177.6879127031343, 1191.7318603314186, 1199.1366216324232, 1231.655136561764, 14918.0, 15032.774508382601, 15415.152166630944, 15428.84571154274, 15491.380344786083, 35252.64747352596, 35283.647163529065, 36222.0, 37006.814965925, 37311.626883730816, 46957.53042469532, 47521.62391880462, 47924.28113578369, 49005.0, 51592.48407515877, 9610.327277090537, 9719.27105467107, 9818.950905245429, 9850.113489785954, 9855.852162217428, 15002.399904003718, 17344.13279336003, 17605.735913961045, 17669.469915902544, 17751.55621109431, 11174.385408802595, 13209.933950330187, 13665.248411337074, 14080.929595351958, 14482.493112741004, 13457.528986485817, 13690.726185476435, 13771.931140344233, 14211.147331160164, 14404.711905762035, 13891.583252502442, 13984.370703318578, 14085.295735213404, 14093.788593171315, 14712.117272963656, 9414.952925235604, 9578.760530986503, 9579.13787759105, 9603.471809050568, 9615.663451779154, 13816.861831381557, 14363.784543231652, 14517.491887783877, 14623.41506339777, 14805.259737013323], "unit": "score", "name": "jquery.html", "value": 8297.042051872691}, {"lowerIsBetter": false, "replicates": [1286.1575667937498, 1292.198836721233, 1352.6280272924944, 1559.1658462722446, 1610.5007447691216, 6580.572262802921, 7102.218755936849, 7411.295926886951, 7418.740344087958, 7424.628768561577, 7194.712211511546, 7318.121825380962, 7336.889946650791, 7349.77950661481, 7366.300201480864, 1981.3758666020158, 2022.302305704537, 2167.9783202167932, 2196.5057861981086, 2203.22886989554, 2219.655953327237, 2220.0897631970897, 2223.655333423322, 2224.810891074261, 2226.7105276314137, 2177.6515757478805, 2242.394553470562, 2246.539459410825, 2246.6068438023362, 2247.606668832956, 2237.5077482953807, 2239.9552008959813, 2261.1294651559106, 2271.4775601611723, 2278.1229226747737, 2230.988845055764, 2247.1910112359537, 2260.762619924917, 2262.1856131792542, 2299.091858715798, 7250.782476525713, 7256.637168141625, 7265.0, 7314.34170924614, 7330.560166390033, 4366.978165109186, 4417.028253784162, 4422.800973956148, 4437.9112417751785, 4441.822327106912, 2971.747401470856, 3022.4710675631677, 3046.2536678513907, 3050.435669401168, 3088.922776930572, 996.4220751963844, 1013.1692012549712, 1036.0882423467376, 1069.0485467933545, 1088.3361149698678, 9758.268129890286, 9767.316287859852, 9777.31558790885, 9786.755331116708, 9816.0, 4004.959950400517, 4060.939085913714, 4080.265552200573, 4080.7755573443746, 4151.0, 8365.8326833463, 8380.287675547524, 8389.790255243668, 8398.874016889751, 8410.537420441811, 4435.35687325336, 4441.800118994653, 4466.709663871903, 4468.061707041557, 4476.843310484118, 4097.528784189797, 4120.938185927213, 4128.6284234419045, 4131.5248746393945, 4133.545310015896, 3075.7539396848197, 3105.0219180957924, 3448.896533104011, 3549.254656522108, 3568.411212150018, 1133.7845809296207, 1189.9405029748477, 1190.1193117093462, 1196.5692350753723, 1201.2372143688647, 1009.1018993096151, 1066.8293073108266, 1072.5816931396762, 1159.640511441439, 1248.581725122076, 6958.860822783516, 6960.269171736996, 7077.752278670325, 7077.787666370017, 7078.1506219254015, 1054.9894501055044, 1060.4114716332356, 1062.7715041266165, 1083.160550573312, 1117.4803716271972, 5378.542823859937, 5522.0, 5528.419515950848, 5536.280283563192, 5538.335399752055, 8450.0, 8616.870746938675, 8726.171013753683, 8782.297416206688, 8859.867101993346, 8662.566871656392, 8742.475451472805, 8766.386352955233, 8778.473291602397, 8807.33944954131, 6425.646589437626, 6588.484648530864, 6631.535792494479, 6663.300353462817, 6669.533132680763, 6757.189137303555, 6775.085363475868, 6792.76225332111, 6793.082933804071, 6793.592384456949, 7758.88361674564, 7951.483153594998, 7960.562169080757, 7973.322267607318, 7980.960095199487, 7865.488743231672, 8058.597070146587, 8062.7581172564915, 8075.5558444286125, 8171.918280817354, 6203.751849925952, 6432.195975503062, 6483.967580162069, 6486.902696459462, 6490.578112422678, 6138.570300078952, 6324.114623952558, 6335.366463353628, 6434.0670602763275, 6793.354631310018, 6206.503479721701, 6291.087792270187, 6330.272018717907, 6372.490200784019, 6381.680915954276, 6258.12386265914, 6317.368263173646, 6326.841828954313, 6329.30377658448, 6353.110564521063, 6321.778737744157, 6340.778072767431, 6352.555321127476, 6361.554691171574, 6362.045693146065, 5904.409559044061, 5919.704014799329, 5926.970365148147, 5927.644341339534, 5932.110183472513, 5899.17411562373, 5944.524438045032, 5981.880362392641, 5993.0, 6084.878302433838], "unit": "score", "name": "mootools.html", "value": 4234.292060654698}, {"lowerIsBetter": false, "replicates": [332.74389180842326, 338.09728026170126, 339.794424373254, 344.2959148541233, 347.7808980342384, 6002.159697642328, 6086.421789929961, 6115.969420152893, 6125.418085281903, 6129.785457508993, 5703.600747947646, 5734.455226753462, 5804.158397032428, 5982.940170598293, 5992.0, 4527.773611319437, 4555.954440455586, 4587.403637527117, 4593.655475839309, 4599.149157405874, 4572.177008138534, 4575.588197062264, 4582.312653102028, 4585.793639286224, 4588.816447342119, 4386.780660966955, 4472.396226509412, 4511.932321015187, 4597.885052873671, 4621.722696638196, 4588.334691469735, 4597.7241365518175, 4602.125596136723, 4615.930761038587, 4626.953730462703, 4077.245709543744, 4080.510338759368, 4083.9591604083876, 4087.0804069084516, 4087.8773636790943, 5681.715914204273, 5709.77160913563, 5717.628354157008, 5719.14212868069, 5743.138529220609, 5168.689878607295, 5271.0, 5338.839834804962, 5340.465953404668, 5345.545628621572, 6357.936420635827, 6359.650219237987, 6359.713812878432, 6360.650164240965, 6377.3303803100935, 4432.556744325574, 4433.600975912151, 4438.378626992224, 4438.955610443919, 4439.933400998988, 6490.772822951221, 6575.704093315812, 6629.270780214172, 6631.86736265272, 6657.53397262187, 4579.771011449481, 4585.060062687141, 4586.8165273388695, 4587.770611469413, 4592.2193227151465, 4642.396488456479, 4643.094596553708, 4647.0, 4649.790759415834, 4650.767461626972, 5350.705711185844, 5356.571474282048, 5357.946420535823, 5360.0351936650995, 5360.8123715670545, 6229.906551401733, 6361.236651601745, 6420.454261387835, 6424.0042793366165, 6432.195975503062, 1616.062683643484, 1625.7805196298584, 1633.3874796951143, 1641.5321633334443, 1644.3915751172142, 1083.160550573312, 1086.913086913087, 1088.0, 1092.7705181911888, 1114.6210288501948, 6158.645098078416, 6162.291336496361, 6166.8724290119835, 6168.414000669929, 6168.8766224675255, 6648.833779155463, 6650.634215118215, 6654.201495820435, 6658.43403310724, 6658.9001164982565, 5976.163337132805, 6064.423879731418, 6135.171751813537, 6228.096925945803, 6237.09562113491, 3586.946195807065, 3606.891793246207, 3608.404613238839, 3610.205754733954, 3610.801405922647, 6816.591004539743, 6828.487863410165, 6832.965835170892, 6837.0, 6839.487038472134, 6725.899111513331, 6851.657417129124, 6879.071325371111, 6881.793546193622, 6882.931170688229, 6817.11377520929, 6821.079154314203, 6827.1807383113355, 6828.2147553031045, 6828.7268509259075, 6696.096027036482, 6697.129373181455, 6703.396694297537, 6705.597664140168, 6710.698018589273, 6417.069524918954, 6579.0, 6579.605223686594, 6583.275839657538, 6583.407493325623, 6763.458923286027, 6771.695273712793, 6825.692843822139, 6830.965845170941, 6839.213490448662, 4527.026689261825, 4560.5895469407915, 4567.588916997353, 4569.520200378913, 4578.771061446981, 6492.415682588401, 6631.270560238467, 6632.734690612321, 6682.264950855305, 6697.397234248941, 6502.772402965874, 6504.739810407531, 6506.219253689587, 6511.21865376139, 6517.869642607026, 6436.742530298923, 6472.35276472349, 6473.741050357933, 6493.383128602775, 6511.9348806511325, 6211.409916057967, 6405.19935008124, 6410.0705397718, 6413.0, 6417.48660107181, 6547.1161393211305, 6551.279359270381, 6551.737930482727, 6554.4756419485375, 6556.934430655632, 6248.4376406123665, 6395.360463953567, 6406.103145559532, 6406.679666016587, 6409.647469389229], "unit": "score", "name": "prototype.html", "value": 4843.600971073338}, {"lowerIsBetter": false, "replicates": [720.9351158395743, 722.5231347310776, 760.6691089376121, 781.9990412272293, 789.0728394136895, 12630.242185468878, 12919.160254583445, 12921.418536165871, 12942.676433089178, 12955.222686638808, 11969.0, 13169.341532923363, 13190.208587484758, 13202.603921882335, 13211.867881321185, 682.8634273145391, 692.1763101908713, 814.6293436486415, 827.7971896885272, 844.1263292492272, 813.9186081391873, 814.9837003259931, 815.2988429950238, 822.411975437562, 822.5845947796355, 712.1774350625011, 858.6264974735979, 861.7716305179133, 863.9049704532528, 865.6321063547967, 716.2837162837163, 857.6826574167567, 870.2168048756107, 871.0723079919928, 873.1922971251566, 638.0174531221912, 638.4892086330917, 639.1435476461564, 639.6130341143588, 640.0463309668606, 12729.490820367175, 12799.808002879965, 12852.22886626796, 12867.22796632205, 12894.290814005226, 11288.153388495813, 11703.122265830098, 12279.93860030703, 12456.31490268035, 12602.581179440394, 9783.46190959497, 9857.457839818808, 9911.801763964753, 9977.351472154287, 10310.175185985103, 3458.3774920514297, 3496.947545786815, 3499.91250218744, 3549.94675079874, 3557.8576856925692, 44306.113877722586, 44733.55266447327, 44971.0, 45034.0, 45726.0, 9398.060193980684, 9413.0, 9446.574904129331, 9565.186959108414, 9736.318457708034, 16898.662026759397, 17033.574160645836, 17036.57408564771, 17041.573960650836, 17066.573335666708, 7128.893066604005, 7211.459140564479, 7318.817029574303, 7409.481336306407, 7509.887351689729, 4216.885367665263, 4237.237297286456, 4260.041490664576, 4261.595148460891, 4267.701260911706, 3070.8925187618324, 3086.90739277822, 3099.3336432667083, 3102.146909599878, 3102.534619807047, 577.8439821248323, 578.0808514462026, 593.0807248764484, 625.6746491824226, 662.1689779326914, 591.961522501036, 647.0876064748682, 658.7858945842524, 672.7843874446619, 732.0775822463734, 7844.450888437755, 7952.880706789403, 8033.758987230392, 8084.627101908802, 8276.29651479619, 579.6782785553974, 644.4672486701626, 721.9314165154302, 732.952358096722, 746.0525133080956, 3540.433530635086, 3646.7447278690765, 3657.451382292624, 3780.4140358244517, 3879.321118804198, 52002.73998629983, 52228.0, 53278.46721532813, 57486.0, 57495.425045749005, 47408.762956185, 49248.75375623099, 49783.0, 50044.74977625089, 50073.749631252336, 43246.7837660816, 43873.78063109664, 44216.55783442189, 44903.326450103275, 45051.774741126086, 7812.765617031499, 7925.643346049326, 7976.397292278302, 8233.259006689426, 8391.118932511998, 33416.33167336688, 34193.31613367768, 34718.65281347154, 35187.64812351946, 35287.82356088203, 41638.58361416347, 41900.37149442822, 42050.1589968205, 42871.57128428676, 43047.13905721805, 10424.530896109542, 10502.737431564272, 11190.720231994264, 11312.434378280888, 11354.375509347065, 11964.0, 11981.700457488632, 12045.397730113635, 12695.492180312684, 12841.422136003715, 10631.840522392326, 11014.669559913216, 11212.27120237182, 11557.942210288895, 11582.725900151145, 11043.779124417306, 11183.161262905478, 11300.0, 11675.464047261214, 11823.46794394237, 11211.887881121085, 11456.255343402652, 11488.483018264365, 11550.537978480766, 11635.069194464253, 9706.36378153932, 9816.901830981598, 9933.0, 10008.14930730867, 10039.69880903574, 8875.047489552288, 8985.371024028254, 9261.72214833556, 9273.67542136022, 9597.568109434953], "unit": "score", "name": "yui.html", "value": 6168.575007178017}], "name": "dromaeo_css", "value": 6836.859585571032}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 103.0, 109.0, 110.0, 112.0, 99.0, 110.0, 110.0, 113.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [152.0, 133.0, 150.0, 165.0, 124.0, 149.0, 149.0, 133.0, 167.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 160.0, 161.0, 159.0, 162.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 84.0, 88.0, 72.0, 73.0, 79.0, 106.0, 90.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 136.0, 93.0, 94.0, 94.0, 149.0, 94.0, 94.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 57.0, 58.0, 58.0, 58.0, 57.0, 66.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [92.0, 86.0, 85.0, 84.0, 85.0, 85.0, 84.0, 86.0, 86.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [129.0, 123.0, 118.0, 123.0, 123.0, 114.0, 135.0, 122.0, 124.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [143.0, 140.0, 149.0, 144.0, 162.0, 144.0, 153.0, 155.0, 151.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.2}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 68.0, 67.0, 67.0, 67.0, 65.0, 66.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1503.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.09547823163558], "unit": "score", "name": "Richards", "value": 210.01159799999994}, {"lowerIsBetter": false, "replicates": [188.9287738522577], "unit": "score", "name": "DeltaBlue", "value": 349.96257399999996}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1102.5358324145534], "unit": "score", "name": "RayTrace", "value": 671.170023}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [11779.06976744186], "unit": "score", "name": "Boyer", "value": 56.58027443237911}, {"lowerIsBetter": false, "replicates": [25923.076923076922], "unit": "score", "name": "RegExp", "value": 35.14185459940652}, {"lowerIsBetter": false, "replicates": [678.1376518218624], "unit": "score", "name": "Splay", "value": 120.16881791044771}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20836.97079603143}]} 20:19:43 INFO - RETURN: dromaeo_css: 6836.86 20:19:43 INFO - RETURN: kraken: 1503.20 20:19:43 INFO - RETURN: v8_7: 20836.97 20:19:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20836.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1503.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6836.86"}}} 20:19:43 INFO - Return code: 0 20:19:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:19:44 INFO - # TBPL SUCCESS # 20:19:44 INFO - Running post-action listener: _resource_record_post_action 20:19:44 INFO - Running post-run listener: _resource_record_post_run 20:19:45 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 16384; Write bytes: 550383616; Read time: 300; Write time: 892384 20:19:45 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 4096; Write bytes: 240467968; Read time: 248; Write time: 550200 20:19:45 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 12288; Write bytes: 309743616; Read time: 52; Write time: 342160 20:19:45 INFO - Running post-run listener: _upload_blobber_files 20:19:45 INFO - Blob upload gear active. 20:19:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:19:45 INFO - Copying logs to upload dir... 20:19:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.704523 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-18 20:19:45.089827) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 20:19:45.093832) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010038 build_url: 'https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/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-18 20:19:45.145865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 20:19:45.146224) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450497462.517210-636084997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 20:19:45.196760) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 20:19:45.197110) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 20:19:45.197509) ========= ========= Total master_lag: 0.22 =========