builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1450497514.82 results: success (0) buildid: 20151218173004 builduid: 5f4ebf00ba0a4a20a2368b54d5b3e551 revision: 36aa441232b7e8cc82b0a83d1b343fd3ace134a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.817483) ========= 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:34.817872) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.818162) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006286 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.843477) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.843746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.859678) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.859928) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.909098) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.909392) ========= 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:34.909778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:34.910047) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 19:58:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-12-18 19:58:35 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.202103 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:35.124034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:35.124321) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016050 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:35.173754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:35.174059) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 19:58:35,426 truncating revision to first 12 chars 2015-12-18 19:58:35,426 Setting DEBUG logging. 2015-12-18 19:58:35,426 attempt 1/10 2015-12-18 19:58:35,426 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:35,677 unpacking tar archive at: fx-team-36aa441232b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575042 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:35.761414) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:35.761699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:35.770571) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 19:58:35.770849) ========= 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:35.771243) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-18 19:58:35.771530) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:58:36 INFO - MultiFileLogger online at 20151218 19:58:36 in /builds/slave/test-pgo 19:58:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:58:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:58:36 INFO - {'append_to_log': False, 19:58:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:58:36 INFO - 'blob_upload_branch': 'Fx-Team', 19:58:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:58:36 INFO - 'branch': 'Fx-Team', 19:58:36 INFO - 'buildbot_json_path': 'buildprops.json', 19:58:36 INFO - 'config_files': ('talos/linux_config.py',), 19:58:36 INFO - 'default_actions': ('clobber', 19:58:36 INFO - 'read-buildbot-config', 19:58:36 INFO - 'download-and-extract', 19:58:36 INFO - 'populate-webroot', 19:58:36 INFO - 'create-virtualenv', 19:58:36 INFO - 'install', 19:58:36 INFO - 'run-tests'), 19:58:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:58:36 INFO - 'download_minidump_stackwalk': True, 19:58:36 INFO - 'download_symbols': 'ondemand', 19:58:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:58:36 INFO - 'tooltool.py': '/tools/tooltool.py', 19:58:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:58:36 INFO - '/tools/misc-python/virtualenv.py')}, 19:58:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:58:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:58:36 INFO - 'installer_path': 'installer.exe', 19:58:36 INFO - 'log_level': 'info', 19:58:36 INFO - 'log_name': 'talos', 19:58:36 INFO - 'log_to_console': True, 19:58:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:58:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:58:36 INFO - 'opt_config_files': (), 19:58:36 INFO - 'pip_index': False, 19:58:36 INFO - 'sps_profile': False, 19:58:36 INFO - 'sps_profile_interval': 0, 19:58:36 INFO - 'suite': 'dromaeojs-e10s', 19:58:36 INFO - 'system_bits': '64', 19:58:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:58:36 INFO - 'title': 'talos-linux64-ix-062', 19:58:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:58:36 INFO - 'use_talos_json': True, 19:58:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:58:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:58:36 INFO - 'work_dir': 'build'} 19:58:36 INFO - ##### 19:58:36 INFO - ##### Running clobber step. 19:58:36 INFO - ##### 19:58:36 INFO - Running pre-action listener: _resource_record_pre_action 19:58:36 INFO - Running main action method: clobber 19:58:36 INFO - rmtree: /builds/slave/test-pgo/build 19:58:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:58:37 INFO - Running post-action listener: _resource_record_post_action 19:58:37 INFO - ##### 19:58:37 INFO - ##### Running read-buildbot-config step. 19:58:37 INFO - ##### 19:58:37 INFO - Running pre-action listener: _resource_record_pre_action 19:58:37 INFO - Running main action method: read_buildbot_config 19:58:37 INFO - Using buildbot properties: 19:58:37 INFO - { 19:58:37 INFO - "project": "", 19:58:37 INFO - "product": "firefox", 19:58:37 INFO - "script_repo_revision": "production", 19:58:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:58:37 INFO - "repository": "", 19:58:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:58:37 INFO - "buildid": "20151218173004", 19:58:37 INFO - "pgo_build": "True", 19:58:37 INFO - "basedir": "/builds/slave/test-pgo", 19:58:37 INFO - "buildnumber": 150, 19:58:37 INFO - "slavename": "talos-linux64-ix-062", 19:58:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:58:37 INFO - "platform": "ubuntu64_hw", 19:58:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:58:37 INFO - "branch": "fx-team", 19:58:37 INFO - "repo_path": "integration/fx-team", 19:58:37 INFO - "revision": "36aa441232b7e8cc82b0a83d1b343fd3ace134a7", 19:58:37 INFO - "stage_platform": "linux64-pgo", 19:58:37 INFO - "builduid": "5f4ebf00ba0a4a20a2368b54d5b3e551", 19:58:37 INFO - "slavebuilddir": "test" 19:58:37 INFO - } 19:58:37 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:37 INFO - Running post-action listener: _resource_record_post_action 19:58:37 INFO - ##### 19:58:37 INFO - ##### Running download-and-extract step. 19:58:37 INFO - ##### 19:58:37 INFO - Running pre-action listener: _resource_record_pre_action 19:58:37 INFO - Running main action method: download_and_extract 19:58:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:37 INFO - https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/test_packages.json 19:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/test_packages.json 19:58:37 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:37 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:45 INFO - Downloaded 1302 bytes. 19:58:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:58:45 INFO - Using the following test package requirements: 19:58:45 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:45 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:58:45 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:45 INFO - u'jsshell-linux-x86_64.zip'], 19:58:45 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:58:45 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:45 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:58:45 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:58:45 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:58:45 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:45 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:58:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:58:45 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:45 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:45 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:45 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:45 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:45 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:53 INFO - Downloaded 23121218 bytes. 19:58:53 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:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:53 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:54 INFO - Return code: 0 19:58:54 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: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 - 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:54 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:54 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:54 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:54 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:55 INFO - Downloaded 23121218 bytes. 19:58:55 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:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:55 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:57 INFO - Return code: 0 19:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:57 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:57 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:57 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:57 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:57 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:58 INFO - Downloaded 11132039 bytes. 19:58:58 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:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:58 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:58 INFO - Return code: 0 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 - 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:58 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:58 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:58 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:58 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:59 INFO - Downloaded 54637734 bytes. 19:58:59 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:59 INFO - mkdir: /builds/slave/test-pgo/properties 19:58:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:58:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:58:59 INFO - Contents: 19:58:59 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:59 INFO - Running post-action listener: _resource_record_post_action 19:58:59 INFO - Running post-action listener: set_extra_try_arguments 19:58:59 INFO - ##### 19:58:59 INFO - ##### Running populate-webroot step. 19:58:59 INFO - ##### 19:58:59 INFO - Running pre-action listener: _resource_record_pre_action 19:58:59 INFO - Running main action method: populate_webroot 19:58:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:58:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:58:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:58:59 INFO - '--tppagecycles', 19:58:59 INFO - '7'], 19:58:59 INFO - 'tests': ['tsvgm']}}, 19:58:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:58:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:58:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:58:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:58:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:58:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:58:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:59 INFO - 'talos_options': ['--e10s'], 19:58:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:59 INFO - 'tests': ['damp', 'tps']}, 19:58:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:59 INFO - 'talos_options': ['--e10s'], 19:58:59 INFO - 'tests': ['damp', 'tps']}, 19:58:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:58:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:58:59 INFO - 'other': {'tests': ['a11yr', 19:58:59 INFO - 'ts_paint', 19:58:59 INFO - 'tpaint', 19:58:59 INFO - 'sessionrestore', 19:58:59 INFO - 'sessionrestore_no_auto_restore']}, 19:58:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:58:59 INFO - 'tests': ['a11yr', 19:58:59 INFO - 'ts_paint', 19:58:59 INFO - 'tpaint', 19:58:59 INFO - 'sessionrestore', 19:58:59 INFO - 'sessionrestore_no_auto_restore']}, 19:58:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:58:59 INFO - 'tests': ['a11yr', 19:58:59 INFO - 'ts_paint', 19:58:59 INFO - 'tpaint', 19:58:59 INFO - 'sessionrestore', 19:58:59 INFO - 'sessionrestore_no_auto_restore']}, 19:58:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:58:59 INFO - 'tests': ['a11yr', 19:58:59 INFO - 'ts_paint', 19:58:59 INFO - 'tpaint', 19:58:59 INFO - 'sessionrestore', 19:58:59 INFO - 'sessionrestore_no_auto_restore']}, 19:58:59 INFO - 'other_l64': {'tests': ['a11yr', 19:58:59 INFO - 'ts_paint', 19:58:59 INFO - 'tpaint', 19:58:59 INFO - 'sessionrestore', 19:58:59 INFO - 'sessionrestore_no_auto_restore']}, 19:58:59 INFO - 'other_nol64': {'tests': ['a11yr', 19:58:59 INFO - 'ts_paint', 19:58:59 INFO - 'tpaint', 19:58:59 INFO - 'sessionrestore', 19:58:59 INFO - 'sessionrestore_no_auto_restore']}, 19:58:59 INFO - 'svgr': {'tests': ['tsvgx', 19:58:59 INFO - 'tsvgr_opacity', 19:58:59 INFO - 'tart', 19:58:59 INFO - 'tscrollx', 19:58:59 INFO - 'cart']}, 19:58:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:58:59 INFO - 'tests': ['tsvgx', 19:58:59 INFO - 'tsvgr_opacity', 19:58:59 INFO - 'tart', 19:58:59 INFO - 'tscrollx', 19:58:59 INFO - 'cart']}, 19:58:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:59 INFO - 'tests': ['tp5o']}, 19:58:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:59 INFO - 'talos_options': ['--e10s'], 19:58:59 INFO - 'tests': ['tp5o']}, 19:58:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:59 INFO - 'talos_options': ['--xperf_path', 19:58:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:59 INFO - 'tests': ['tp5n']}, 19:58:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:59 INFO - 'talos_options': ['--e10s', 19:58:59 INFO - '--xperf_path', 19:58:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:59 INFO - 'tests': ['tp5n']}}, 19:58:59 INFO - 'talos.zip': {'path': '', 19:58:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:58:59 INFO - Running post-action listener: _resource_record_post_action 19:58:59 INFO - ##### 19:58:59 INFO - ##### Running create-virtualenv step. 19:58:59 INFO - ##### 19:58:59 INFO - Running pre-action listener: _resource_record_pre_action 19:58:59 INFO - Running main action method: create_virtualenv 19:58:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:58:59 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:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:58:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:58:59 INFO - Using real prefix '/usr' 19:58:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:59:00 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:02 INFO - Installing pip.................done. 19:59:02 INFO - Return code: 0 19:59:02 INFO - Installing pip>=1.5 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', '--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 0x7fc267ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1837350>, '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 0x1838250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18386e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', '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', '--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:59:02 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: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': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', 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 - 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:59:02 INFO - Cleaning up... 19:59:02 INFO - Return code: 0 19:59:02 INFO - Installing psutil>=0.7.1 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', '--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 0x7fc267ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1837350>, '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 0x1838250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18386e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', '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', '--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:59:02 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: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': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', 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 - Downloading/unpacking psutil>=0.7.1 19:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:04 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:59:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:59:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:04 INFO - Installing collected packages: psutil 19:59:04 INFO - Running setup.py install for psutil 19:59:04 INFO - building 'psutil._psutil_linux' extension 19:59:04 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:59:04 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:59:04 INFO - building 'psutil._psutil_posix' extension 19:59:04 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:59:05 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:59:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:05 INFO - Successfully installed psutil 19:59:05 INFO - Cleaning up... 19:59:05 INFO - Return code: 0 19:59:05 INFO - Installing mozsystemmonitor==0.0.0 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', '--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 0x7fc267ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1837350>, '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 0x1838250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18386e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', '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', '--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: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 --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: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': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', 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 - Downloading/unpacking mozsystemmonitor==0.0.0 19:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:59:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:59:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:07 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:59:07 INFO - Installing collected packages: mozsystemmonitor 19:59:07 INFO - Running setup.py install for mozsystemmonitor 19:59:07 INFO - Successfully installed mozsystemmonitor 19:59:07 INFO - Cleaning up... 19:59:07 INFO - Return code: 0 19:59:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:07 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 0x7fc267ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1837350>, '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 0x1838250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18386e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', '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:07 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:59:07 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:59:07 INFO - Using env: {'DISPLAY': ':0', 19:59:07 INFO - 'HOME': '/home/cltbld', 19:59:07 INFO - 'LANG': 'en_US.UTF-8', 19:59:07 INFO - 'LANGUAGE': 'en_US:en', 19:59:07 INFO - 'LOGNAME': 'cltbld', 19:59:07 INFO - 'MAIL': '/var/mail/cltbld', 19:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:07 INFO - 'MOZ_NO_REMOTE': '1', 19:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:07 INFO - 'NO_EM_RESTART': '1', 19:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:07 INFO - 'SHELL': '/bin/bash', 19:59:07 INFO - 'SHLVL': '1', 19:59:07 INFO - 'TERM': 'linux', 19:59:07 INFO - 'TMOUT': '86400', 19:59:07 INFO - 'USER': 'cltbld', 19:59:07 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', 19:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:07 INFO - '_': '/tools/buildbot/bin/python'} 19:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:07 INFO - Downloading/unpacking blobuploader==1.2.4 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:09 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:09 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:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:09 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:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:59:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:09 INFO - Downloading docopt-0.6.1.tar.gz 19:59:09 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:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:09 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:09 INFO - Running setup.py install for blobuploader 19:59:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:59:10 INFO - Running setup.py install for requests 19:59:10 INFO - Running setup.py install for docopt 19:59:10 INFO - Successfully installed blobuploader requests docopt 19:59:10 INFO - Cleaning up... 19:59:10 INFO - Return code: 0 19:59:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:10 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 0x7fc267ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1837350>, '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 0x1838250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18386e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', '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:10 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:10 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:10 INFO - Using env: {'DISPLAY': ':0', 19:59:10 INFO - 'HOME': '/home/cltbld', 19:59:10 INFO - 'LANG': 'en_US.UTF-8', 19:59:10 INFO - 'LANGUAGE': 'en_US:en', 19:59:10 INFO - 'LOGNAME': 'cltbld', 19:59:10 INFO - 'MAIL': '/var/mail/cltbld', 19:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:10 INFO - 'MOZ_NO_REMOTE': '1', 19:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:10 INFO - 'NO_EM_RESTART': '1', 19:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:10 INFO - 'SHELL': '/bin/bash', 19:59:10 INFO - 'SHLVL': '1', 19:59:10 INFO - 'TERM': 'linux', 19:59:10 INFO - 'TMOUT': '86400', 19:59:10 INFO - 'USER': 'cltbld', 19:59:10 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', 19:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:10 INFO - '_': '/tools/buildbot/bin/python'} 19:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:10 INFO - Running setup.py (path:/tmp/pip-qGFFMO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:10 INFO - Running setup.py (path:/tmp/pip-kdwXkD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:10 INFO - Running setup.py (path:/tmp/pip-BlIxaI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:10 INFO - Running setup.py (path:/tmp/pip-hEQFO3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:11 INFO - Running setup.py (path:/tmp/pip-hCE9Zi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:11 INFO - Running setup.py (path:/tmp/pip-XbhB41-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:11 INFO - Running setup.py (path:/tmp/pip-hq1z7O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:11 INFO - Running setup.py (path:/tmp/pip-681K5o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:11 INFO - Running setup.py (path:/tmp/pip-VSUs6I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:11 INFO - Running setup.py (path:/tmp/pip-p0ZGtl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:11 INFO - Running setup.py (path:/tmp/pip-eRdQU1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:11 INFO - Running setup.py (path:/tmp/pip-0ww0PV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:11 INFO - Running setup.py (path:/tmp/pip-smEe4T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:11 INFO - Running setup.py (path:/tmp/pip-ZlxfQN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:11 INFO - Running setup.py (path:/tmp/pip-lBLhO4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:11 INFO - Running setup.py (path:/tmp/pip-Tk3lna-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:11 INFO - Running setup.py (path:/tmp/pip-XFDr4a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:59:11 INFO - Running setup.py install for manifestparser 19:59:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Running setup.py install for mozcrash 19:59:12 INFO - Running setup.py install for mozdebug 19:59:12 INFO - Running setup.py install for mozdevice 19:59:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Running setup.py install for mozfile 19:59:12 INFO - Running setup.py install for mozhttpd 19:59:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Running setup.py install for mozinfo 19:59:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Running setup.py install for mozInstall 19:59:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Running setup.py install for mozleak 19:59:12 INFO - Running setup.py install for mozlog 19:59:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:59:13 INFO - Running setup.py install for moznetwork 19:59:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:59:13 INFO - Running setup.py install for mozprocess 19:59:13 INFO - Running setup.py install for mozprofile 19:59:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:59:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:59:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:59:13 INFO - Running setup.py install for mozrunner 19:59:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:59:13 INFO - Running setup.py install for mozscreenshot 19:59:13 INFO - Running setup.py install for moztest 19:59:13 INFO - Running setup.py install for mozversion 19:59:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:59:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:59:13 INFO - Cleaning up... 19:59:13 INFO - Return code: 0 19:59:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:13 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:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:13 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:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:13 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 0x7fc267ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1837350>, '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 0x1838250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18386e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', '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:13 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:13 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:13 INFO - Using env: {'DISPLAY': ':0', 19:59:13 INFO - 'HOME': '/home/cltbld', 19:59:13 INFO - 'LANG': 'en_US.UTF-8', 19:59:13 INFO - 'LANGUAGE': 'en_US:en', 19:59:13 INFO - 'LOGNAME': 'cltbld', 19:59:13 INFO - 'MAIL': '/var/mail/cltbld', 19:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:13 INFO - 'MOZ_NO_REMOTE': '1', 19:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:13 INFO - 'NO_EM_RESTART': '1', 19:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:13 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:13 INFO - 'SHELL': '/bin/bash', 19:59:13 INFO - 'SHLVL': '1', 19:59:13 INFO - 'TERM': 'linux', 19:59:13 INFO - 'TMOUT': '86400', 19:59:13 INFO - 'USER': 'cltbld', 19:59:13 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', 19:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:13 INFO - '_': '/tools/buildbot/bin/python'} 19:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:13 INFO - Running setup.py (path:/tmp/pip-_QEaJE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:14 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:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:14 INFO - Running setup.py (path:/tmp/pip-zrpti6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:14 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:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:14 INFO - Running setup.py (path:/tmp/pip-wN6b20-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:14 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:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:14 INFO - Running setup.py (path:/tmp/pip-RB6ZZb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:14 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:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:14 INFO - Running setup.py (path:/tmp/pip-AtS0DU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:14 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:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:14 INFO - Running setup.py (path:/tmp/pip-HyFZY9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:14 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:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:14 INFO - Running setup.py (path:/tmp/pip-ZflJq5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:14 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:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:14 INFO - Running setup.py (path:/tmp/pip-12EybP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:14 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:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:14 INFO - Running setup.py (path:/tmp/pip-h1xfv_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:14 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:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:14 INFO - Running setup.py (path:/tmp/pip-q0Tzgq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:14 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:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:14 INFO - Running setup.py (path:/tmp/pip-0Da1AZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:14 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:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:14 INFO - Running setup.py (path:/tmp/pip-cGIC7Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:14 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:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:14 INFO - Running setup.py (path:/tmp/pip-0UtpSL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:14 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:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:14 INFO - Running setup.py (path:/tmp/pip-pPY9iZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:15 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:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:15 INFO - Running setup.py (path:/tmp/pip-6WJLLG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:15 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:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:15 INFO - Running setup.py (path:/tmp/pip-9vEI81-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:15 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:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:15 INFO - Running setup.py (path:/tmp/pip-uxGa5N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:15 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:15 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:15 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:15 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:15 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:15 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:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:16 INFO - Downloading blessings-1.5.1.tar.gz 19:59:16 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:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:59:16 INFO - Installing collected packages: blessings 19:59:16 INFO - Running setup.py install for blessings 19:59:17 INFO - Successfully installed blessings 19:59:17 INFO - Cleaning up... 19:59:17 INFO - Return code: 0 19:59:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:59:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:59:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:59:17 INFO - Reading from file tmpfile_stdout 19:59:17 INFO - Current package versions: 19:59:17 INFO - argparse == 1.2.1 19:59:17 INFO - blessings == 1.5.1 19:59:17 INFO - blobuploader == 1.2.4 19:59:17 INFO - docopt == 0.6.1 19:59:17 INFO - manifestparser == 1.1 19:59:17 INFO - mozInstall == 1.12 19:59:17 INFO - mozcrash == 0.16 19:59:17 INFO - mozdebug == 0.1 19:59:17 INFO - mozdevice == 0.47 19:59:17 INFO - mozfile == 1.2 19:59:17 INFO - mozhttpd == 0.7 19:59:17 INFO - mozinfo == 0.9 19:59:17 INFO - mozleak == 0.1 19:59:17 INFO - mozlog == 3.1 19:59:17 INFO - moznetwork == 0.27 19:59:17 INFO - mozprocess == 0.22 19:59:17 INFO - mozprofile == 0.27 19:59:17 INFO - mozrunner == 6.11 19:59:17 INFO - mozscreenshot == 0.1 19:59:17 INFO - mozsystemmonitor == 0.0 19:59:17 INFO - moztest == 0.7 19:59:17 INFO - mozversion == 1.4 19:59:17 INFO - psutil == 3.1.1 19:59:17 INFO - requests == 1.2.3 19:59:17 INFO - wsgiref == 0.1.2 19:59:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:17 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 0x7fc267ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1837350>, '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 0x1838250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18386e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 19:59:17 INFO - 'HOME': '/home/cltbld', 19:59:17 INFO - 'LANG': 'en_US.UTF-8', 19:59:17 INFO - 'LANGUAGE': 'en_US:en', 19:59:17 INFO - 'LOGNAME': 'cltbld', 19:59:17 INFO - 'MAIL': '/var/mail/cltbld', 19:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:17 INFO - 'MOZ_NO_REMOTE': '1', 19:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:17 INFO - 'NO_EM_RESTART': '1', 19:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:17 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:17 INFO - 'SHELL': '/bin/bash', 19:59:17 INFO - 'SHLVL': '1', 19:59:17 INFO - 'TERM': 'linux', 19:59:17 INFO - 'TMOUT': '86400', 19:59:17 INFO - 'USER': 'cltbld', 19:59:17 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', 19:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:17 INFO - '_': '/tools/buildbot/bin/python'} 19:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:17 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:17 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:17 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:17 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:17 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:17 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:17 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:17 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:17 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:17 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:17 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:17 INFO - Cleaning up... 19:59:17 INFO - Return code: 0 19:59:17 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:59:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:17 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 0x7fc267ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1837350>, '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 0x1838250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18386e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 19:59:17 INFO - 'HOME': '/home/cltbld', 19:59:17 INFO - 'LANG': 'en_US.UTF-8', 19:59:17 INFO - 'LANGUAGE': 'en_US:en', 19:59:17 INFO - 'LOGNAME': 'cltbld', 19:59:17 INFO - 'MAIL': '/var/mail/cltbld', 19:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:17 INFO - 'MOZ_NO_REMOTE': '1', 19:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:17 INFO - 'NO_EM_RESTART': '1', 19:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:17 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:17 INFO - 'SHELL': '/bin/bash', 19:59:17 INFO - 'SHLVL': '1', 19:59:17 INFO - 'TERM': 'linux', 19:59:17 INFO - 'TMOUT': '86400', 19:59:17 INFO - 'USER': 'cltbld', 19:59:17 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', 19:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:17 INFO - '_': '/tools/buildbot/bin/python'} 19:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:17 INFO - Downloading/unpacking jsonschema 19:59:17 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:17 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:17 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:17 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:17 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:17 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:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:59:19 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:19 INFO - Downloading/unpacking functools32 (from jsonschema) 19:59:19 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:19 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:19 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:19 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:19 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:19 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:19 INFO - Downloading functools32-3.2.3-2.tar.gz 19:59:19 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:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:59:19 INFO - warning: no files found matching '*.txt' 19:59:19 INFO - no previously-included directories found matching 'build' 19:59:19 INFO - no previously-included directories found matching 'dist' 19:59:19 INFO - no previously-included directories found matching '.git*' 19:59:19 INFO - Installing collected packages: jsonschema, functools32 19:59:19 INFO - Running setup.py install for functools32 19:59:19 INFO - warning: no files found matching '*.txt' 19:59:19 INFO - no previously-included directories found matching 'build' 19:59:19 INFO - no previously-included directories found matching 'dist' 19:59:19 INFO - no previously-included directories found matching '.git*' 19:59:19 INFO - Successfully installed jsonschema functools32 19:59:19 INFO - Cleaning up... 19:59:19 INFO - Return code: 0 19:59:19 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:59:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:19 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 0x7fc267ca6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1837350>, '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 0x1838250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18386e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 19:59:19 INFO - 'HOME': '/home/cltbld', 19:59:19 INFO - 'LANG': 'en_US.UTF-8', 19:59:19 INFO - 'LANGUAGE': 'en_US:en', 19:59:19 INFO - 'LOGNAME': 'cltbld', 19:59:19 INFO - 'MAIL': '/var/mail/cltbld', 19:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:19 INFO - 'MOZ_NO_REMOTE': '1', 19:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:19 INFO - 'NO_EM_RESTART': '1', 19:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:19 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:19 INFO - 'SHELL': '/bin/bash', 19:59:19 INFO - 'SHLVL': '1', 19:59:19 INFO - 'TERM': 'linux', 19:59:19 INFO - 'TMOUT': '86400', 19:59:19 INFO - 'USER': 'cltbld', 19:59:19 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', 19:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:19 INFO - '_': '/tools/buildbot/bin/python'} 19:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:20 INFO - Downloading/unpacking flake8 19:59:20 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:20 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:20 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:20 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:20 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:20 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:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:59:21 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:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:59:21 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:21 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:21 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:21 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:21 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:21 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:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:59:22 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:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:59:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:59:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:59:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:22 INFO - no previously-included directories found matching 'docs/_build' 19:59:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:59:22 INFO - Running setup.py install for pep8 19:59:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:22 INFO - no previously-included directories found matching 'docs/_build' 19:59:22 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:59:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:59:22 INFO - Cleaning up... 19:59:22 INFO - Return code: 0 19:59:22 INFO - Running post-action listener: _resource_record_post_action 19:59:22 INFO - Running post-action listener: _start_resource_monitoring 19:59:22 INFO - Starting resource monitoring. 19:59:22 INFO - ##### 19:59:22 INFO - ##### Running install step. 19:59:22 INFO - ##### 19:59:22 INFO - Running pre-action listener: _resource_record_pre_action 19:59:22 INFO - Running main action method: install 19:59:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:59:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:59:22 INFO - Reading from file tmpfile_stdout 19:59:22 INFO - Detecting whether we're running mozinstall >=1.0... 19:59:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:59:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:59:23 INFO - Reading from file tmpfile_stdout 19:59:23 INFO - Output received: 19:59:23 INFO - Usage: mozinstall [options] installer 19:59:23 INFO - Options: 19:59:23 INFO - -h, --help show this help message and exit 19:59:23 INFO - -d DEST, --destination=DEST 19:59:23 INFO - Directory to install application into. [default: 19:59:23 INFO - "/builds/slave/test-pgo"] 19:59:23 INFO - --app=APP Application being installed. [default: firefox] 19:59:23 INFO - mkdir: /builds/slave/test-pgo/build/application 19:59:23 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:23 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:38 INFO - Reading from file tmpfile_stdout 19:59:38 INFO - Output received: 19:59:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:59:38 INFO - Running post-action listener: _resource_record_post_action 19:59:38 INFO - ##### 19:59:38 INFO - ##### Running run-tests step. 19:59:38 INFO - ##### 19:59:38 INFO - Running pre-action listener: _resource_record_pre_action 19:59:38 INFO - Running main action method: run_tests 19:59:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:59:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:59:38 INFO - Python 2.7.3 19:59:38 INFO - Return code: 0 19:59:38 INFO - grabbing minidump binary from tooltool 19:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:38 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 0x1837350>, '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 0x1838250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18386e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:59:38 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:38 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:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:38 INFO - Return code: 0 19:59:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:59:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:59:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:59:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:59:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:59:39 INFO - Return code: 0 19:59:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 19:59:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost 19:59:39 INFO - Using env: {'DISPLAY': ':0', 19:59:39 INFO - 'HOME': '/home/cltbld', 19:59:39 INFO - 'LANG': 'en_US.UTF-8', 19:59:39 INFO - 'LANGUAGE': 'en_US:en', 19:59:39 INFO - 'LOGNAME': 'cltbld', 19:59:39 INFO - 'MAIL': '/var/mail/cltbld', 19:59:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:39 INFO - 'MOZ_NO_REMOTE': '1', 19:59:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:39 INFO - 'NO_EM_RESTART': '1', 19:59:39 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:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:39 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:59:39 INFO - 'SHELL': '/bin/bash', 19:59:39 INFO - 'SHLVL': '1', 19:59:39 INFO - 'TERM': 'linux', 19:59:39 INFO - 'TMOUT': '86400', 19:59:39 INFO - 'USER': 'cltbld', 19:59:39 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496', 19:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:39 INFO - '_': '/tools/buildbot/bin/python'} 19:59:39 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0gL7ILmvQsKXoldJGHXGNw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] with output_timeout 3600 19:59:40 INFO - mozversion INFO | application_buildid: 20151218173004 19:59:40 INFO - mozversion INFO | application_changeset: 36aa441232b7e8cc82b0a83d1b343fd3ace134a7 19:59:40 INFO - mozversion INFO | application_display_name: Nightly 19:59:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:40 INFO - mozversion INFO | application_name: Firefox 19:59:40 INFO - mozversion INFO | application_remotingname: firefox 19:59:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:59:40 INFO - mozversion INFO | application_vendor: Mozilla 19:59:40 INFO - mozversion INFO | application_version: 46.0a1 19:59:40 INFO - mozversion INFO | platform_buildid: 20151218173004 19:59:40 INFO - mozversion INFO | platform_changeset: 36aa441232b7e8cc82b0a83d1b343fd3ace134a7 19:59:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:59:40 INFO - mozversion INFO | platform_version: 46.0a1 19:59:40 INFO - 2015-12-18 19:59:40,042 DEBUG : using testdate: 1450497580 19:59:40 INFO - 2015-12-18 19:59:40,042 DEBUG : actual date: 1450497580 19:59:40 INFO - 2015-12-18 19:59:40,052 INFO : starting webserver on 'localhost:34369' 19:59:40 INFO - 2015-12-18 19:59:40,053 INFO : Starting test suite talos-linux64-ix-062.e 19:59:40 INFO - 2015-12-18 19:59:40,053 INFO : Starting test dromaeo_css 19:59:40 INFO - 2015-12-18 19:59:40,054 DEBUG : operating with platform_type : linux_ 19:59:40 INFO - 2015-12-18 19:59:40,054 INFO : Initialising browser for dromaeo_css test... 19:59:40 INFO - 2015-12-18 19:59:40,069 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Z4p_7/profile http://localhost:34369/getInfo.html 19:59:44 INFO - 2015-12-18 19:59:44,557 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:59:44 INFO - 2015-12-18 19:59:44,557 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:59:44 INFO - 2015-12-18 19:59:44,557 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:59:44 INFO - 2015-12-18 19:59:44,557 DEBUG : BROWSER_OUTPUT: __metrics 19:59:44 INFO - 2015-12-18 19:59:44,680 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:45 INFO - 2015-12-18 19:59:45,556 INFO : Browser initialized. 19:59:45 INFO - 2015-12-18 19:59:45,557 INFO : Running cycle 1/1 for dromaeo_css test... 19:59:45 INFO - 2015-12-18 19:59:45,557 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Z4p_7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:59:57 INFO - 2015-12-18 19:59:57,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 150745088 19:59:57 INFO - 2015-12-18 19:59:57,351 DEBUG : BROWSER_OUTPUT: 20:00:46 INFO - 2015-12-18 20:00:46,950 DEBUG : BROWSER_OUTPUT: 1450497646946 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:56 INFO - 2015-12-18 20:02:56,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34369/tests/dromaeo/cssquery-ext.html) 20:02:57 INFO - 2015-12-18 20:02:57,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 154628096 20:02:57 INFO - 2015-12-18 20:02:57,716 DEBUG : BROWSER_OUTPUT: 20:05:59 INFO - 2015-12-18 20:05:59,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/dromaeo/cssquery-ext.html (next: http://localhost:34369/tests/dromaeo/cssquery-jquery.html) 20:06:00 INFO - 2015-12-18 20:06:00,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 152612864 20:06:00 INFO - 2015-12-18 20:06:00,402 DEBUG : BROWSER_OUTPUT: 20:09:02 INFO - 2015-12-18 20:09:02,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34369/tests/dromaeo/cssquery-mootools.html) 20:09:02 INFO - 2015-12-18 20:09:02,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 153919488 20:09:02 INFO - 2015-12-18 20:09:02,707 DEBUG : BROWSER_OUTPUT: 20:12:04 INFO - 2015-12-18 20:12:04,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34369/tests/dromaeo/cssquery-prototype.html) 20:12:04 INFO - 2015-12-18 20:12:04,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 151678976 20:12:04 INFO - 2015-12-18 20:12:04,964 DEBUG : BROWSER_OUTPUT: 20:15:07 INFO - 2015-12-18 20:15:07,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34369/tests/dromaeo/cssquery-yui.html) 20:15:07 INFO - 2015-12-18 20:15:07,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 152412160 20:15:07 INFO - 2015-12-18 20:15:07,920 DEBUG : BROWSER_OUTPUT: 20:18:10 INFO - 2015-12-18 20:18:10,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/dromaeo/cssquery-yui.html (next: http://localhost:34369/tests/dromaeo/cssquery-dojo.html) 20:18:10 INFO - 2015-12-18 20:18:10,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 156200960 20:18:10 INFO - 2015-12-18 20:18:10,394 DEBUG : BROWSER_OUTPUT: 20:18:10 INFO - 2015-12-18 20:18:10,395 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:18:10 INFO - 2015-12-18 20:18:10,396 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:18:10 INFO - 2015-12-18 20:18:10,396 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:18:10 INFO - 2015-12-18 20:18:10,396 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:18:10 INFO - 2015-12-18 20:18:10,397 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3206.4228438881;3243.578334816472;3250.7236884864787;3277.0824169232615;3300.2739397332593;5418.024755544;5489.91765123523;5514.91727624086;5523.1163013917785;5543.6396634218745;5383.515483606475;5397.784088636459;5415.539679127279;5447.863803404917;5511.917321240175;4696.788644510988;4955.529224723655;5160.716160611165;5176.223566465042;5177.741112944338;4829.806807727687;5119.206522988943;5122.92315615266;5127.846164615067;5162.896742065156;4896.608271338302;4931.186354251544;5052.292679024939;5070.873228169288;5104.719240441774;5077.949220507821;5079.771410286546;5081.161608334621;5097.515736005073;5123.385193776733;4819.59033482151;5029.471905449948;5065;5079.492050794928;5122.436531981479;5230.241614965847;5343.251944727741;5344.652597581145;5355.758990845421;5394.109971854639;5866.911996320058;5908.4386983236955;5928.170056192136;5957.136215248808;6014.3985601439945;5984.431479009487;6008.909866352008;6018.886505996405;6020.668863212565;6032.487238584726;5553.416891226403;5559.305086864142;5570;5575.386707462176;5615.719214039323;5902.940970590325;5917.644941303535;5944.197533332945;5954.255718035246;5995.2206213192;5725.799597014085;5774.624649397776;5842.561807864342;5860.912086318709;5867.973104706744;5858.736356863951;5867.941320586825;5869.354371019184;5931.317898441648;5942;5797.768089276382;5937;5966.552508561876;5973;5995;6063.363346848518;6064.302605200371;6065.059915712984;6090.116933044772;6091.390860913962;4435.556444355539;4522.118186953512;4612.100640375094;4618.284165954283;4623.606993405599;4001.7198796083994;4017.718759686794;4035.6771458283265;4048.8865561970692;4102.0360215349365;5561.165825126263;5599.132134519156;5599.80400685974;5646.491815736604;5669.914951275734;5891.705414729332;6007.128966299862;6025.457708806229;6029.939700602938;6087.604305720114;5634.126710359901;5640.85897852557;5685.545156387479;5698.515626171739;5701.743421546041;5128.1794912813775;5144.742762861842;5163.7676304566385;5229.790808367623;5252.632315737862;5835.4748072673665;5925.970370148121;5946.197263369476;5951.226340575698;6127.325994140641;5968.820935371946;6055.939440605537;6062.454379105901;6088.117223002729;6100.694965251809;6114.48026917717;6166.136740856374;6175.876482470415;6205.88294107065;6215.409536094064;5795.94204057954;5847.093700476433;5926.703664816828;5991.940080599138;6011.0382338825575;5992.940070599238;6074.088886667036;6083.452489275986;6122.938770612237;6134;5881.735321910439;5888.293404791281;5927.318358388668;5934.525237981037;5975.342712301556;5749.425057494384;5802;5852.502537284378;5870.589058765845;5886.882262354643;5807.983602869396;5820.097884827858;5828.417158284137;5833.504152147115;5833.7666493341485;5889.440503152194;5904.380040095728;5943.108533719804;5943.138244954544;5960.5231581474245;5483.890322193613;5623.8594035149445;5707.914381284367;5830.737616807169;5830.941690583039 20:18:10 INFO - 2015-12-18 20:18:10,401 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.3707079535523;586.4633860018083;598.6856900127435;604.879024195161;608.2245137449751;37909;38501.22997540048;38836.80581597092;39172.41241381374;39230.21539569207;40915.545067295905;41892.16215675684;41916.95207619811;42036;42055.15889682212;8584.098669639692;8681.782955426102;8714.128587141267;8767.868481972775;8770.824583508325;8671.393002489796;8747.256483198937;8759.562021898879;8761.342899282547;8770.254528365065;8705.477671339708;8717.738467845944;8790.077041910603;8793.824123517526;8845.601947912328;8691.782705432382;8703.129687031309;8708;8748.518831464267;8754.56227188638;8626.698065567674;8690.348223883171;8695.956520217422;8710.47737135774;8715.956420217923;39489;39930.80034599808;39931.00344982768;40075.19849603021;40143.598564014574;3196.4566023776015;3231.062991732395;3326.2017115892254;3546.5034895114704;3766.322062028834;29159.271018224503;29638.110856674335;30472.54291185634;30591.235219119477;31191.844040779877;3884.6767757382227;4008.8596899108393;4025.2553277643437;4058.8782336529657;4103.302438585418;250836;251892;253984;254060.99999999814;254212;53693.926121478136;54244;59172.92894748663;64182.6790866052;65549.34450655528;59101.70449147813;59212.703936480044;59387.70306148442;59533.02334883239;59678.33055859686;13846.376913038937;13954.162750235018;14042.929785351213;14053.016288859886;14097.78853317201;10851.565937362575;10892.673219803419;10943.4528273586;10949.83575246372;11116.110711143088;19941.302054428317;20043.79737215772;20103.698444523343;20184.394468165978;20223.19107235694;7801.180876008051;7986.161453047463;8033.839323213503;8041.552520546241;8060.193980601893;895.7939673874915;942.566419447062;950.2682934140673;969.6993931880999;997.6083363707733;27624;27856;28413.715862841105;28522.42955140927;28625.42749145047;982.5087456271864;987.1855719031828;994.5723338964315;1004.7789486313;1112.6495154026456;14683.77974330386;16558.83441165597;16860.409885653942;17022.57443563896;17176.914115429343;364355;365614;368891;369579;370125;52863.471365285855;52884.206736898974;53107.46892531103;53241.467585324426;53294.73352633212;1350.3923234544495;1357.2806412601337;1370.4518192722792;1372.1561239837429;1376.7590671632424;28984.710152899046;29287;29635.407291854473;30126;30637.54043689391;44441;44707;44753.77623111994;44794.55205447904;45429.54570454253;281309;283903;284143;284977;285319;32371.676283237808;42237.57762422459;42611.57388426076;42636.14727705491;42831.3575296377;40172.1965560693;41112.38331424971;41141;41165.382519262836;41727.791361043;32446.513302300013;33012.834935825165;33162.66837331596;33228.33543329168;33384.33231335311;36488.27023459569;36602;36718.8164059178;37496;37632.623673762915;35525;35951;35972.64027359693;36077.639223607424;36287;31103.84448077745;32862.34275314432;33185.50221746627;33304.033401922316;33333;25235.369115772253;25742.485150297263;26095.217143485726;26269.21192364232;28080.85959570189 20:18:10 INFO - 2015-12-18 20:18:10,401 DEBUG : BROWSER_OUTPUT: |2;jquery.html;361.19633814762153;362.3676684186096;363.8362736768455;365.3916229477919;367.72971865678727;17033.488995330143;17378;17518;18121.275148994024;18122;11089.445527723621;11164.051055660279;11189.49647265873;12269.957053650429;15001.249937503137;5062.772175252104;5065.468125846779;5147.253648221005;5148.665336753099;5176.922346164792;5089.134847075988;5094.77073531692;5096.700341412935;5103.9489605103845;5126.948730512703;3627.7823330600118;3775.3959366501367;5059.519345662175;5090.847274581768;5104.846854594368;5159.226116082599;5308.309919710413;5320.095583750772;5340.465953404648;5350.063738845706;5102.158143906251;5142.100132476839;5148.9485105149215;5218.321618189611;5252.290940722992;11882.821757673642;12051.457684404222;12072;12090.153689241757;12645.557405490856;2083.0938541734395;2088.1960445228547;2135.95728085439;2147.162606583434;2176.6952626632283;9720.708378748648;9794.069563391466;9844.60621575136;9922.3054386193;9939.353941993748;1795.2818872451123;1838.7701537307837;1843.235057451156;1878.5115869873794;1917.7890432052463;58879.116813247834;59684;60162;60420.39579604236;60675.393246067855;9983.950080249553;10203.540840662188;10207.489625518694;10278.406687731576;10405.583776649;13050.955923526095;13209.33953302331;13279.93360033213;13292.401841917137;13457.394417251247;7007.614581198083;7103.289671032855;7149.964250178716;7193.3166349196745;7254.854902901912;6955.756548520778;6977.965110174417;6991.755288564876;6998.510104292651;7081.468889833283;4046.089629833264;4109.732867363671;4288.18524480354;4386.078923426053;4463.642908567307;1834;1884.8680592358678;1896.2415033986515;1905.3997990632906;1906.3518403742794;458.71788849857097;458.79354290569376;466.5035558489146;806.1454857850697;848.6647774129184;10488.323351802788;10587.39155120369;10736.08743256832;10832.404217768099;11041.889581104248;426.2646934038758;430.834128860391;439.246691923353;440.40545263894126;444.9265871131227;5687.516561092353;5783.334916484658;5818.389069147764;5831.3877042910735;5920.674362909996;537715;539904;540505;547632;554252;79454.02729863484;79747.20252797514;82399;82933;83291.16708832956;471.0226280467974;482.81894289641383;483.9758012099381;486.4017258771731;487.78537443524027;9529.61881524759;9616.95191524038;9639.518024098626;9783.315167938175;9866.161376283097;33461.832690837364;33703.494447582816;33902.98291051272;34035.4894676585;34493.13767155841;45276.77361613171;46406;46554;47162.29256561086;47562;9294.767630809283;9332.20676242527;9498.287628427757;9522.52387380642;9552.713418597454;12714.427850746924;17133.82866171322;17343.306267749147;17498.562535936704;17705.822941770417;11295.152863535432;14168.858311416754;14496.492622758575;14749.483768068067;14924;12876.742465150832;13550.390232439368;13579.86420135786;13932.30338483092;14229.573112806218;13749.106308089942;13921.512747053805;13924.860751392356;14463.78304325457;14505.419783208976;9315.6273749052;9443.811123777623;9462.384944978554;9488.240940724587;9520.190783783455;13846.307684615931;13860.168389896638;14213.715725685222;14301.856981430052;14386.568402947929 20:18:10 INFO - 2015-12-18 20:18:10,405 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1363.8227030486034;1378.2213049626957;1409.605310513056;1574.8425157484246;1585.508492367367;7251.129864416271;7290.489665723401;7413.481056326066;7497.4376921730955;7521.398288136949;7387.778366648996;7408.851822963537;7421.5176013559085;7438.590877501735;7448.1434635016985;2201.9889900550515;2246.8764217968005;2250.2686626846257;2251.538434620899;2259.954800903981;2251.808596269319;2252.1666983216232;2256.379495638696;2266.660000999855;2310.630299152136;2138.379869837745;2143.3355659745453;2151.128792838903;2208.7349518057777;2213.524092320151;2214.557088582274;2220.578090162864;2234.0728597631964;2252.9211477598287;2254.4927391336983;2262.7850354216325;2278.168468508999;2286.554121946221;2288.668143119255;2299.0918587158144;7260.491765576412;7323.633818309063;7324.816879578;7374.115106187238;7410.925890741131;4503.054358584701;4553.248713962193;4571.405717256768;4584.289435137559;4589.24277494213;2956.3791603763234;2984.3035962646577;3011.578379026938;3029.106413607991;3057.617797775278;942.7737343037691;967.4243824924159;976.2580438866513;987.328616540752;1020.6223697231998;9921.206303495703;9942.154916832078;9991;9996.950015249877;10019.649312274109;3948.348522493814;4060.6548443382053;4073.6944729145434;4116.629503344653;4152.647025002909;8084.717034903868;8115;8123.634436450256;8137.552434616153;8159.510429374256;4508.278675411984;4549.522300158502;4553.931691024637;4563.0873825235085;4606.309053641913;4161.625453709181;4172.436721042681;4211.052513184509;4246.787660616957;4277.59362860534;3418.29924865402;3442.915481623331;3454.775439596418;3467.8439470223902;3472.774269672463;1031.7523794289316;1032.9876720813495;1033.2302434686208;1047;1049.082053203447;942.8632848237104;944.1974321826392;1015.3451024089421;1029.9237297024627;1259.1815320042047;6981.057557229709;6981.162260528769;7008.684609192598;7059.647017649097;7089.22018577956;1028.4395004722444;1034.6016783538391;1046.4767616191905;1059.2691043180182;1067.4876059491487;5560.388357280696;5578.41426650204;5599.1321345190745;5616.2698849150165;5644.096944488944;8677.132286771399;8716.869246961302;8939.865902011476;8995.820083598423;9043.412178208395;8795.91204087951;8878.200961913459;8881.555922203865;8888.555572221363;8935.642574296955;6532.706028228741;6621.238557565845;6643.634600096944;6673.265940746514;6690.330966903368;6983.790486285419;6999.825004374931;7063.611501367474;7075.610841403773;7088.751893683696;7886.802829929297;7933.523988560705;8035.035795704553;8059;8113.229243221885;8012.118666946748;8099.919000810152;8200.712975046083;8201.671933122609;8268.958655206927;6420.903686444613;6423.261324947504;6457.0637257596445;6542.672866356568;6594.043863639841;7127.073480447716;7128.643567821485;7191.748288809867;7224.783256502314;7228.27717228294;5770.538356931519;6563.835904102436;6607.735690572324;6651.800445986628;6906.102206713095;6514.185726784152;6589.17635295588;6623.6688165592495;6635.369639884203;6758.8648227036165;6340.30256671775;6430.067640192239;6467.676616169267;6588.571742836701;6605.801825945229;6047.516198704181;6063.848403789941;6096.02463605821;6099.786507472217;6103.9694801527485;6126.540509461897;6234.189555357774;6270;6295.811125666238;6301.117843502005 20:18:10 INFO - 2015-12-18 20:18:10,405 DEBUG : BROWSER_OUTPUT: |4;prototype.html;336.4482249111457;339.2197944727127;342.85942763466977;351.3114295979879;351.9049856538736;6321.747130114795;6324.241091069072;6378.744850205992;6415.358464153594;6527.575707579004;6274;6326.8101956941255;6348.269948955872;6354.714037868295;6358;4799.856004319876;4802.567768900798;4805.159097158001;4814.8314808981695;4826.49321821209;4790.449098353682;4797.488791030814;4799.040191961604;4802.807887684488;4805.087033463648;4661.557152070548;4744.454387745402;4764.356811830393;4772.713637181763;4781.3545171401765;4706.411698537683;4714.127886341021;4748.216544270192;4752.643551733617;4756.595689366373;4082.6529744971713;4113.91772164555;4133.441985332001;4139.77231252281;4146.481689788777;6004.099385092228;6021.066734656135;6028.457438830526;6034.487068599175;6082.300535438437;5428.83713488596;5511.118221084607;5515.338159420855;5539.030669632798;5544.528715059185;6643.368879956396;6656.267810540837;6688.83277918051;6699.732010719566;6724.058631791553;4522.16339977102;4527.61515271199;4563.452385713703;4569.588737013652;4593.908121837578;6704.2625311215725;6768.52620316578;6831.419329356961;6898.103246577913;6909.1018167638385;4665.183592871234;4699.78850951708;4701.835435759732;4708.411448568929;4710.081534100886;4690.64820138491;4768.690035147704;4770.427548694179;4780.737059461763;4786.282057691375;5503.779848806083;5511.53151982078;5512.724363781795;5531.225628411945;5531.778728850801;6551.80344589663;6626.608412233389;6664.600123992576;6706.497012724065;6720.193576770819;1641.7127002774466;1658.6848498785191;1684.9157542122846;1687.0383881187606;1697.5671203842942;1087.4399684162663;1090.2695194219891;1094.698957786615;1099.4502748625687;1102.4873433853297;6246.4378205960775;6273.215848018997;6308.3060863305;6319.33646967071;6340.778072767524;6760.763373281911;6788.898166527506;6855.245922948472;6878.174619045746;6896.655167241718;6156.29202641693;6286.717097730613;6311.400416960381;6314;6329.620222786648;3695.6858667013603;3736.4208547675153;3737.6449237322413;3749.6250374962287;3764.9811750941617;6982.47631427645;7017.228104908456;7023.89464158038;7030.437564994788;7057.89413158803;6991.265917078736;7004.2995700430565;7046.788596342118;7058.294170582901;7073;7149.82125446868;7170.533915295593;7173.461990350745;7204.0994875640545;7225.8554828903125;6963.512554121163;6964.268751781193;6977.7208911642965;7007.40437062835;7057.294270572902;6821.386075253251;6876.106106206161;6878.55289406207;6878.65606719652;6922.688479018356;7163.10461192351;7174.1032370953635;7176.820579485555;7187.1734750504365;7199.532030418006;4669.39297891272;4701.801040734727;4709.434867815884;4716.221823399101;4737;6873.793786186422;6983.6857341418745;6995.580265183901;7024.578525288499;7048.083749112788;6751.189857217166;6786.966065169642;6793.4565234782085;6796.388325050571;6805.489588280998;6710.094137291599;6742.730290788313;6749.86500269982;6771.830704232433;6784.457243420613;6535.934640653532;6622.536422450382;6647.3352664735075;6653.201615806134;6668.866622667422;6735.663216839236;6764.4588432924265;6770.052192693125;6819.2498825128205;6838.213605435439;6629.171353580802;6650.800475985729;6651.866962660622;6661.900071498834;6673.699683514156 20:18:10 INFO - 2015-12-18 20:18:10,406 DEBUG : BROWSER_OUTPUT: |5;yui.html;735.5733674468809;773.5165521549031;786.6971216081811;809.0695699945062;855.9957200214005;13771.31143442829;14026.719465610682;14081.647958801022;14125.081869678464;14132.434702611909;13658.248796316198;14078.366473508691;14103.08329958552;14109.506167284148;14134.64663383416;805.5891495337377;824.2169938558363;836.882836402901;843.7131375332385;845.6448291717494;820.0774129104757;828.7016673997356;830.6884918155691;831.0899564976341;832.9333653307751;866.519081909543;867.4361664917823;868.635173227243;874.1433395272605;875.7635438431652;862.4394143806513;864.2524216552699;868.0494858130337;868.3921255121409;870.2211520688979;631.5673763472037;636.0364048466577;636.7357546618148;636.920384951881;637.5823835387829;13704;13728.244946527937;13779.173249605055;13787.172769633855;13896.305184740722;11239.66281011571;11416.42917854104;11518.136139789549;11753.118516111326;11783.293002419883;10057;10111.949440252753;10122.696319110439;10233.48832558369;10361.689149325532;3478.843452044664;3512.7365447591533;3544.3620148373284;3571.8571257149683;3598.748087633867;44152.11695766067;44500;44519;44623.107537849384;44643.77678111621;8814.515201663842;9066.637334506679;9194;9229.077092290852;9276.582553785096;16692.83307166937;16889.23998420074;16914.492565223063;16946.745798813026;16953.576160596083;6514.706838192293;6841.965790171017;7276.454265930077;7330.706771729071;7463.813404664818;4099.139180772012;4102.405151253051;4156.771377574262;4215.557151979605;4259.829606815754;2887.5235586128056;2903.738663520251;2940.779441541893;2944.4699954008056;2955.2907302247304;584.6696616411714;591.7100620695828;596.4751019103162;612.4487960835195;616.2666426951913;553.8504603756963;608.9086637004485;655.4494224851148;657.6908852839158;661.9933800661931;8579.442336248125;8880.467171969702;9277.814443711088;9361.719148425558;9451.76370590727;641.3970867384644;678.5792808458689;684.1789852177407;688.9138857642795;690.5614934516618;3713.517242758478;4085.162541678949;4125.731827431207;4288.442502474658;4340.76125813077;50673.23990140151;51358.22962655563;51823.74088129535;51964;52092.21861672078;47509.52490475051;47899.5210047902;48037.75981120142;48628;48960.510394895595;44134;44199.116017680106;44216.55783442124;44707;45024.324635129844;8195.385346098947;8344.791380215544;8418.747437576883;8520.74437766868;8649.654013839376;32069.198270042503;32482.51276230811;32680.83659581687;32781.672183277864;32890.50664240086;39875.60124398719;41482;41892.79053604713;42609.147817044104;42753.358699620156;10347.12049475803;10466.215033872339;10763.3541987481;11043.287174299676;11415.25800822977;11515.25150865191;11562.306261623993;11687.415629218674;11987.34069626179;12597.93701031489;10143.594256229668;10195.235357348376;10302.22733294991;10439.895601044196;11059.336439813636;10200;10521.210909181995;10599.735006624896;10747.838782418426;10786.137109031102;10433.686989390331;10741.946290268499;10748.785024299626;10761.623343182951;10782.573920867742;9585.281103917094;9663.613455461702;9877.259205559469;9936.652217172365;10070.69787906364;8372.120927302545;8540;8556.27271681914;9030.232430243503;9360.812783744423 20:18:10 INFO - 2015-12-18 20:18:10,406 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:18:10 INFO - 2015-12-18 20:18:10,406 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:18:10 INFO - 2015-12-18 20:18:10,406 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,309 20:18:10 INFO - 2015-12-18 20:18:10,406 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:18:10 INFO - 2015-12-18 20:18:10,407 DEBUG : BROWSER_OUTPUT: __startTimestamp1450498690394__endTimestamp 20:18:10 INFO - 2015-12-18 20:18:10,407 DEBUG : BROWSER_OUTPUT: 20:18:10 INFO - 2015-12-18 20:18:10,407 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:18:10 INFO - 2015-12-18 20:18:10,407 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:18:10 INFO - 2015-12-18 20:18:10,407 DEBUG : BROWSER_OUTPUT: 20:18:10 INFO - 2015-12-18 20:18:10,407 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5527.35 Median:5797.77 stddev:633.45 (10.9%) stddev-sans-first:608.67 20:18:10 INFO - 2015-12-18 20:18:10,407 DEBUG : BROWSER_OUTPUT: Values: 3206.4 3243.6 3250.7 3277.1 3300.3 5418.0 5489.9 5514.9 5523.1 5543.6 5383.5 5397.8 5415.5 5447.9 5511.9 4696.8 4955.5 5160.7 5176.2 5177.7 4829.8 5119.2 5122.9 5127.8 5162.9 4896.6 4931.2 5052.3 5070.9 5104.7 5077.9 5079.8 5081.2 5097.5 5123.4 4819.6 5029.5 5065.0 5079.5 5122.4 5230.2 5343.3 5344.7 5355.8 5394.1 5866.9 5908.4 5928.2 5957.1 6014.4 5984.4 6008.9 6018.9 6020.7 6032.5 5553.4 5559.3 5570.0 5575.4 5615.7 5902.9 5917.6 5944.2 5954.3 5995.2 5725.8 5774.6 5842.6 5860.9 5868.0 5858.7 5867.9 5869.4 5931.3 5942.0 5797.8 5937.0 5966.6 5973.0 5995.0 6063.4 6064.3 6065.1 6090.1 6091.4 4435.6 4522.1 4612.1 4618.3 4623.6 4001.7 4017.7 4035.7 4048.9 4102.0 5561.2 5599.1 5599.8 5646.5 5669.9 5891.7 6007.1 6025.5 6029.9 6087.6 5634.1 5640.9 5685.5 5698.5 5701.7 5128.2 5144.7 5163.8 5229.8 5252.6 5835.5 5926.0 5946.2 5951.2 6127.3 5968.8 6055.9 6062.5 6088.1 6100.7 6114.5 6166.1 6175.9 6205.9 6215.4 5795.9 5847.1 5926.7 5991.9 6011.0 5992.9 6074.1 6083.5 6122.9 6134.0 5881.7 5888.3 5927.3 5934.5 5975.3 5749.4 5802.0 5852.5 5870.6 5886.9 5808.0 5820.1 5828.4 5833.5 5833.8 5889.4 5904.4 5943.1 5943.1 5960.5 5483.9 5623.9 5707.9 5830.7 5830.9 20:18:10 INFO - 2015-12-18 20:18:10,407 DEBUG : BROWSER_OUTPUT: 20:18:10 INFO - 2015-12-18 20:18:10,407 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47249.14 Median:21360.74 stddev:80004.09 (374.5%) stddev-sans-first:80151.72 20:18:10 INFO - 2015-12-18 20:18:10,409 DEBUG : BROWSER_OUTPUT: Values: 559.4 586.5 598.7 604.9 608.2 37909.0 38501.2 38836.8 39172.4 39230.2 40915.5 41892.2 41917.0 42036.0 42055.2 8584.1 8681.8 8714.1 8767.9 8770.8 8671.4 8747.3 8759.6 8761.3 8770.3 8705.5 8717.7 8790.1 8793.8 8845.6 8691.8 8703.1 8708.0 8748.5 8754.6 8626.7 8690.3 8696.0 8710.5 8716.0 39489.0 39930.8 39931.0 40075.2 40143.6 3196.5 3231.1 3326.2 3546.5 3766.3 29159.3 29638.1 30472.5 30591.2 31191.8 3884.7 4008.9 4025.3 4058.9 4103.3 250836.0 251892.0 253984.0 254061.0 254212.0 53693.9 54244.0 59172.9 64182.7 65549.3 59101.7 59212.7 59387.7 59533.0 59678.3 13846.4 13954.2 14042.9 14053.0 14097.8 10851.6 10892.7 10943.5 10949.8 11116.1 19941.3 20043.8 20103.7 20184.4 20223.2 7801.2 7986.2 8033.8 8041.6 8060.2 895.8 942.6 950.3 969.7 997.6 27624.0 27856.0 28413.7 28522.4 28625.4 982.5 987.2 994.6 1004.8 1112.6 14683.8 16558.8 16860.4 17022.6 17176.9 364355.0 365614.0 368891.0 369579.0 370125.0 52863.5 52884.2 53107.5 53241.5 53294.7 1350.4 1357.3 1370.5 1372.2 1376.8 28984.7 29287.0 29635.4 30126.0 30637.5 44441.0 44707.0 44753.8 44794.6 45429.5 281309.0 283903.0 284143.0 284977.0 285319.0 32371.7 42237.6 42611.6 42636.1 42831.4 40172.2 41112.4 41141.0 41165.4 41727.8 32446.5 33012.8 33162.7 33228.3 33384.3 36488.3 36602.0 36718.8 37496.0 37632.6 35525.0 35951.0 35972.6 36077.6 36287.0 31103.8 32862.3 33185.5 33304.0 33333.0 25235.4 25742.5 26095.2 26269.2 28080.9 20:18:10 INFO - 2015-12-18 20:18:10,409 DEBUG : BROWSER_OUTPUT: 20:18:10 INFO - 2015-12-18 20:18:10,409 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28057.23 Median:24870.21 stddev:89056.29 (358.1%) stddev-sans-first:89281.83 20:18:10 INFO - 2015-12-18 20:18:10,409 DEBUG : BROWSER_OUTPUT: Values: 361.2 362.4 363.8 365.4 367.7 17033.5 17378.0 17518.0 18121.3 18122.0 11089.4 11164.1 11189.5 12270.0 15001.2 5062.8 5065.5 5147.3 5148.7 5176.9 5089.1 5094.8 5096.7 5103.9 5126.9 3627.8 3775.4 5059.5 5090.8 5104.8 5159.2 5308.3 5320.1 5340.5 5350.1 5102.2 5142.1 5148.9 5218.3 5252.3 11882.8 12051.5 12072.0 12090.2 12645.6 2083.1 2088.2 2136.0 2147.2 2176.7 9720.7 9794.1 9844.6 9922.3 9939.4 1795.3 1838.8 1843.2 1878.5 1917.8 58879.1 59684.0 60162.0 60420.4 60675.4 9984.0 10203.5 10207.5 10278.4 10405.6 13051.0 13209.3 13279.9 13292.4 13457.4 7007.6 7103.3 7150.0 7193.3 7254.9 6955.8 6978.0 6991.8 6998.5 7081.5 4046.1 4109.7 4288.2 4386.1 4463.6 1834.0 1884.9 1896.2 1905.4 1906.4 458.7 458.8 466.5 806.1 848.7 10488.3 10587.4 10736.1 10832.4 11041.9 426.3 430.8 439.2 440.4 444.9 5687.5 5783.3 5818.4 5831.4 5920.7 537715.0 539904.0 540505.0 547632.0 554252.0 79454.0 79747.2 82399.0 82933.0 83291.2 471.0 482.8 484.0 486.4 487.8 9529.6 9617.0 9639.5 9783.3 9866.2 33461.8 33703.5 33903.0 34035.5 34493.1 45276.8 46406.0 46554.0 47162.3 47562.0 9294.8 9332.2 9498.3 9522.5 9552.7 12714.4 17133.8 17343.3 17498.6 17705.8 11295.2 14168.9 14496.5 14749.5 14924.0 12876.7 13550.4 13579.9 13932.3 14229.6 13749.1 13921.5 13924.9 14463.8 14505.4 9315.6 9443.8 9462.4 9488.2 9520.2 13846.3 13860.2 14213.7 14301.9 14386.6 20:18:10 INFO - 2015-12-18 20:18:10,409 DEBUG : BROWSER_OUTPUT: 20:18:10 INFO - 2015-12-18 20:18:10,409 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5185.96 Median:6320.71 stddev:2641.23 (41.8%) stddev-sans-first:2633.01 20:18:10 INFO - 2015-12-18 20:18:10,410 DEBUG : BROWSER_OUTPUT: Values: 1363.8 1378.2 1409.6 1574.8 1585.5 7251.1 7290.5 7413.5 7497.4 7521.4 7387.8 7408.9 7421.5 7438.6 7448.1 2202.0 2246.9 2250.3 2251.5 2260.0 2251.8 2252.2 2256.4 2266.7 2310.6 2138.4 2143.3 2151.1 2208.7 2213.5 2214.6 2220.6 2234.1 2252.9 2254.5 2262.8 2278.2 2286.6 2288.7 2299.1 7260.5 7323.6 7324.8 7374.1 7410.9 4503.1 4553.2 4571.4 4584.3 4589.2 2956.4 2984.3 3011.6 3029.1 3057.6 942.8 967.4 976.3 987.3 1020.6 9921.2 9942.2 9991.0 9997.0 10019.6 3948.3 4060.7 4073.7 4116.6 4152.6 8084.7 8115.0 8123.6 8137.6 8159.5 4508.3 4549.5 4553.9 4563.1 4606.3 4161.6 4172.4 4211.1 4246.8 4277.6 3418.3 3442.9 3454.8 3467.8 3472.8 1031.8 1033.0 1033.2 1047.0 1049.1 942.9 944.2 1015.3 1029.9 1259.2 6981.1 6981.2 7008.7 7059.6 7089.2 1028.4 1034.6 1046.5 1059.3 1067.5 5560.4 5578.4 5599.1 5616.3 5644.1 8677.1 8716.9 8939.9 8995.8 9043.4 8795.9 8878.2 8881.6 8888.6 8935.6 6532.7 6621.2 6643.6 6673.3 6690.3 6983.8 6999.8 7063.6 7075.6 7088.8 7886.8 7933.5 8035.0 8059.0 8113.2 8012.1 8099.9 8200.7 8201.7 8269.0 6420.9 6423.3 6457.1 6542.7 6594.0 7127.1 7128.6 7191.7 7224.8 7228.3 5770.5 6563.8 6607.7 6651.8 6906.1 6514.2 6589.2 6623.7 6635.4 6758.9 6340.3 6430.1 6467.7 6588.6 6605.8 6047.5 6063.8 6096.0 6099.8 6104.0 6126.5 6234.2 6270.0 6295.8 6301.1 20:18:10 INFO - 2015-12-18 20:18:10,410 DEBUG : BROWSER_OUTPUT: 20:18:10 INFO - 2015-12-18 20:18:10,410 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5583.85 Median:6325.53 stddev:1701.79 (26.9%) stddev-sans-first:1660.37 20:18:10 INFO - 2015-12-18 20:18:10,411 DEBUG : BROWSER_OUTPUT: Values: 336.4 339.2 342.9 351.3 351.9 6321.7 6324.2 6378.7 6415.4 6527.6 6274.0 6326.8 6348.3 6354.7 6358.0 4799.9 4802.6 4805.2 4814.8 4826.5 4790.4 4797.5 4799.0 4802.8 4805.1 4661.6 4744.5 4764.4 4772.7 4781.4 4706.4 4714.1 4748.2 4752.6 4756.6 4082.7 4113.9 4133.4 4139.8 4146.5 6004.1 6021.1 6028.5 6034.5 6082.3 5428.8 5511.1 5515.3 5539.0 5544.5 6643.4 6656.3 6688.8 6699.7 6724.1 4522.2 4527.6 4563.5 4569.6 4593.9 6704.3 6768.5 6831.4 6898.1 6909.1 4665.2 4699.8 4701.8 4708.4 4710.1 4690.6 4768.7 4770.4 4780.7 4786.3 5503.8 5511.5 5512.7 5531.2 5531.8 6551.8 6626.6 6664.6 6706.5 6720.2 1641.7 1658.7 1684.9 1687.0 1697.6 1087.4 1090.3 1094.7 1099.5 1102.5 6246.4 6273.2 6308.3 6319.3 6340.8 6760.8 6788.9 6855.2 6878.2 6896.7 6156.3 6286.7 6311.4 6314.0 6329.6 3695.7 3736.4 3737.6 3749.6 3765.0 6982.5 7017.2 7023.9 7030.4 7057.9 6991.3 7004.3 7046.8 7058.3 7073.0 7149.8 7170.5 7173.5 7204.1 7225.9 6963.5 6964.3 6977.7 7007.4 7057.3 6821.4 6876.1 6878.6 6878.7 6922.7 7163.1 7174.1 7176.8 7187.2 7199.5 4669.4 4701.8 4709.4 4716.2 4737.0 6873.8 6983.7 6995.6 7024.6 7048.1 6751.2 6787.0 6793.5 6796.4 6805.5 6710.1 6742.7 6749.9 6771.8 6784.5 6535.9 6622.5 6647.3 6653.2 6668.9 6735.7 6764.5 6770.1 6819.2 6838.2 6629.2 6650.8 6651.9 6661.9 6673.7 20:18:10 INFO - 2015-12-18 20:18:10,411 DEBUG : BROWSER_OUTPUT: 20:18:10 INFO - 2015-12-18 20:18:10,411 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13101.10 Median:44509.50 stddev:14746.51 (33.1%) stddev-sans-first:14758.64 20:18:10 INFO - 2015-12-18 20:18:10,411 DEBUG : BROWSER_OUTPUT: Values: 735.6 773.5 786.7 809.1 856.0 13771.3 14026.7 14081.6 14125.1 14132.4 13658.2 14078.4 14103.1 14109.5 14134.6 805.6 824.2 836.9 843.7 845.6 820.1 828.7 830.7 831.1 832.9 866.5 867.4 868.6 874.1 875.8 862.4 864.3 868.0 868.4 870.2 631.6 636.0 636.7 636.9 637.6 13704.0 13728.2 13779.2 13787.2 13896.3 11239.7 11416.4 11518.1 11753.1 11783.3 10057.0 10111.9 10122.7 10233.5 10361.7 3478.8 3512.7 3544.4 3571.9 3598.7 44152.1 44500.0 44519.0 44623.1 44643.8 8814.5 9066.6 9194.0 9229.1 9276.6 16692.8 16889.2 16914.5 16946.7 16953.6 6514.7 6842.0 7276.5 7330.7 7463.8 4099.1 4102.4 4156.8 4215.6 4259.8 2887.5 2903.7 2940.8 2944.5 2955.3 584.7 591.7 596.5 612.4 616.3 553.9 608.9 655.4 657.7 662.0 8579.4 8880.5 9277.8 9361.7 9451.8 641.4 678.6 684.2 688.9 690.6 3713.5 4085.2 4125.7 4288.4 4340.8 50673.2 51358.2 51823.7 51964.0 52092.2 47509.5 47899.5 48037.8 48628.0 48960.5 44134.0 44199.1 44216.6 44707.0 45024.3 8195.4 8344.8 8418.7 8520.7 8649.7 32069.2 32482.5 32680.8 32781.7 32890.5 39875.6 41482.0 41892.8 42609.1 42753.4 10347.1 10466.2 10763.4 11043.3 11415.3 11515.3 11562.3 11687.4 11987.3 12597.9 10143.6 10195.2 10302.2 10439.9 11059.3 10200.0 10521.2 10599.7 10747.8 10786.1 10433.7 10741.9 10748.8 10761.6 10782.6 9585.3 9663.6 9877.3 9936.7 10070.7 8372.1 8540.0 8556.3 9030.2 9360.8 20:18:10 INFO - 2015-12-18 20:18:10,411 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:18:10 INFO - 2015-12-18 20:18:10,411 DEBUG : BROWSER_OUTPUT: 20:18:11 INFO - 2015-12-18 20:18:11,096 INFO : Browser exited with error code: 0 20:18:11 INFO - 2015-12-18 20:18:11,117 INFO : Completed test dromaeo_css (00:18:31) 20:18:11 INFO - 2015-12-18 20:18:11,117 INFO : Starting test kraken 20:18:11 INFO - 2015-12-18 20:18:11,117 DEBUG : operating with platform_type : linux_ 20:18:11 INFO - 2015-12-18 20:18:11,118 INFO : Initialising browser for kraken test... 20:18:11 INFO - 2015-12-18 20:18:11,123 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb_P0PY/profile http://localhost:34369/getInfo.html 20:18:15 INFO - 2015-12-18 20:18:15,507 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:18:15 INFO - 2015-12-18 20:18:15,507 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:18:15 INFO - 2015-12-18 20:18:15,507 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:18:15 INFO - 2015-12-18 20:18:15,507 DEBUG : BROWSER_OUTPUT: __metrics 20:18:15 INFO - 2015-12-18 20:18:15,615 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:16 INFO - 2015-12-18 20:18:16,540 INFO : Browser initialized. 20:18:16 INFO - 2015-12-18 20:18:16,541 INFO : Running cycle 1/1 for kraken test... 20:18:16 INFO - 2015-12-18 20:18:16,541 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb_P0PY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:18:28 INFO - 2015-12-18 20:18:28,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 151465984 20:18:28 INFO - 2015-12-18 20:18:28,321 DEBUG : BROWSER_OUTPUT: 20:18:30 INFO - 2015-12-18 20:18:30,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34369/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:31 INFO - 2015-12-18 20:18:31,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 152309760 20:18:31 INFO - 2015-12-18 20:18:31,431 DEBUG : BROWSER_OUTPUT: 20:18:34 INFO - 2015-12-18 20:18:34,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34369/tests/kraken/driver.html?testName=audio-dft) 20:18:34 INFO - 2015-12-18 20:18:34,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 151498752 20:18:34 INFO - 2015-12-18 20:18:34,690 DEBUG : BROWSER_OUTPUT: 20:18:37 INFO - 2015-12-18 20:18:37,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34369/tests/kraken/driver.html?testName=audio-fft) 20:18:38 INFO - 2015-12-18 20:18:38,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 146849792 20:18:38 INFO - 2015-12-18 20:18:38,151 DEBUG : BROWSER_OUTPUT: 20:18:40 INFO - 2015-12-18 20:18:40,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34369/tests/kraken/driver.html?testName=audio-oscillator) 20:18:40 INFO - 2015-12-18 20:18:40,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 146505728 20:18:40 INFO - 2015-12-18 20:18:40,995 DEBUG : BROWSER_OUTPUT: 20:18:43 INFO - 2015-12-18 20:18:43,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:43 INFO - 2015-12-18 20:18:43,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 145600512 20:18:43 INFO - 2015-12-18 20:18:43,818 DEBUG : BROWSER_OUTPUT: 20:18:46 INFO - 2015-12-18 20:18:46,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34369/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:47 INFO - 2015-12-18 20:18:47,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 146653184 20:18:47 INFO - 2015-12-18 20:18:47,365 DEBUG : BROWSER_OUTPUT: 20:18:50 INFO - 2015-12-18 20:18:50,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34369/tests/kraken/driver.html?testName=imaging-desaturate) 20:18:51 INFO - 2015-12-18 20:18:51,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 147955712 20:18:51 INFO - 2015-12-18 20:18:51,334 DEBUG : BROWSER_OUTPUT: 20:18:54 INFO - 2015-12-18 20:18:54,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34369/tests/kraken/driver.html?testName=json-parse-financial) 20:18:54 INFO - 2015-12-18 20:18:54,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 147988480 20:18:54 INFO - 2015-12-18 20:18:54,766 DEBUG : BROWSER_OUTPUT: 20:18:56 INFO - 2015-12-18 20:18:56,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:18:56 INFO - 2015-12-18 20:18:56,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 148758528 20:18:56 INFO - 2015-12-18 20:18:56,942 DEBUG : BROWSER_OUTPUT: 20:18:58 INFO - 2015-12-18 20:18:58,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:18:59 INFO - 2015-12-18 20:18:59,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 148000768 20:18:59 INFO - 2015-12-18 20:18:59,383 DEBUG : BROWSER_OUTPUT: 20:19:01 INFO - 2015-12-18 20:19:01,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:02 INFO - 2015-12-18 20:19:02,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 148000768 20:19:02 INFO - 2015-12-18 20:19:02,110 DEBUG : BROWSER_OUTPUT: 20:19:04 INFO - 2015-12-18 20:19:04,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:05 INFO - 2015-12-18 20:19:05,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 148709376 20:19:05 INFO - 2015-12-18 20:19:05,180 DEBUG : BROWSER_OUTPUT: 20:19:07 INFO - 2015-12-18 20:19:07,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:08 INFO - 2015-12-18 20:19:08,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 147734528 20:19:08 INFO - 2015-12-18 20:19:08,389 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34369/tests/kraken/driver.html?testName=ai-astar) 20:19:10 INFO - 2015-12-18 20:19:10,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 148348928 20:19:10 INFO - 2015-12-18 20:19:10,356 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,358 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:19:10 INFO - 2015-12-18 20:19:10,359 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:19:10 INFO - 2015-12-18 20:19:10,359 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:19:10 INFO - 2015-12-18 20:19:10,359 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:19:10 INFO - 2015-12-18 20:19:10,360 DEBUG : BROWSER_OUTPUT: |0;ai-astar;117;108;114;116;112;124;112;113;111;112 20:19:10 INFO - 2015-12-18 20:19:10,360 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;126;152;168;126;152;153;130;167;127 20:19:10 INFO - 2015-12-18 20:19:10,360 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;165;163;161;164;163;168;169;163 20:19:10 INFO - 2015-12-18 20:19:10,360 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;73;71;73;73;73;140;72;73;72 20:19:10 INFO - 2015-12-18 20:19:10,361 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;94;144;93;95;94;136;95;95;135 20:19:10 INFO - 2015-12-18 20:19:10,361 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;117;110;111;111;112;111;110;111 20:19:10 INFO - 2015-12-18 20:19:10,361 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;146;147;146;147;154;147;146 20:19:10 INFO - 2015-12-18 20:19:10,361 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;96;97;97;97;98;96;97;96 20:19:10 INFO - 2015-12-18 20:19:10,361 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;62;60;62;60;60;62;61;58;61 20:19:10 INFO - 2015-12-18 20:19:10,361 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;71;68;68;68;69;78;69;68;69 20:19:10 INFO - 2015-12-18 20:19:10,361 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;87;87;103;84;90;86;87;88 20:19:10 INFO - 2015-12-18 20:19:10,362 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;119;127;117;122;122;117;132;118;126 20:19:10 INFO - 2015-12-18 20:19:10,362 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;153;159;151;156;147;152;149;159;141 20:19:10 INFO - 2015-12-18 20:19:10,362 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;74;70;69;72;68;66;67;69;75 20:19:10 INFO - 2015-12-18 20:19:10,362 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:19:10 INFO - 2015-12-18 20:19:10,362 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:19:10 INFO - 2015-12-18 20:19:10,362 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,739 20:19:10 INFO - 2015-12-18 20:19:10,362 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:19:10 INFO - 2015-12-18 20:19:10,363 DEBUG : BROWSER_OUTPUT: __startTimestamp1450498750357__endTimestamp 20:19:10 INFO - 2015-12-18 20:19:10,363 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,366 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:19:10 INFO - 2015-12-18 20:19:10,366 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:19:10 INFO - 2015-12-18 20:19:10,367 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,367 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.90 Median:113.50 stddev:4.36 (3.8%) stddev-sans-first:4.48 20:19:10 INFO - 2015-12-18 20:19:10,367 DEBUG : BROWSER_OUTPUT: Values: 117.0 108.0 114.0 116.0 112.0 124.0 112.0 113.0 111.0 112.0 20:19:10 INFO - 2015-12-18 20:19:10,367 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,367 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.50 Median:152.50 stddev:16.75 (11.0%) stddev-sans-first:17.48 20:19:10 INFO - 2015-12-18 20:19:10,367 DEBUG : BROWSER_OUTPUT: Values: 154.0 126.0 152.0 168.0 126.0 152.0 153.0 130.0 167.0 127.0 20:19:10 INFO - 2015-12-18 20:19:10,368 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,368 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:2.56 (1.6%) stddev-sans-first:2.60 20:19:10 INFO - 2015-12-18 20:19:10,368 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 165.0 163.0 161.0 164.0 163.0 168.0 169.0 163.0 20:19:10 INFO - 2015-12-18 20:19:10,368 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,368 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:73.00 stddev:21.28 (29.2%) stddev-sans-first:22.51 20:19:10 INFO - 2015-12-18 20:19:10,368 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 71.0 73.0 73.0 73.0 140.0 72.0 73.0 72.0 20:19:10 INFO - 2015-12-18 20:19:10,368 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,368 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.80 Median:94.50 stddev:21.22 (22.5%) stddev-sans-first:22.15 20:19:10 INFO - 2015-12-18 20:19:10,368 DEBUG : BROWSER_OUTPUT: Values: 97.0 94.0 144.0 93.0 95.0 94.0 136.0 95.0 95.0 135.0 20:19:10 INFO - 2015-12-18 20:19:10,368 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,369 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:111.30 Median:111.00 stddev:2.11 (1.9%) stddev-sans-first:2.19 20:19:10 INFO - 2015-12-18 20:19:10,369 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 117.0 110.0 111.0 111.0 112.0 111.0 110.0 111.0 20:19:10 INFO - 2015-12-18 20:19:10,369 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,369 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:2.41 (1.6%) stddev-sans-first:2.55 20:19:10 INFO - 2015-12-18 20:19:10,369 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 146.0 147.0 146.0 147.0 154.0 147.0 146.0 20:19:10 INFO - 2015-12-18 20:19:10,369 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,369 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 20:19:10 INFO - 2015-12-18 20:19:10,369 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 96.0 97.0 97.0 97.0 98.0 96.0 97.0 96.0 20:19:10 INFO - 2015-12-18 20:19:10,369 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,369 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.70 Median:61.00 stddev:1.25 (2.1%) stddev-sans-first:1.32 20:19:10 INFO - 2015-12-18 20:19:10,369 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 60.0 62.0 60.0 60.0 62.0 61.0 58.0 61.0 20:19:10 INFO - 2015-12-18 20:19:10,370 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,370 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.00 stddev:3.17 (4.6%) stddev-sans-first:3.23 20:19:10 INFO - 2015-12-18 20:19:10,370 DEBUG : BROWSER_OUTPUT: Values: 67.0 71.0 68.0 68.0 68.0 69.0 78.0 69.0 68.0 69.0 20:19:10 INFO - 2015-12-18 20:19:10,370 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,370 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:87.00 stddev:5.42 (6.2%) stddev-sans-first:5.61 20:19:10 INFO - 2015-12-18 20:19:10,370 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 87.0 87.0 103.0 84.0 90.0 86.0 87.0 88.0 20:19:10 INFO - 2015-12-18 20:19:10,370 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,370 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:122.00 stddev:5.07 (4.2%) stddev-sans-first:5.19 20:19:10 INFO - 2015-12-18 20:19:10,370 DEBUG : BROWSER_OUTPUT: Values: 118.0 119.0 127.0 117.0 122.0 122.0 117.0 132.0 118.0 126.0 20:19:10 INFO - 2015-12-18 20:19:10,370 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,371 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:152.50 stddev:6.31 (4.1%) stddev-sans-first:5.82 20:19:10 INFO - 2015-12-18 20:19:10,372 DEBUG : BROWSER_OUTPUT: Values: 142.0 153.0 159.0 151.0 156.0 147.0 152.0 149.0 159.0 141.0 20:19:10 INFO - 2015-12-18 20:19:10,372 DEBUG : BROWSER_OUTPUT: 20:19:10 INFO - 2015-12-18 20:19:10,372 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.50 stddev:2.92 (4.2%) stddev-sans-first:3.08 20:19:10 INFO - 2015-12-18 20:19:10,372 DEBUG : BROWSER_OUTPUT: Values: 69.0 74.0 70.0 69.0 72.0 68.0 66.0 67.0 69.0 75.0 20:19:10 INFO - 2015-12-18 20:19:10,372 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:19:10 INFO - 2015-12-18 20:19:10,372 DEBUG : BROWSER_OUTPUT: 20:19:11 INFO - 2015-12-18 20:19:11,248 INFO : Browser exited with error code: 0 20:19:11 INFO - 2015-12-18 20:19:11,298 INFO : Completed test kraken (00:01:00) 20:19:11 INFO - 2015-12-18 20:19:11,298 INFO : Starting test v8_7 20:19:11 INFO - 2015-12-18 20:19:11,298 DEBUG : operating with platform_type : linux_ 20:19:11 INFO - 2015-12-18 20:19:11,298 INFO : Initialising browser for v8_7 test... 20:19:11 INFO - 2015-12-18 20:19:11,304 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNfc0tB/profile http://localhost:34369/getInfo.html 20:19:15 INFO - 2015-12-18 20:19:15,720 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:19:15 INFO - 2015-12-18 20:19:15,721 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:19:15 INFO - 2015-12-18 20:19:15,721 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:19:15 INFO - 2015-12-18 20:19:15,721 DEBUG : BROWSER_OUTPUT: __metrics 20:19:15 INFO - 2015-12-18 20:19:15,846 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:16 INFO - 2015-12-18 20:19:16,712 INFO : Browser initialized. 20:19:16 INFO - 2015-12-18 20:19:16,713 INFO : Running cycle 1/1 for v8_7 test... 20:19:16 INFO - 2015-12-18 20:19:16,713 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNfc0tB/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:28 INFO - 2015-12-18 20:19:28,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 150982656 20:19:28 INFO - 2015-12-18 20:19:28,537 DEBUG : BROWSER_OUTPUT: 20:19:49 INFO - 2015-12-18 20:19:49,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34369/tests/v8_7/run.html (next: http://localhost:34369/tests/v8_7/run.html) 20:19:50 INFO - 2015-12-18 20:19:50,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 146788352 20:19:50 INFO - 2015-12-18 20:19:50,214 DEBUG : BROWSER_OUTPUT: 20:19:50 INFO - 2015-12-18 20:19:50,215 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:19:50 INFO - 2015-12-18 20:19:50,215 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:19:50 INFO - 2015-12-18 20:19:50,215 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:19:50 INFO - 2015-12-18 20:19:50,215 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:19:50 INFO - 2015-12-18 20:19:50,215 DEBUG : BROWSER_OUTPUT: |0;Richards;167.58840288252054 20:19:50 INFO - 2015-12-18 20:19:50,215 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.79342723004694 20:19:50 INFO - 2015-12-18 20:19:50,215 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.2690582959641 20:19:50 INFO - 2015-12-18 20:19:50,216 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 20:19:50 INFO - 2015-12-18 20:19:50,216 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1074.1138560687432 20:19:50 INFO - 2015-12-18 20:19:50,216 DEBUG : BROWSER_OUTPUT: |5;Earley;711.2375533428165 20:19:50 INFO - 2015-12-18 20:19:50,216 DEBUG : BROWSER_OUTPUT: |6;Boyer;12168.674698795181 20:19:50 INFO - 2015-12-18 20:19:50,216 DEBUG : BROWSER_OUTPUT: |7;RegExp;25250 20:19:50 INFO - 2015-12-18 20:19:50,217 DEBUG : BROWSER_OUTPUT: |8;Splay;564.0157924421884 20:19:50 INFO - 2015-12-18 20:19:50,217 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 20:19:50 INFO - 2015-12-18 20:19:50,217 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:19:50 INFO - 2015-12-18 20:19:50,217 DEBUG : BROWSER_OUTPUT: __startTimestamp1450498790213__endTimestamp 20:19:50 INFO - 2015-12-18 20:19:50,217 DEBUG : BROWSER_OUTPUT: 20:19:50 INFO - 2015-12-18 20:19:50,217 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:19:50 INFO - 2015-12-18 20:19:50,218 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:19:50 INFO - 2015-12-18 20:19:50,218 DEBUG : BROWSER_OUTPUT: 20:19:50 INFO - 2015-12-18 20:19:50,218 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.59 Median:167.59 stddev:0.00 (0.0%) 20:19:50 INFO - 2015-12-18 20:19:50,218 DEBUG : BROWSER_OUTPUT: Values: 167.6 20:19:50 INFO - 2015-12-18 20:19:50,218 DEBUG : BROWSER_OUTPUT: 20:19:50 INFO - 2015-12-18 20:19:50,218 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.79 Median:187.79 stddev:0.00 (0.0%) 20:19:50 INFO - 2015-12-18 20:19:50,219 DEBUG : BROWSER_OUTPUT: Values: 187.8 20:19:50 INFO - 2015-12-18 20:19:50,219 DEBUG : BROWSER_OUTPUT: 20:19:50 INFO - 2015-12-18 20:19:50,219 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 20:19:50 INFO - 2015-12-18 20:19:50,219 DEBUG : BROWSER_OUTPUT: Values: 280.3 20:19:50 INFO - 2015-12-18 20:19:50,220 DEBUG : BROWSER_OUTPUT: 20:19:50 INFO - 2015-12-18 20:19:50,220 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 20:19:50 INFO - 2015-12-18 20:19:50,220 DEBUG : BROWSER_OUTPUT: Values: 5196.9 20:19:50 INFO - 2015-12-18 20:19:50,220 DEBUG : BROWSER_OUTPUT: 20:19:50 INFO - 2015-12-18 20:19:50,220 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1074.11 Median:1074.11 stddev:0.00 (0.0%) 20:19:50 INFO - 2015-12-18 20:19:50,220 DEBUG : BROWSER_OUTPUT: Values: 1074.1 20:19:50 INFO - 2015-12-18 20:19:50,220 DEBUG : BROWSER_OUTPUT: 20:19:50 INFO - 2015-12-18 20:19:50,220 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:711.24 Median:711.24 stddev:0.00 (0.0%) 20:19:50 INFO - 2015-12-18 20:19:50,220 DEBUG : BROWSER_OUTPUT: Values: 711.2 20:19:50 INFO - 2015-12-18 20:19:50,220 DEBUG : BROWSER_OUTPUT: 20:19:50 INFO - 2015-12-18 20:19:50,221 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12168.67 Median:12168.67 stddev:0.00 (0.0%) 20:19:50 INFO - 2015-12-18 20:19:50,221 DEBUG : BROWSER_OUTPUT: Values: 12168.7 20:19:50 INFO - 2015-12-18 20:19:50,221 DEBUG : BROWSER_OUTPUT: 20:19:50 INFO - 2015-12-18 20:19:50,221 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25250.00 Median:25250.00 stddev:0.00 (0.0%) 20:19:50 INFO - 2015-12-18 20:19:50,221 DEBUG : BROWSER_OUTPUT: Values: 25250.0 20:19:50 INFO - 2015-12-18 20:19:50,221 DEBUG : BROWSER_OUTPUT: 20:19:50 INFO - 2015-12-18 20:19:50,221 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:564.02 Median:564.02 stddev:0.00 (0.0%) 20:19:50 INFO - 2015-12-18 20:19:50,221 DEBUG : BROWSER_OUTPUT: Values: 564.0 20:19:50 INFO - 2015-12-18 20:19:50,221 DEBUG : BROWSER_OUTPUT: 20:19:50 INFO - 2015-12-18 20:19:50,221 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 20:19:50 INFO - 2015-12-18 20:19:50,221 DEBUG : BROWSER_OUTPUT: Values: 4845.4 20:19:50 INFO - 2015-12-18 20:19:50,221 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:19:50 INFO - 2015-12-18 20:19:50,222 DEBUG : BROWSER_OUTPUT: 20:19:51 INFO - 2015-12-18 20:19:51,087 INFO : Browser exited with error code: 0 20:19:51 INFO - 2015-12-18 20:19:51,100 INFO : Completed test v8_7 (00:00:39) 20:19:51 INFO - 2015-12-18 20:19:51,227 INFO : Completed test suite (00:20:11) 20:19:51 INFO - 2015-12-18 20:19:51,227 DEBUG : Working with test: dromaeo_css 20:19:51 INFO - 2015-12-18 20:19:51,227 DEBUG : Generating results file: dromaeo_css 20:19:51 INFO - 2015-12-18 20:19:51,228 DEBUG : Working with test: kraken 20:19:51 INFO - 2015-12-18 20:19:51,229 DEBUG : Generating results file: kraken 20:19:51 INFO - 2015-12-18 20:19:51,229 INFO : javascript benchmark 20:19:51 INFO - 2015-12-18 20:19:51,229 DEBUG : Working with test: v8_7 20:19:51 INFO - 2015-12-18 20:19:51,229 DEBUG : Generating results file: v8_7 20:19:51 INFO - 2015-12-18 20:19:51,230 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:51 INFO - 2015-12-18 20:19:51,284 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:19:51 INFO - 2015-12-18 20:19:51,284 DEBUG : process_Request line: dromaeo_css 6869.70 graph.html#tests=[[72,64,43]] 20:19:51 INFO - 2015-12-18 20:19:51,285 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:51 INFO - 2015-12-18 20:19:51,328 DEBUG : process_Request line: kraken 1527.30 graph.html#tests=[[232,64,43]] 20:19:51 INFO - 2015-12-18 20:19:51,328 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:51 INFO - 2015-12-18 20:19:51,360 DEBUG : process_Request line: v8_7 21508.52 graph.html#tests=[[230,64,43]] 20:19:51 INFO - 2015-12-18 20:19:51,361 INFO : javascript benchmark 20:19:51 INFO - 2015-12-18 20:19:51,365 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3206.4228438881, 3243.578334816472, 3250.7236884864787, 3277.0824169232615, 3300.2739397332593, 5418.024755544, 5489.91765123523, 5514.91727624086, 5523.1163013917785, 5543.6396634218745, 5383.515483606475, 5397.784088636459, 5415.539679127279, 5447.863803404917, 5511.917321240175, 4696.788644510988, 4955.529224723655, 5160.716160611165, 5176.223566465042, 5177.741112944338, 4829.806807727687, 5119.206522988943, 5122.92315615266, 5127.846164615067, 5162.896742065156, 4896.608271338302, 4931.186354251544, 5052.292679024939, 5070.873228169288, 5104.719240441774, 5077.949220507821, 5079.771410286546, 5081.161608334621, 5097.515736005073, 5123.385193776733, 4819.59033482151, 5029.471905449948, 5065.0, 5079.492050794928, 5122.436531981479, 5230.241614965847, 5343.251944727741, 5344.652597581145, 5355.758990845421, 5394.109971854639, 5866.911996320058, 5908.4386983236955, 5928.170056192136, 5957.136215248808, 6014.3985601439945, 5984.431479009487, 6008.909866352008, 6018.886505996405, 6020.668863212565, 6032.487238584726, 5553.416891226403, 5559.305086864142, 5570.0, 5575.386707462176, 5615.719214039323, 5902.940970590325, 5917.644941303535, 5944.197533332945, 5954.255718035246, 5995.2206213192, 5725.799597014085, 5774.624649397776, 5842.561807864342, 5860.912086318709, 5867.973104706744, 5858.736356863951, 5867.941320586825, 5869.354371019184, 5931.317898441648, 5942.0, 5797.768089276382, 5937.0, 5966.552508561876, 5973.0, 5995.0, 6063.363346848518, 6064.302605200371, 6065.059915712984, 6090.116933044772, 6091.390860913962, 4435.556444355539, 4522.118186953512, 4612.100640375094, 4618.284165954283, 4623.606993405599, 4001.7198796083994, 4017.718759686794, 4035.6771458283265, 4048.8865561970692, 4102.0360215349365, 5561.165825126263, 5599.132134519156, 5599.80400685974, 5646.491815736604, 5669.914951275734, 5891.705414729332, 6007.128966299862, 6025.457708806229, 6029.939700602938, 6087.604305720114, 5634.126710359901, 5640.85897852557, 5685.545156387479, 5698.515626171739, 5701.743421546041, 5128.1794912813775, 5144.742762861842, 5163.7676304566385, 5229.790808367623, 5252.632315737862, 5835.4748072673665, 5925.970370148121, 5946.197263369476, 5951.226340575698, 6127.325994140641, 5968.820935371946, 6055.939440605537, 6062.454379105901, 6088.117223002729, 6100.694965251809, 6114.48026917717, 6166.136740856374, 6175.876482470415, 6205.88294107065, 6215.409536094064, 5795.94204057954, 5847.093700476433, 5926.703664816828, 5991.940080599138, 6011.0382338825575, 5992.940070599238, 6074.088886667036, 6083.452489275986, 6122.938770612237, 6134.0, 5881.735321910439, 5888.293404791281, 5927.318358388668, 5934.525237981037, 5975.342712301556, 5749.425057494384, 5802.0, 5852.502537284378, 5870.589058765845, 5886.882262354643, 5807.983602869396, 5820.097884827858, 5828.417158284137, 5833.504152147115, 5833.7666493341485, 5889.440503152194, 5904.380040095728, 5943.108533719804, 5943.138244954544, 5960.5231581474245, 5483.890322193613, 5623.8594035149445, 5707.914381284367, 5830.737616807169, 5830.941690583039], "unit": "score", "name": "dojo.html", "value": 5484.753183239546}, {"lowerIsBetter": false, "replicates": [559.3707079535523, 586.4633860018083, 598.6856900127435, 604.879024195161, 608.2245137449751, 37909.0, 38501.22997540048, 38836.80581597092, 39172.41241381374, 39230.21539569207, 40915.545067295905, 41892.16215675684, 41916.95207619811, 42036.0, 42055.15889682212, 8584.098669639692, 8681.782955426102, 8714.128587141267, 8767.868481972775, 8770.824583508325, 8671.393002489796, 8747.256483198937, 8759.562021898879, 8761.342899282547, 8770.254528365065, 8705.477671339708, 8717.738467845944, 8790.077041910603, 8793.824123517526, 8845.601947912328, 8691.782705432382, 8703.129687031309, 8708.0, 8748.518831464267, 8754.56227188638, 8626.698065567674, 8690.348223883171, 8695.956520217422, 8710.47737135774, 8715.956420217923, 39489.0, 39930.80034599808, 39931.00344982768, 40075.19849603021, 40143.598564014574, 3196.4566023776015, 3231.062991732395, 3326.2017115892254, 3546.5034895114704, 3766.322062028834, 29159.271018224503, 29638.110856674335, 30472.54291185634, 30591.235219119477, 31191.844040779877, 3884.6767757382227, 4008.8596899108393, 4025.2553277643437, 4058.8782336529657, 4103.302438585418, 250836.0, 251892.0, 253984.0, 254060.99999999814, 254212.0, 53693.926121478136, 54244.0, 59172.92894748663, 64182.6790866052, 65549.34450655528, 59101.70449147813, 59212.703936480044, 59387.70306148442, 59533.02334883239, 59678.33055859686, 13846.376913038937, 13954.162750235018, 14042.929785351213, 14053.016288859886, 14097.78853317201, 10851.565937362575, 10892.673219803419, 10943.4528273586, 10949.83575246372, 11116.110711143088, 19941.302054428317, 20043.79737215772, 20103.698444523343, 20184.394468165978, 20223.19107235694, 7801.180876008051, 7986.161453047463, 8033.839323213503, 8041.552520546241, 8060.193980601893, 895.7939673874915, 942.566419447062, 950.2682934140673, 969.6993931880999, 997.6083363707733, 27624.0, 27856.0, 28413.715862841105, 28522.42955140927, 28625.42749145047, 982.5087456271864, 987.1855719031828, 994.5723338964315, 1004.7789486313, 1112.6495154026456, 14683.77974330386, 16558.83441165597, 16860.409885653942, 17022.57443563896, 17176.914115429343, 364355.0, 365614.0, 368891.0, 369579.0, 370125.0, 52863.471365285855, 52884.206736898974, 53107.46892531103, 53241.467585324426, 53294.73352633212, 1350.3923234544495, 1357.2806412601337, 1370.4518192722792, 1372.1561239837429, 1376.7590671632424, 28984.710152899046, 29287.0, 29635.407291854473, 30126.0, 30637.54043689391, 44441.0, 44707.0, 44753.77623111994, 44794.55205447904, 45429.54570454253, 281309.0, 283903.0, 284143.0, 284977.0, 285319.0, 32371.676283237808, 42237.57762422459, 42611.57388426076, 42636.14727705491, 42831.3575296377, 40172.1965560693, 41112.38331424971, 41141.0, 41165.382519262836, 41727.791361043, 32446.513302300013, 33012.834935825165, 33162.66837331596, 33228.33543329168, 33384.33231335311, 36488.27023459569, 36602.0, 36718.8164059178, 37496.0, 37632.623673762915, 35525.0, 35951.0, 35972.64027359693, 36077.639223607424, 36287.0, 31103.84448077745, 32862.34275314432, 33185.50221746627, 33304.033401922316, 33333.0, 25235.369115772253, 25742.485150297263, 26095.217143485726, 26269.21192364232, 28080.85959570189], "unit": "score", "name": "ext.html", "value": 18598.66737660258}, {"lowerIsBetter": false, "replicates": [361.19633814762153, 362.3676684186096, 363.8362736768455, 365.3916229477919, 367.72971865678727, 17033.488995330143, 17378.0, 17518.0, 18121.275148994024, 18122.0, 11089.445527723621, 11164.051055660279, 11189.49647265873, 12269.957053650429, 15001.249937503137, 5062.772175252104, 5065.468125846779, 5147.253648221005, 5148.665336753099, 5176.922346164792, 5089.134847075988, 5094.77073531692, 5096.700341412935, 5103.9489605103845, 5126.948730512703, 3627.7823330600118, 3775.3959366501367, 5059.519345662175, 5090.847274581768, 5104.846854594368, 5159.226116082599, 5308.309919710413, 5320.095583750772, 5340.465953404648, 5350.063738845706, 5102.158143906251, 5142.100132476839, 5148.9485105149215, 5218.321618189611, 5252.290940722992, 11882.821757673642, 12051.457684404222, 12072.0, 12090.153689241757, 12645.557405490856, 2083.0938541734395, 2088.1960445228547, 2135.95728085439, 2147.162606583434, 2176.6952626632283, 9720.708378748648, 9794.069563391466, 9844.60621575136, 9922.3054386193, 9939.353941993748, 1795.2818872451123, 1838.7701537307837, 1843.235057451156, 1878.5115869873794, 1917.7890432052463, 58879.116813247834, 59684.0, 60162.0, 60420.39579604236, 60675.393246067855, 9983.950080249553, 10203.540840662188, 10207.489625518694, 10278.406687731576, 10405.583776649, 13050.955923526095, 13209.33953302331, 13279.93360033213, 13292.401841917137, 13457.394417251247, 7007.614581198083, 7103.289671032855, 7149.964250178716, 7193.3166349196745, 7254.854902901912, 6955.756548520778, 6977.965110174417, 6991.755288564876, 6998.510104292651, 7081.468889833283, 4046.089629833264, 4109.732867363671, 4288.18524480354, 4386.078923426053, 4463.642908567307, 1834.0, 1884.8680592358678, 1896.2415033986515, 1905.3997990632906, 1906.3518403742794, 458.71788849857097, 458.79354290569376, 466.5035558489146, 806.1454857850697, 848.6647774129184, 10488.323351802788, 10587.39155120369, 10736.08743256832, 10832.404217768099, 11041.889581104248, 426.2646934038758, 430.834128860391, 439.246691923353, 440.40545263894126, 444.9265871131227, 5687.516561092353, 5783.334916484658, 5818.389069147764, 5831.3877042910735, 5920.674362909996, 537715.0, 539904.0, 540505.0, 547632.0, 554252.0, 79454.02729863484, 79747.20252797514, 82399.0, 82933.0, 83291.16708832956, 471.0226280467974, 482.81894289641383, 483.9758012099381, 486.4017258771731, 487.78537443524027, 9529.61881524759, 9616.95191524038, 9639.518024098626, 9783.315167938175, 9866.161376283097, 33461.832690837364, 33703.494447582816, 33902.98291051272, 34035.4894676585, 34493.13767155841, 45276.77361613171, 46406.0, 46554.0, 47162.29256561086, 47562.0, 9294.767630809283, 9332.20676242527, 9498.287628427757, 9522.52387380642, 9552.713418597454, 12714.427850746924, 17133.82866171322, 17343.306267749147, 17498.562535936704, 17705.822941770417, 11295.152863535432, 14168.858311416754, 14496.492622758575, 14749.483768068067, 14924.0, 12876.742465150832, 13550.390232439368, 13579.86420135786, 13932.30338483092, 14229.573112806218, 13749.106308089942, 13921.512747053805, 13924.860751392356, 14463.78304325457, 14505.419783208976, 9315.6273749052, 9443.811123777623, 9462.384944978554, 9488.240940724587, 9520.190783783455, 13846.307684615931, 13860.168389896638, 14213.715725685222, 14301.856981430052, 14386.568402947929], "unit": "score", "name": "jquery.html", "value": 7778.678656229174}, {"lowerIsBetter": false, "replicates": [1363.8227030486034, 1378.2213049626957, 1409.605310513056, 1574.8425157484246, 1585.508492367367, 7251.129864416271, 7290.489665723401, 7413.481056326066, 7497.4376921730955, 7521.398288136949, 7387.778366648996, 7408.851822963537, 7421.5176013559085, 7438.590877501735, 7448.1434635016985, 2201.9889900550515, 2246.8764217968005, 2250.2686626846257, 2251.538434620899, 2259.954800903981, 2251.808596269319, 2252.1666983216232, 2256.379495638696, 2266.660000999855, 2310.630299152136, 2138.379869837745, 2143.3355659745453, 2151.128792838903, 2208.7349518057777, 2213.524092320151, 2214.557088582274, 2220.578090162864, 2234.0728597631964, 2252.9211477598287, 2254.4927391336983, 2262.7850354216325, 2278.168468508999, 2286.554121946221, 2288.668143119255, 2299.0918587158144, 7260.491765576412, 7323.633818309063, 7324.816879578, 7374.115106187238, 7410.925890741131, 4503.054358584701, 4553.248713962193, 4571.405717256768, 4584.289435137559, 4589.24277494213, 2956.3791603763234, 2984.3035962646577, 3011.578379026938, 3029.106413607991, 3057.617797775278, 942.7737343037691, 967.4243824924159, 976.2580438866513, 987.328616540752, 1020.6223697231998, 9921.206303495703, 9942.154916832078, 9991.0, 9996.950015249877, 10019.649312274109, 3948.348522493814, 4060.6548443382053, 4073.6944729145434, 4116.629503344653, 4152.647025002909, 8084.717034903868, 8115.0, 8123.634436450256, 8137.552434616153, 8159.510429374256, 4508.278675411984, 4549.522300158502, 4553.931691024637, 4563.0873825235085, 4606.309053641913, 4161.625453709181, 4172.436721042681, 4211.052513184509, 4246.787660616957, 4277.59362860534, 3418.29924865402, 3442.915481623331, 3454.775439596418, 3467.8439470223902, 3472.774269672463, 1031.7523794289316, 1032.9876720813495, 1033.2302434686208, 1047.0, 1049.082053203447, 942.8632848237104, 944.1974321826392, 1015.3451024089421, 1029.9237297024627, 1259.1815320042047, 6981.057557229709, 6981.162260528769, 7008.684609192598, 7059.647017649097, 7089.22018577956, 1028.4395004722444, 1034.6016783538391, 1046.4767616191905, 1059.2691043180182, 1067.4876059491487, 5560.388357280696, 5578.41426650204, 5599.1321345190745, 5616.2698849150165, 5644.096944488944, 8677.132286771399, 8716.869246961302, 8939.865902011476, 8995.820083598423, 9043.412178208395, 8795.91204087951, 8878.200961913459, 8881.555922203865, 8888.555572221363, 8935.642574296955, 6532.706028228741, 6621.238557565845, 6643.634600096944, 6673.265940746514, 6690.330966903368, 6983.790486285419, 6999.825004374931, 7063.611501367474, 7075.610841403773, 7088.751893683696, 7886.802829929297, 7933.523988560705, 8035.035795704553, 8059.0, 8113.229243221885, 8012.118666946748, 8099.919000810152, 8200.712975046083, 8201.671933122609, 8268.958655206927, 6420.903686444613, 6423.261324947504, 6457.0637257596445, 6542.672866356568, 6594.043863639841, 7127.073480447716, 7128.643567821485, 7191.748288809867, 7224.783256502314, 7228.27717228294, 5770.538356931519, 6563.835904102436, 6607.735690572324, 6651.800445986628, 6906.102206713095, 6514.185726784152, 6589.17635295588, 6623.6688165592495, 6635.369639884203, 6758.8648227036165, 6340.30256671775, 6430.067640192239, 6467.676616169267, 6588.571742836701, 6605.801825945229, 6047.516198704181, 6063.848403789941, 6096.02463605821, 6099.786507472217, 6103.9694801527485, 6126.540509461897, 6234.189555357774, 6270.0, 6295.811125666238, 6301.117843502005], "unit": "score", "name": "mootools.html", "value": 4274.4624291933615}, {"lowerIsBetter": false, "replicates": [336.4482249111457, 339.2197944727127, 342.85942763466977, 351.3114295979879, 351.9049856538736, 6321.747130114795, 6324.241091069072, 6378.744850205992, 6415.358464153594, 6527.575707579004, 6274.0, 6326.8101956941255, 6348.269948955872, 6354.714037868295, 6358.0, 4799.856004319876, 4802.567768900798, 4805.159097158001, 4814.8314808981695, 4826.49321821209, 4790.449098353682, 4797.488791030814, 4799.040191961604, 4802.807887684488, 4805.087033463648, 4661.557152070548, 4744.454387745402, 4764.356811830393, 4772.713637181763, 4781.3545171401765, 4706.411698537683, 4714.127886341021, 4748.216544270192, 4752.643551733617, 4756.595689366373, 4082.6529744971713, 4113.91772164555, 4133.441985332001, 4139.77231252281, 4146.481689788777, 6004.099385092228, 6021.066734656135, 6028.457438830526, 6034.487068599175, 6082.300535438437, 5428.83713488596, 5511.118221084607, 5515.338159420855, 5539.030669632798, 5544.528715059185, 6643.368879956396, 6656.267810540837, 6688.83277918051, 6699.732010719566, 6724.058631791553, 4522.16339977102, 4527.61515271199, 4563.452385713703, 4569.588737013652, 4593.908121837578, 6704.2625311215725, 6768.52620316578, 6831.419329356961, 6898.103246577913, 6909.1018167638385, 4665.183592871234, 4699.78850951708, 4701.835435759732, 4708.411448568929, 4710.081534100886, 4690.64820138491, 4768.690035147704, 4770.427548694179, 4780.737059461763, 4786.282057691375, 5503.779848806083, 5511.53151982078, 5512.724363781795, 5531.225628411945, 5531.778728850801, 6551.80344589663, 6626.608412233389, 6664.600123992576, 6706.497012724065, 6720.193576770819, 1641.7127002774466, 1658.6848498785191, 1684.9157542122846, 1687.0383881187606, 1697.5671203842942, 1087.4399684162663, 1090.2695194219891, 1094.698957786615, 1099.4502748625687, 1102.4873433853297, 6246.4378205960775, 6273.215848018997, 6308.3060863305, 6319.33646967071, 6340.778072767524, 6760.763373281911, 6788.898166527506, 6855.245922948472, 6878.174619045746, 6896.655167241718, 6156.29202641693, 6286.717097730613, 6311.400416960381, 6314.0, 6329.620222786648, 3695.6858667013603, 3736.4208547675153, 3737.6449237322413, 3749.6250374962287, 3764.9811750941617, 6982.47631427645, 7017.228104908456, 7023.89464158038, 7030.437564994788, 7057.89413158803, 6991.265917078736, 7004.2995700430565, 7046.788596342118, 7058.294170582901, 7073.0, 7149.82125446868, 7170.533915295593, 7173.461990350745, 7204.0994875640545, 7225.8554828903125, 6963.512554121163, 6964.268751781193, 6977.7208911642965, 7007.40437062835, 7057.294270572902, 6821.386075253251, 6876.106106206161, 6878.55289406207, 6878.65606719652, 6922.688479018356, 7163.10461192351, 7174.1032370953635, 7176.820579485555, 7187.1734750504365, 7199.532030418006, 4669.39297891272, 4701.801040734727, 4709.434867815884, 4716.221823399101, 4737.0, 6873.793786186422, 6983.6857341418745, 6995.580265183901, 7024.578525288499, 7048.083749112788, 6751.189857217166, 6786.966065169642, 6793.4565234782085, 6796.388325050571, 6805.489588280998, 6710.094137291599, 6742.730290788313, 6749.86500269982, 6771.830704232433, 6784.457243420613, 6535.934640653532, 6622.536422450382, 6647.3352664735075, 6653.201615806134, 6668.866622667422, 6735.663216839236, 6764.4588432924265, 6770.052192693125, 6819.2498825128205, 6838.213605435439, 6629.171353580802, 6650.800475985729, 6651.866962660622, 6661.900071498834, 6673.699683514156], "unit": "score", "name": "prototype.html", "value": 5024.258787350115}, {"lowerIsBetter": false, "replicates": [735.5733674468809, 773.5165521549031, 786.6971216081811, 809.0695699945062, 855.9957200214005, 13771.31143442829, 14026.719465610682, 14081.647958801022, 14125.081869678464, 14132.434702611909, 13658.248796316198, 14078.366473508691, 14103.08329958552, 14109.506167284148, 14134.64663383416, 805.5891495337377, 824.2169938558363, 836.882836402901, 843.7131375332385, 845.6448291717494, 820.0774129104757, 828.7016673997356, 830.6884918155691, 831.0899564976341, 832.9333653307751, 866.519081909543, 867.4361664917823, 868.635173227243, 874.1433395272605, 875.7635438431652, 862.4394143806513, 864.2524216552699, 868.0494858130337, 868.3921255121409, 870.2211520688979, 631.5673763472037, 636.0364048466577, 636.7357546618148, 636.920384951881, 637.5823835387829, 13704.0, 13728.244946527937, 13779.173249605055, 13787.172769633855, 13896.305184740722, 11239.66281011571, 11416.42917854104, 11518.136139789549, 11753.118516111326, 11783.293002419883, 10057.0, 10111.949440252753, 10122.696319110439, 10233.48832558369, 10361.689149325532, 3478.843452044664, 3512.7365447591533, 3544.3620148373284, 3571.8571257149683, 3598.748087633867, 44152.11695766067, 44500.0, 44519.0, 44623.107537849384, 44643.77678111621, 8814.515201663842, 9066.637334506679, 9194.0, 9229.077092290852, 9276.582553785096, 16692.83307166937, 16889.23998420074, 16914.492565223063, 16946.745798813026, 16953.576160596083, 6514.706838192293, 6841.965790171017, 7276.454265930077, 7330.706771729071, 7463.813404664818, 4099.139180772012, 4102.405151253051, 4156.771377574262, 4215.557151979605, 4259.829606815754, 2887.5235586128056, 2903.738663520251, 2940.779441541893, 2944.4699954008056, 2955.2907302247304, 584.6696616411714, 591.7100620695828, 596.4751019103162, 612.4487960835195, 616.2666426951913, 553.8504603756963, 608.9086637004485, 655.4494224851148, 657.6908852839158, 661.9933800661931, 8579.442336248125, 8880.467171969702, 9277.814443711088, 9361.719148425558, 9451.76370590727, 641.3970867384644, 678.5792808458689, 684.1789852177407, 688.9138857642795, 690.5614934516618, 3713.517242758478, 4085.162541678949, 4125.731827431207, 4288.442502474658, 4340.76125813077, 50673.23990140151, 51358.22962655563, 51823.74088129535, 51964.0, 52092.21861672078, 47509.52490475051, 47899.5210047902, 48037.75981120142, 48628.0, 48960.510394895595, 44134.0, 44199.116017680106, 44216.55783442124, 44707.0, 45024.324635129844, 8195.385346098947, 8344.791380215544, 8418.747437576883, 8520.74437766868, 8649.654013839376, 32069.198270042503, 32482.51276230811, 32680.83659581687, 32781.672183277864, 32890.50664240086, 39875.60124398719, 41482.0, 41892.79053604713, 42609.147817044104, 42753.358699620156, 10347.12049475803, 10466.215033872339, 10763.3541987481, 11043.287174299676, 11415.25800822977, 11515.25150865191, 11562.306261623993, 11687.415629218674, 11987.34069626179, 12597.93701031489, 10143.594256229668, 10195.235357348376, 10302.22733294991, 10439.895601044196, 11059.336439813636, 10200.0, 10521.210909181995, 10599.735006624896, 10747.838782418426, 10786.137109031102, 10433.686989390331, 10741.946290268499, 10748.785024299626, 10761.623343182951, 10782.573920867742, 9585.281103917094, 9663.613455461702, 9877.259205559469, 9936.652217172365, 10070.69787906364, 8372.120927302545, 8540.0, 8556.27271681914, 9030.232430243503, 9360.812783744423], "unit": "score", "name": "yui.html", "value": 6167.223182399982}], "name": "dromaeo_css", "value": 6869.696806899114}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 108.0, 114.0, 116.0, 112.0, 124.0, 112.0, 113.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.9}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 152.0, 168.0, 126.0, 152.0, 153.0, 130.0, 167.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 165.0, 163.0, 161.0, 164.0, 163.0, 168.0, 169.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 71.0, 73.0, 73.0, 73.0, 140.0, 72.0, 73.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [97.0, 94.0, 144.0, 93.0, 95.0, 94.0, 136.0, 95.0, 95.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 117.0, 110.0, 111.0, 111.0, 112.0, 111.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 111.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 154.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 98.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 60.0, 62.0, 60.0, 60.0, 62.0, 61.0, 58.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 60.7}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 68.0, 68.0, 68.0, 69.0, 78.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 87.0, 87.0, 103.0, 84.0, 90.0, 86.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.3}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 127.0, 117.0, 122.0, 122.0, 117.0, 132.0, 118.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [142.0, 153.0, 159.0, 151.0, 156.0, 147.0, 152.0, 149.0, 159.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.9}, {"lowerIsBetter": true, "replicates": [69.0, 74.0, 70.0, 69.0, 72.0, 68.0, 66.0, 67.0, 69.0, 75.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1527.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.58840288252054], "unit": "score", "name": "Richards", "value": 210.64703400000002}, {"lowerIsBetter": false, "replicates": [187.79342723004694], "unit": "score", "name": "DeltaBlue", "value": 352.0783499999999}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1074.1138560687432], "unit": "score", "name": "RayTrace", "value": 688.9297590000002}, {"lowerIsBetter": false, "replicates": [711.2375533428165], "unit": "score", "name": "Earley", "value": 937.0469780000002}, {"lowerIsBetter": false, "replicates": [12168.674698795181], "unit": "score", "name": "Boyer", "value": 54.768741584158384}, {"lowerIsBetter": false, "replicates": [25250.0], "unit": "score", "name": "RegExp", "value": 36.07861386138617}, {"lowerIsBetter": false, "replicates": [564.0157924421884], "unit": "score", "name": "Splay", "value": 144.48354300000003}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21508.517599135605}]} 20:19:51 INFO - RETURN: dromaeo_css: 6869.70 20:19:51 INFO - RETURN: kraken: 1527.30 20:19:51 INFO - RETURN: v8_7: 21508.52 20:19:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21508.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1527.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6869.70"}}} 20:19:51 INFO - Return code: 0 20:19:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:19:51 INFO - # TBPL SUCCESS # 20:19:51 INFO - Running post-action listener: _resource_record_post_action 20:19:51 INFO - Running post-run listener: _resource_record_post_run 20:19:52 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 567726080; Read time: 0; Write time: 429480 20:19:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245174272; Read time: 0; Write time: 260136 20:19:52 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 322191360; Read time: 0; Write time: 169316 20:19:52 INFO - Running post-run listener: _upload_blobber_files 20:19:52 INFO - Blob upload gear active. 20:19:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:19:52 INFO - Copying logs to upload dir... 20:19:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.624658 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-18 20:19:52.429758) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 20:19:52.437820) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496 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.010081 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:52.489825) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 20:19:52.490225) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bab59de71505bdac5bb1aeb2000001b6-1450497496.729775-216667496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 20:19:52.540336) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 20:19:52.540682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 20:19:52.541026) ========= ========= Total master_lag: 0.24 =========