builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1456151176.56 results: success (0) buildid: 20160222030212 builduid: c4c5afe0268442618a2d2c650e205c99 revision: e1cf617a1f2813b6cd66f460313a61c223406c9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.562793) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.563201) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.563510) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006681 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.613346) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.613617) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.706372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.706623) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004669 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.763435) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.763693) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.764020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.764346) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-22 06:26:17-- 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% 64.6M=0s 2016-02-22 06:26:17 (64.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151746 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.928396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.928872) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019418 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.985822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 06:26:16.986146) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e1cf617a1f2813b6cd66f460313a61c223406c9b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e1cf617a1f2813b6cd66f460313a61c223406c9b --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=9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-22 06:26:18,018 truncating revision to first 12 chars 2016-02-22 06:26:18,018 Setting DEBUG logging. 2016-02-22 06:26:18,019 attempt 1/10 2016-02-22 06:26:18,019 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e1cf617a1f28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 06:26:18,932 unpacking tar archive at: mozilla-central-e1cf617a1f28/testing/mozharness/ program finished with exit code 0 elapsedTime=1.237265 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 06:26:18.236887) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:18.237242) ========= echo e1cf617a1f2813b6cd66f460313a61c223406c9b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e1cf617a1f2813b6cd66f460313a61c223406c9b'] 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=9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e1cf617a1f2813b6cd66f460313a61c223406c9b program finished with exit code 0 elapsedTime=0.003454 script_repo_revision: 'e1cf617a1f2813b6cd66f460313a61c223406c9b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:18.285840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:18.286141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:18.295870) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-22 06:26:18.296183) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:26:19 INFO - MultiFileLogger online at 20160222 06:26:19 in /builds/slave/test-pgo 06:26:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:26:19 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:26:19 INFO - {'append_to_log': False, 06:26:19 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:26:19 INFO - 'blob_upload_branch': 'Firefox', 06:26:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:26:19 INFO - 'branch': 'Firefox', 06:26:19 INFO - 'buildbot_json_path': 'buildprops.json', 06:26:19 INFO - 'config_files': ('talos/linux_config.py',), 06:26:19 INFO - 'default_actions': ('clobber', 06:26:19 INFO - 'read-buildbot-config', 06:26:19 INFO - 'download-and-extract', 06:26:19 INFO - 'populate-webroot', 06:26:19 INFO - 'create-virtualenv', 06:26:19 INFO - 'install', 06:26:19 INFO - 'run-tests'), 06:26:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:26:19 INFO - 'download_minidump_stackwalk': True, 06:26:19 INFO - 'download_symbols': 'ondemand', 06:26:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:26:19 INFO - 'tooltool.py': '/tools/tooltool.py', 06:26:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:26:19 INFO - '/tools/misc-python/virtualenv.py')}, 06:26:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:26:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:26:19 INFO - 'installer_path': 'installer.exe', 06:26:19 INFO - 'log_level': 'info', 06:26:19 INFO - 'log_name': 'talos', 06:26:19 INFO - 'log_to_console': True, 06:26:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:26:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:26:19 INFO - 'opt_config_files': (), 06:26:19 INFO - 'pip_index': False, 06:26:19 INFO - 'sps_profile': False, 06:26:19 INFO - 'sps_profile_interval': 0, 06:26:19 INFO - 'suite': 'dromaeojs', 06:26:19 INFO - 'system_bits': '32', 06:26:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:26:19 INFO - 'title': 'talos-linux64-ix-022', 06:26:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:26:19 INFO - 'use_talos_json': True, 06:26:19 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:26:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:26:19 INFO - 'work_dir': 'build'} 06:26:19 INFO - ##### 06:26:19 INFO - ##### Running clobber step. 06:26:19 INFO - ##### 06:26:19 INFO - Running pre-action listener: _resource_record_pre_action 06:26:19 INFO - Running main action method: clobber 06:26:19 INFO - rmtree: /builds/slave/test-pgo/build 06:26:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:26:19 INFO - Running post-action listener: _resource_record_post_action 06:26:19 INFO - ##### 06:26:19 INFO - ##### Running read-buildbot-config step. 06:26:19 INFO - ##### 06:26:19 INFO - Running pre-action listener: _resource_record_pre_action 06:26:19 INFO - Running main action method: read_buildbot_config 06:26:19 INFO - Using buildbot properties: 06:26:19 INFO - { 06:26:19 INFO - "project": "", 06:26:19 INFO - "product": "firefox", 06:26:19 INFO - "script_repo_revision": "production", 06:26:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:26:19 INFO - "repository": "", 06:26:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:26:19 INFO - "buildid": "20160222030212", 06:26:19 INFO - "stage_platform": "linux64-pgo", 06:26:19 INFO - "basedir": "/builds/slave/test-pgo", 06:26:19 INFO - "nightly_build": "True", 06:26:19 INFO - "buildnumber": 201, 06:26:19 INFO - "slavename": "talos-linux64-ix-022", 06:26:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:26:19 INFO - "platform": "ubuntu64_hw", 06:26:19 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:26:19 INFO - "branch": "mozilla-central", 06:26:19 INFO - "repo_path": "mozilla-central", 06:26:19 INFO - "revision": "e1cf617a1f2813b6cd66f460313a61c223406c9b", 06:26:19 INFO - "pgo_build": "True", 06:26:19 INFO - "builduid": "c4c5afe0268442618a2d2c650e205c99", 06:26:19 INFO - "slavebuilddir": "test" 06:26:19 INFO - } 06:26:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 06:26:19 INFO - Running post-action listener: _resource_record_post_action 06:26:19 INFO - ##### 06:26:19 INFO - ##### Running download-and-extract step. 06:26:19 INFO - ##### 06:26:19 INFO - Running pre-action listener: _resource_record_pre_action 06:26:19 INFO - Running main action method: download_and_extract 06:26:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:26: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')]} 06:26:19 INFO - https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:26:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/test_packages.json 06:26:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/test_packages.json 06:26:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:26:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:26:21 INFO - Downloaded 1448 bytes. 06:26:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:26:21 INFO - Using the following test package requirements: 06:26:21 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:26:21 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:26:21 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:26:21 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:21 INFO - u'jsshell-linux-x86_64.zip'], 06:26:21 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:26:21 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:26:21 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:26:21 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:26:21 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:26:21 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:26:21 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:26:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:26:21 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')]} 06:26:21 INFO - https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:26:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:26:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:26:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:26:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:26:23 INFO - Downloaded 23366418 bytes. 06:26:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:26:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:26:24 INFO - Return code: 0 06:26:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:26:24 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')]} 06:26:24 INFO - https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:26:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:26:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:26:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:26:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:26:26 INFO - Downloaded 23366418 bytes. 06:26:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:26:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:26:27 INFO - Return code: 0 06:26:27 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')]} 06:26:27 INFO - https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:26:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:26:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:26:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:26:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:26:28 INFO - Downloaded 10707015 bytes. 06:26:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:26:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 06:26:28 INFO - Return code: 0 06:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:28 INFO - https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:26:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:26:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:26:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:26:30 INFO - Downloaded 56560179 bytes. 06:26:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:26:30 INFO - mkdir: /builds/slave/test-pgo/properties 06:26:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:26:30 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:26:30 INFO - Contents: 06:26:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:26:30 INFO - Running post-action listener: _resource_record_post_action 06:26:30 INFO - Running post-action listener: set_extra_try_arguments 06:26:30 INFO - ##### 06:26:30 INFO - ##### Running populate-webroot step. 06:26:30 INFO - ##### 06:26:30 INFO - Running pre-action listener: _resource_record_pre_action 06:26:30 INFO - Running main action method: populate_webroot 06:26:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:26:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:26:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:26:30 INFO - '--tppagecycles', 06:26:30 INFO - '7'], 06:26:30 INFO - 'tests': ['tsvgm']}}, 06:26:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:26:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:26:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:26:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:26:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:26:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:26:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:26:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:30 INFO - 'talos_options': ['--e10s'], 06:26:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:26:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:30 INFO - 'tests': ['damp', 'tps']}, 06:26:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:30 INFO - 'talos_options': ['--e10s'], 06:26:30 INFO - 'tests': ['damp', 'tps']}, 06:26:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:26:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:26:30 INFO - 'other': {'tests': ['a11yr', 06:26:30 INFO - 'ts_paint', 06:26:30 INFO - 'tpaint', 06:26:30 INFO - 'sessionrestore', 06:26:30 INFO - 'sessionrestore_no_auto_restore']}, 06:26:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:26:30 INFO - 'tests': ['a11yr', 06:26:30 INFO - 'ts_paint', 06:26:30 INFO - 'tpaint', 06:26:30 INFO - 'sessionrestore', 06:26:30 INFO - 'sessionrestore_no_auto_restore']}, 06:26:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:26:30 INFO - 'tests': ['a11yr', 06:26:30 INFO - 'ts_paint', 06:26:30 INFO - 'tpaint', 06:26:30 INFO - 'sessionrestore', 06:26:30 INFO - 'sessionrestore_no_auto_restore']}, 06:26:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:26:30 INFO - 'tests': ['a11yr', 06:26:30 INFO - 'ts_paint', 06:26:30 INFO - 'tpaint', 06:26:30 INFO - 'sessionrestore', 06:26:30 INFO - 'sessionrestore_no_auto_restore']}, 06:26:30 INFO - 'other_l64': {'tests': ['a11yr', 06:26:30 INFO - 'ts_paint', 06:26:30 INFO - 'tpaint', 06:26:30 INFO - 'sessionrestore', 06:26:30 INFO - 'sessionrestore_no_auto_restore']}, 06:26:30 INFO - 'other_nol64': {'tests': ['a11yr', 06:26:30 INFO - 'ts_paint', 06:26:30 INFO - 'tpaint', 06:26:30 INFO - 'sessionrestore', 06:26:30 INFO - 'sessionrestore_no_auto_restore']}, 06:26:30 INFO - 'svgr': {'tests': ['tsvgx', 06:26:30 INFO - 'tsvgr_opacity', 06:26:30 INFO - 'tart', 06:26:30 INFO - 'tscrollx', 06:26:30 INFO - 'cart']}, 06:26:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:26:30 INFO - 'tests': ['tsvgx', 06:26:30 INFO - 'tsvgr_opacity', 06:26:30 INFO - 'tart', 06:26:30 INFO - 'tscrollx', 06:26:30 INFO - 'cart']}, 06:26:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:30 INFO - 'tests': ['tp5o']}, 06:26:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:30 INFO - 'talos_options': ['--e10s'], 06:26:30 INFO - 'tests': ['tp5o']}, 06:26:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:30 INFO - 'talos_options': ['--xperf_path', 06:26:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:26:30 INFO - 'tests': ['tp5n']}, 06:26:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:30 INFO - 'talos_options': ['--e10s', 06:26:30 INFO - '--xperf_path', 06:26:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:26:30 INFO - 'tests': ['tp5n']}}, 06:26:30 INFO - 'talos.zip': {'path': '', 06:26:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:26:30 INFO - Running post-action listener: _resource_record_post_action 06:26:30 INFO - ##### 06:26:30 INFO - ##### Running create-virtualenv step. 06:26:30 INFO - ##### 06:26:30 INFO - Running pre-action listener: _resource_record_pre_action 06:26:30 INFO - Running main action method: create_virtualenv 06:26:30 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:26:30 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 06:26:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:26:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:26:30 INFO - Using real prefix '/usr' 06:26:30 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:26:31 INFO - Installing distribute.............................................................................................................................................................................................done. 06:26:33 INFO - Installing pip.................done. 06:26:33 INFO - Return code: 0 06:26:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:26:33 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')]} 06:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:33 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')]} 06:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98157eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252a8c0>, '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 0x252b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252bc50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', '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 06:26:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:26:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:26:33 INFO - Using env: {'DISPLAY': ':0', 06:26:33 INFO - 'HOME': '/home/cltbld', 06:26:33 INFO - 'LANG': 'en_US.UTF-8', 06:26:33 INFO - 'LANGUAGE': 'en_US:en', 06:26:33 INFO - 'LOGNAME': 'cltbld', 06:26:33 INFO - 'MAIL': '/var/mail/cltbld', 06:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:33 INFO - 'MOZ_NO_REMOTE': '1', 06:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:33 INFO - 'NO_EM_RESTART': '1', 06:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:33 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:33 INFO - 'SHELL': '/bin/bash', 06:26:33 INFO - 'SHLVL': '1', 06:26:33 INFO - 'TERM': 'linux', 06:26:33 INFO - 'TMOUT': '86400', 06:26:33 INFO - 'USER': 'cltbld', 06:26:33 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', 06:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:33 INFO - '_': '/tools/buildbot/bin/python'} 06:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:33 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 06:26:33 INFO - Cleaning up... 06:26:33 INFO - Return code: 0 06:26:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:26:33 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')]} 06:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:33 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')]} 06:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98157eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252a8c0>, '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 0x252b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252bc50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', '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 06:26:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:26:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:26:33 INFO - Using env: {'DISPLAY': ':0', 06:26:33 INFO - 'HOME': '/home/cltbld', 06:26:33 INFO - 'LANG': 'en_US.UTF-8', 06:26:33 INFO - 'LANGUAGE': 'en_US:en', 06:26:33 INFO - 'LOGNAME': 'cltbld', 06:26:33 INFO - 'MAIL': '/var/mail/cltbld', 06:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:33 INFO - 'MOZ_NO_REMOTE': '1', 06:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:33 INFO - 'NO_EM_RESTART': '1', 06:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:33 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:33 INFO - 'SHELL': '/bin/bash', 06:26:33 INFO - 'SHLVL': '1', 06:26:33 INFO - 'TERM': 'linux', 06:26:33 INFO - 'TMOUT': '86400', 06:26:33 INFO - 'USER': 'cltbld', 06:26:33 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', 06:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:33 INFO - '_': '/tools/buildbot/bin/python'} 06:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:33 INFO - Downloading/unpacking psutil>=0.7.1 06:26:33 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 06:26:33 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 06:26:33 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 06:26:33 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 06:26:33 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 06:26:33 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 06:26:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:26:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:26:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:26:35 INFO - Installing collected packages: psutil 06:26:35 INFO - Running setup.py install for psutil 06:26:35 INFO - building 'psutil._psutil_linux' extension 06:26:35 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 06:26:36 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 06:26:36 INFO - building 'psutil._psutil_posix' extension 06:26:36 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 06:26:36 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 06:26:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:26:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:26:36 INFO - Successfully installed psutil 06:26:36 INFO - Cleaning up... 06:26:36 INFO - Return code: 0 06:26:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:26:36 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')]} 06:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:36 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')]} 06:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98157eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252a8c0>, '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 0x252b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252bc50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', '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 06:26:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:26:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:26:36 INFO - Using env: {'DISPLAY': ':0', 06:26:36 INFO - 'HOME': '/home/cltbld', 06:26:36 INFO - 'LANG': 'en_US.UTF-8', 06:26:36 INFO - 'LANGUAGE': 'en_US:en', 06:26:36 INFO - 'LOGNAME': 'cltbld', 06:26:36 INFO - 'MAIL': '/var/mail/cltbld', 06:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:36 INFO - 'MOZ_NO_REMOTE': '1', 06:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:36 INFO - 'NO_EM_RESTART': '1', 06:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:36 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:36 INFO - 'SHELL': '/bin/bash', 06:26:36 INFO - 'SHLVL': '1', 06:26:36 INFO - 'TERM': 'linux', 06:26:36 INFO - 'TMOUT': '86400', 06:26:36 INFO - 'USER': 'cltbld', 06:26:36 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', 06:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:36 INFO - '_': '/tools/buildbot/bin/python'} 06:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:26:36 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 06:26:36 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 06:26:36 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 06:26:36 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 06:26:36 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 06:26:36 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 06:26:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:26:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:26:38 INFO - Installing collected packages: mozsystemmonitor 06:26:38 INFO - Running setup.py install for mozsystemmonitor 06:26:38 INFO - Successfully installed mozsystemmonitor 06:26:38 INFO - Cleaning up... 06:26:38 INFO - Return code: 0 06:26:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:26: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')]} 06:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26: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')]} 06:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98157eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252a8c0>, '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 0x252b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252bc50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', '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 06:26:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:26:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:26:38 INFO - Using env: {'DISPLAY': ':0', 06:26:38 INFO - 'HOME': '/home/cltbld', 06:26:38 INFO - 'LANG': 'en_US.UTF-8', 06:26:38 INFO - 'LANGUAGE': 'en_US:en', 06:26:38 INFO - 'LOGNAME': 'cltbld', 06:26:38 INFO - 'MAIL': '/var/mail/cltbld', 06:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:38 INFO - 'MOZ_NO_REMOTE': '1', 06:26:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:38 INFO - 'NO_EM_RESTART': '1', 06:26:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:38 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:38 INFO - 'SHELL': '/bin/bash', 06:26:38 INFO - 'SHLVL': '1', 06:26:38 INFO - 'TERM': 'linux', 06:26:38 INFO - 'TMOUT': '86400', 06:26:38 INFO - 'USER': 'cltbld', 06:26:38 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', 06:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:38 INFO - '_': '/tools/buildbot/bin/python'} 06:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:38 INFO - Downloading/unpacking blobuploader==1.2.4 06:26:38 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 06:26:38 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 06:26:38 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 06:26:38 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 06:26:38 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 06:26:38 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 06:26:40 INFO - Downloading blobuploader-1.2.4.tar.gz 06:26:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:26:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:26:40 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 06:26:40 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 06:26:40 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 06:26:40 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 06:26:40 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 06:26:40 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 06:26:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:26:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:26:41 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 06:26:41 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 06:26:41 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 06:26:41 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 06:26:41 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 06:26:41 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 06:26:41 INFO - Downloading docopt-0.6.1.tar.gz 06:26:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:26:41 INFO - Installing collected packages: blobuploader, requests, docopt 06:26:41 INFO - Running setup.py install for blobuploader 06:26:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:26:41 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:26:41 INFO - Running setup.py install for requests 06:26:41 INFO - Running setup.py install for docopt 06:26:41 INFO - Successfully installed blobuploader requests docopt 06:26:41 INFO - Cleaning up... 06:26:41 INFO - Return code: 0 06:26:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:26:41 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')]} 06:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:41 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')]} 06:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98157eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252a8c0>, '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 0x252b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252bc50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', '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 06:26:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:26:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:26:41 INFO - Using env: {'DISPLAY': ':0', 06:26:41 INFO - 'HOME': '/home/cltbld', 06:26:41 INFO - 'LANG': 'en_US.UTF-8', 06:26:41 INFO - 'LANGUAGE': 'en_US:en', 06:26:41 INFO - 'LOGNAME': 'cltbld', 06:26:41 INFO - 'MAIL': '/var/mail/cltbld', 06:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:41 INFO - 'MOZ_NO_REMOTE': '1', 06:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:41 INFO - 'NO_EM_RESTART': '1', 06:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:41 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:41 INFO - 'SHELL': '/bin/bash', 06:26:41 INFO - 'SHLVL': '1', 06:26:41 INFO - 'TERM': 'linux', 06:26:41 INFO - 'TMOUT': '86400', 06:26:41 INFO - 'USER': 'cltbld', 06:26:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', 06:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:41 INFO - '_': '/tools/buildbot/bin/python'} 06:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:26:42 INFO - Running setup.py (path:/tmp/pip-BZ344L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:26:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:26:42 INFO - Running setup.py (path:/tmp/pip-doXJjh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:26:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:26:42 INFO - Running setup.py (path:/tmp/pip-1XwJtd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:26:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:26:42 INFO - Running setup.py (path:/tmp/pip-IbxYzt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:26:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:26:42 INFO - Running setup.py (path:/tmp/pip-IUZZp7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:26:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:26:42 INFO - Running setup.py (path:/tmp/pip-nX_pDY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:26:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:26:42 INFO - Running setup.py (path:/tmp/pip-wuyXaM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:26:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:26:42 INFO - Running setup.py (path:/tmp/pip-9bgrf9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:26:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:26:42 INFO - Running setup.py (path:/tmp/pip-jCHcuc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:26:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:26:42 INFO - Running setup.py (path:/tmp/pip-P7oA3l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:26:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:26:42 INFO - Running setup.py (path:/tmp/pip-f06W_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:26:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:26:42 INFO - Running setup.py (path:/tmp/pip-Yhtcrg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:26:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:26:43 INFO - Running setup.py (path:/tmp/pip-FhfOZq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:26:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:26:43 INFO - Running setup.py (path:/tmp/pip-I9u0bI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:26:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:26:43 INFO - Running setup.py (path:/tmp/pip-FxXCpX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:26:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:26:43 INFO - Running setup.py (path:/tmp/pip-KlCCG9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:26:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:26:43 INFO - Running setup.py (path:/tmp/pip-vjkKqm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:26:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:26:43 INFO - Running setup.py install for manifestparser 06:26:43 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:26:43 INFO - Running setup.py install for mozcrash 06:26:43 INFO - Running setup.py install for mozdebug 06:26:43 INFO - Running setup.py install for mozdevice 06:26:43 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:26:43 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:26:43 INFO - Running setup.py install for mozfile 06:26:43 INFO - Running setup.py install for mozhttpd 06:26:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:26:43 INFO - Running setup.py install for mozinfo 06:26:44 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:26:44 INFO - Running setup.py install for mozInstall 06:26:44 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:26:44 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:26:44 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:26:44 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:26:44 INFO - Running setup.py install for mozleak 06:26:44 INFO - Running setup.py install for mozlog 06:26:44 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:26:44 INFO - Running setup.py install for moznetwork 06:26:44 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:26:44 INFO - Running setup.py install for mozprocess 06:26:44 INFO - Running setup.py install for mozprofile 06:26:44 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:26:44 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:26:44 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:26:44 INFO - Running setup.py install for mozrunner 06:26:44 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:26:44 INFO - Running setup.py install for mozscreenshot 06:26:44 INFO - Running setup.py install for moztest 06:26:45 INFO - Running setup.py install for mozversion 06:26:45 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:26:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:26:45 INFO - Cleaning up... 06:26:45 INFO - Return code: 0 06:26:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:26: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')]} 06:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26: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')]} 06:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98157eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252a8c0>, '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 0x252b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252bc50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', '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 06:26:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:26:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:26:45 INFO - Using env: {'DISPLAY': ':0', 06:26:45 INFO - 'HOME': '/home/cltbld', 06:26:45 INFO - 'LANG': 'en_US.UTF-8', 06:26:45 INFO - 'LANGUAGE': 'en_US:en', 06:26:45 INFO - 'LOGNAME': 'cltbld', 06:26:45 INFO - 'MAIL': '/var/mail/cltbld', 06:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:45 INFO - 'MOZ_NO_REMOTE': '1', 06:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:45 INFO - 'NO_EM_RESTART': '1', 06:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:45 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:45 INFO - 'SHELL': '/bin/bash', 06:26:45 INFO - 'SHLVL': '1', 06:26:45 INFO - 'TERM': 'linux', 06:26:45 INFO - 'TMOUT': '86400', 06:26:45 INFO - 'USER': 'cltbld', 06:26:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', 06:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:45 INFO - '_': '/tools/buildbot/bin/python'} 06:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:26:45 INFO - Running setup.py (path:/tmp/pip-7QMY1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:26:45 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)) 06:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:26:45 INFO - Running setup.py (path:/tmp/pip-GE54e1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:26:45 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)) 06:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:26:45 INFO - Running setup.py (path:/tmp/pip-WdcvIW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:26:45 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)) 06:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:26:45 INFO - Running setup.py (path:/tmp/pip-FOmcZk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:26:45 INFO - Running setup.py (path:/tmp/pip-aRV6S9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:26:45 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)) 06:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:26:45 INFO - Running setup.py (path:/tmp/pip-1zqUtM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:26:45 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)) 06:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:26:45 INFO - Running setup.py (path:/tmp/pip-BMjNNY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:26:45 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)) 06:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:26:45 INFO - Running setup.py (path:/tmp/pip-LDjH92-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:26:45 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)) 06:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:26:45 INFO - Running setup.py (path:/tmp/pip-k7CrFS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:26:46 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)) 06:26:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:26:46 INFO - Running setup.py (path:/tmp/pip-g2TnxX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:26:46 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)) 06:26:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:26:46 INFO - Running setup.py (path:/tmp/pip-PVPTan-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:26:46 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)) 06:26:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:26:46 INFO - Running setup.py (path:/tmp/pip-BQdZxx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:26:46 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)) 06:26:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:26:46 INFO - Running setup.py (path:/tmp/pip-HJbzZn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 06:26:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:26:46 INFO - Running setup.py (path:/tmp/pip-zpPepP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:26:46 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)) 06:26:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:26:46 INFO - Running setup.py (path:/tmp/pip-Gla6I_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:26:46 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)) 06:26:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:26:46 INFO - Running setup.py (path:/tmp/pip-KwMuzS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:26:46 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)) 06:26:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:26:46 INFO - Running setup.py (path:/tmp/pip-heCFrq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:26:46 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)) 06:26:46 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)) 06:26:46 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)) 06:26:46 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)) 06:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:26:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:26:46 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 06:26:46 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 06:26:46 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 06:26:46 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 06:26:46 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 06:26:46 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 06:26:48 INFO - Downloading blessings-1.6.tar.gz 06:26:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:26:48 INFO - Installing collected packages: blessings 06:26:48 INFO - Running setup.py install for blessings 06:26:48 INFO - Successfully installed blessings 06:26:48 INFO - Cleaning up... 06:26:48 INFO - Return code: 0 06:26:48 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:26:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:26:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:26:48 INFO - Reading from file tmpfile_stdout 06:26:48 INFO - Current package versions: 06:26:48 INFO - argparse == 1.2.1 06:26:48 INFO - blessings == 1.6 06:26:48 INFO - blobuploader == 1.2.4 06:26:48 INFO - docopt == 0.6.1 06:26:48 INFO - manifestparser == 1.1 06:26:48 INFO - mozInstall == 1.12 06:26:48 INFO - mozcrash == 0.16 06:26:48 INFO - mozdebug == 0.1 06:26:48 INFO - mozdevice == 0.48 06:26:48 INFO - mozfile == 1.2 06:26:48 INFO - mozhttpd == 0.7 06:26:48 INFO - mozinfo == 0.9 06:26:48 INFO - mozleak == 0.1 06:26:48 INFO - mozlog == 3.1 06:26:48 INFO - moznetwork == 0.27 06:26:48 INFO - mozprocess == 0.22 06:26:48 INFO - mozprofile == 0.28 06:26:48 INFO - mozrunner == 6.11 06:26:48 INFO - mozscreenshot == 0.1 06:26:48 INFO - mozsystemmonitor == 0.0 06:26:48 INFO - moztest == 0.7 06:26:48 INFO - mozversion == 1.4 06:26:48 INFO - psutil == 3.1.1 06:26:48 INFO - requests == 1.2.3 06:26:48 INFO - wsgiref == 0.1.2 06:26:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98157eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252a8c0>, '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 0x252b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252bc50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', '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 06:26:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 06:26:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:26:48 INFO - Using env: {'DISPLAY': ':0', 06:26:48 INFO - 'HOME': '/home/cltbld', 06:26:48 INFO - 'LANG': 'en_US.UTF-8', 06:26:48 INFO - 'LANGUAGE': 'en_US:en', 06:26:48 INFO - 'LOGNAME': 'cltbld', 06:26:48 INFO - 'MAIL': '/var/mail/cltbld', 06:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:48 INFO - 'MOZ_NO_REMOTE': '1', 06:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:48 INFO - 'NO_EM_RESTART': '1', 06:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:48 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:48 INFO - 'SHELL': '/bin/bash', 06:26:48 INFO - 'SHLVL': '1', 06:26:48 INFO - 'TERM': 'linux', 06:26:48 INFO - 'TMOUT': '86400', 06:26:48 INFO - 'USER': 'cltbld', 06:26:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', 06:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:48 INFO - '_': '/tools/buildbot/bin/python'} 06:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 06:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 06:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 06:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 06:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 06:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 06:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:26:49 INFO - Cleaning up... 06:26:49 INFO - Return code: 0 06:26:49 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98157eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252a8c0>, '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 0x252b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252bc50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', '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 06:26:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 06:26:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:26:49 INFO - Using env: {'DISPLAY': ':0', 06:26:49 INFO - 'HOME': '/home/cltbld', 06:26:49 INFO - 'LANG': 'en_US.UTF-8', 06:26:49 INFO - 'LANGUAGE': 'en_US:en', 06:26:49 INFO - 'LOGNAME': 'cltbld', 06:26:49 INFO - 'MAIL': '/var/mail/cltbld', 06:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:49 INFO - 'MOZ_NO_REMOTE': '1', 06:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:49 INFO - 'NO_EM_RESTART': '1', 06:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:49 INFO - 'SHELL': '/bin/bash', 06:26:49 INFO - 'SHLVL': '1', 06:26:49 INFO - 'TERM': 'linux', 06:26:49 INFO - 'TMOUT': '86400', 06:26:49 INFO - 'USER': 'cltbld', 06:26:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', 06:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:49 INFO - '_': '/tools/buildbot/bin/python'} 06:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:49 INFO - Downloading/unpacking jsonschema 06:26:49 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 06:26:49 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 06:26:49 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 06:26:49 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 06:26:49 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 06:26:49 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 06:26:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:26:51 INFO - Downloading/unpacking functools32 (from jsonschema) 06:26:51 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 06:26:51 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 06:26:51 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 06:26:51 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 06:26:51 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 06:26:51 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 06:26:51 INFO - Downloading functools32-3.2.3-2.tar.gz 06:26:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:26:51 INFO - warning: no files found matching '*.txt' 06:26:51 INFO - no previously-included directories found matching 'build' 06:26:51 INFO - no previously-included directories found matching 'dist' 06:26:51 INFO - no previously-included directories found matching '.git*' 06:26:51 INFO - Installing collected packages: jsonschema, functools32 06:26:51 INFO - Running setup.py install for functools32 06:26:51 INFO - warning: no files found matching '*.txt' 06:26:51 INFO - no previously-included directories found matching 'build' 06:26:51 INFO - no previously-included directories found matching 'dist' 06:26:51 INFO - no previously-included directories found matching '.git*' 06:26:51 INFO - Successfully installed jsonschema functools32 06:26:51 INFO - Cleaning up... 06:26:51 INFO - Return code: 0 06:26:51 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:26:51 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')]} 06:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:51 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')]} 06:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98157eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252a8c0>, '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 0x252b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252bc50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', '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 06:26:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 06:26:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:26:51 INFO - Using env: {'DISPLAY': ':0', 06:26:51 INFO - 'HOME': '/home/cltbld', 06:26:51 INFO - 'LANG': 'en_US.UTF-8', 06:26:51 INFO - 'LANGUAGE': 'en_US:en', 06:26:51 INFO - 'LOGNAME': 'cltbld', 06:26:51 INFO - 'MAIL': '/var/mail/cltbld', 06:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:51 INFO - 'MOZ_NO_REMOTE': '1', 06:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:51 INFO - 'NO_EM_RESTART': '1', 06:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:51 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:51 INFO - 'SHELL': '/bin/bash', 06:26:51 INFO - 'SHLVL': '1', 06:26:51 INFO - 'TERM': 'linux', 06:26:51 INFO - 'TMOUT': '86400', 06:26:51 INFO - 'USER': 'cltbld', 06:26:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', 06:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:51 INFO - '_': '/tools/buildbot/bin/python'} 06:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:51 INFO - Downloading/unpacking flake8 06:26:51 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 06:26:51 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 06:26:51 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 06:26:51 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 06:26:51 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 06:26:51 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 06:26:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:26:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:26:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:26:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:26:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:26:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:26:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:26:54 INFO - no previously-included directories found matching 'docs/_build' 06:26:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:26:54 INFO - Running setup.py install for pep8 06:26:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:26:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:26:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:26:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:26:54 INFO - no previously-included directories found matching 'docs/_build' 06:26:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:26:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:26:54 INFO - Cleaning up... 06:26:54 INFO - Return code: 0 06:26:54 INFO - Running post-action listener: _resource_record_post_action 06:26:54 INFO - Running post-action listener: _start_resource_monitoring 06:26:54 INFO - Starting resource monitoring. 06:26:54 INFO - ##### 06:26:54 INFO - ##### Running install step. 06:26:54 INFO - ##### 06:26:54 INFO - Running pre-action listener: _resource_record_pre_action 06:26:54 INFO - Running main action method: install 06:26:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:26:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:26:54 INFO - Reading from file tmpfile_stdout 06:26:54 INFO - Detecting whether we're running mozinstall >=1.0... 06:26:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:26:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:26:54 INFO - Reading from file tmpfile_stdout 06:26:54 INFO - Output received: 06:26:54 INFO - Usage: mozinstall [options] installer 06:26:54 INFO - Options: 06:26:54 INFO - -h, --help show this help message and exit 06:26:54 INFO - -d DEST, --destination=DEST 06:26:54 INFO - Directory to install application into. [default: 06:26:54 INFO - "/builds/slave/test-pgo"] 06:26:54 INFO - --app=APP Application being installed. [default: firefox] 06:26:54 INFO - mkdir: /builds/slave/test-pgo/build/application 06:26:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:26:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:27:11 INFO - Reading from file tmpfile_stdout 06:27:11 INFO - Output received: 06:27:11 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:27:11 INFO - Running post-action listener: _resource_record_post_action 06:27:11 INFO - ##### 06:27:11 INFO - ##### Running run-tests step. 06:27:11 INFO - ##### 06:27:11 INFO - Running pre-action listener: _resource_record_pre_action 06:27:11 INFO - Running main action method: run_tests 06:27:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:27:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:27:11 INFO - Python 2.7.3 06:27:11 INFO - Return code: 0 06:27:11 INFO - grabbing minidump binary from tooltool 06:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:11 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 0x252a8c0>, '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 0x252b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252bc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:27:11 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 06:27:11 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 06:27:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:27:11 INFO - Return code: 0 06:27:11 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:27:11 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:27:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:27:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:27:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:27:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:27:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:27:12 INFO - Return code: 0 06:27:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 06:27:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 06:27:12 INFO - Using env: {'DISPLAY': ':0', 06:27:12 INFO - 'HOME': '/home/cltbld', 06:27:12 INFO - 'LANG': 'en_US.UTF-8', 06:27:12 INFO - 'LANGUAGE': 'en_US:en', 06:27:12 INFO - 'LOGNAME': 'cltbld', 06:27:12 INFO - 'MAIL': '/var/mail/cltbld', 06:27:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:27:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:12 INFO - 'MOZ_NO_REMOTE': '1', 06:27:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:12 INFO - 'NO_EM_RESTART': '1', 06:27:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:27:12 INFO - 'PWD': '/builds/slave/test-pgo', 06:27:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:27:12 INFO - 'SHELL': '/bin/bash', 06:27:12 INFO - 'SHLVL': '1', 06:27:12 INFO - 'TERM': 'linux', 06:27:12 INFO - 'TMOUT': '86400', 06:27:12 INFO - 'USER': 'cltbld', 06:27:12 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607', 06:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:12 INFO - '_': '/tools/buildbot/bin/python'} 06:27:12 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:27:12 INFO - mozversion application_buildid: 20160222030212 06:27:12 INFO - mozversion application_changeset: e1cf617a1f2813b6cd66f460313a61c223406c9b 06:27:12 INFO - mozversion application_display_name: Nightly 06:27:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:27:12 INFO - mozversion application_name: Firefox 06:27:12 INFO - mozversion application_remotingname: firefox 06:27:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:27:12 INFO - mozversion application_vendor: Mozilla 06:27:12 INFO - mozversion application_version: 47.0a1 06:27:12 INFO - mozversion platform_buildid: 20160222030212 06:27:12 INFO - mozversion platform_changeset: e1cf617a1f2813b6cd66f460313a61c223406c9b 06:27:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:27:12 INFO - mozversion platform_version: 47.0a1 06:27:12 INFO - using testdate: 1456151232 06:27:12 INFO - actual date: 1456151232 06:27:12 INFO - starting webserver on 'localhost:42239' 06:27:12 INFO - SUITE-START | Running 2 tests 06:27:12 INFO - TEST-START | dromaeo_css 06:27:12 INFO - operating with platform_type : linux_ 06:27:12 INFO - Initialising browser for dromaeo_css test... 06:27:12 INFO - TEST-INFO | started process 7982 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkvbM0S/profile http://localhost:42239/getInfo.html) 06:27:17 INFO - PROCESS | 7982 | __metrics Screen width/height:1600/1200 06:27:17 INFO - PROCESS | 7982 | colorDepth:24 06:27:17 INFO - PROCESS | 7982 | Browser inner width/height: 1024/697 06:27:17 INFO - PROCESS | 7982 | __metrics 06:27:17 INFO - PROCESS | 7982 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:27:18 INFO - TEST-INFO | 7982: exit 0 06:27:18 INFO - Browser initialized. 06:27:18 INFO - Running cycle 1/1 for dromaeo_css test... 06:27:18 INFO - TEST-INFO | started process 8075 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkvbM0S/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:27:30 INFO - PROCESS | 8075 | RSS: Main: 147480576 06:27:30 INFO - PROCESS | 8075 | 06:28:21 INFO - PROCESS | 8075 | 1456151301909 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] 06:30:30 INFO - PROCESS | 8075 | Cycle 1(1): loaded http://localhost:42239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42239/tests/dromaeo/cssquery-ext.html) 06:30:31 INFO - PROCESS | 8075 | RSS: Main: 276185088 06:30:31 INFO - PROCESS | 8075 | 06:33:33 INFO - PROCESS | 8075 | Cycle 1(1): loaded http://localhost:42239/tests/dromaeo/cssquery-ext.html (next: http://localhost:42239/tests/dromaeo/cssquery-jquery.html) 06:33:34 INFO - PROCESS | 8075 | RSS: Main: 240463872 06:33:34 INFO - PROCESS | 8075 | 06:36:36 INFO - PROCESS | 8075 | Cycle 1(1): loaded http://localhost:42239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42239/tests/dromaeo/cssquery-mootools.html) 06:36:36 INFO - PROCESS | 8075 | RSS: Main: 242098176 06:36:36 INFO - PROCESS | 8075 | 06:39:38 INFO - PROCESS | 8075 | Cycle 1(1): loaded http://localhost:42239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42239/tests/dromaeo/cssquery-prototype.html) 06:39:39 INFO - PROCESS | 8075 | RSS: Main: 214773760 06:39:39 INFO - PROCESS | 8075 | 06:42:41 INFO - PROCESS | 8075 | Cycle 1(1): loaded http://localhost:42239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42239/tests/dromaeo/cssquery-yui.html) 06:42:42 INFO - PROCESS | 8075 | RSS: Main: 191709184 06:42:42 INFO - PROCESS | 8075 | 06:45:45 INFO - PROCESS | 8075 | Cycle 1(1): loaded http://localhost:42239/tests/dromaeo/cssquery-yui.html (next: http://localhost:42239/tests/dromaeo/cssquery-dojo.html) 06:45:45 INFO - PROCESS | 8075 | RSS: Main: 286220288 06:45:45 INFO - PROCESS | 8075 | 06:45:45 INFO - PROCESS | 8075 | __start_tp_report 06:45:45 INFO - PROCESS | 8075 | _x_x_mozilla_page_load 06:45:45 INFO - PROCESS | 8075 | _x_x_mozilla_page_load_details 06:45:45 INFO - PROCESS | 8075 | |i|pagename|runs| 06:45:45 INFO - PROCESS | 8075 | |0;dojo.html;3166.8416579171035;3168.635606905206;3236.902892913212;3238.498032804916;3268.738500919926;5129.743512824353;5220.138677118271;5263.078961181792;5281.049411106;5334.119870221413;5203.115470370037;5208.921866172011;5209.244659524376;5230.92153617696;5282.2076688496745;4681.83613573525;4797.52024797521;4871.829485967992;4873.195922672755;4939.629527785412;4682.531746825324;4808;4888.951110488885;4893.926591101136;4992.500749925015;4827.179379505493;4836.540528649773;4838.03239352131;4845.515448455161;4885.5358740919555;4845.588125009378;4848;4856.101621200054;4871.634627402959;4903.4851340609075;4725.22033864412;4761.9761751223305;4823.180059389877;4842.15262329091;4844.781984810692;5105.285260063594;5117.82087626935;5148.3564554430695;5158.793648254065;5176.948230517684;5573.944260557383;5636.577256705764;5644.943550564483;5651.40660230674;5667.263255776764;5665.858353541194;5687.544996400278;5714.571407144439;5727.2268243787385;5776.537876969875;5336.306280183551;5362.517373436371;5366.248725178478;5368.087425137736;5371.973140134313;5676.489115979582;5796.94203057964;5802.767889284381;5860;5955.702214889238;5626.662400255997;5636.098224284095;5640.858978525488;5653.886922261614;5661.801836935688;5689.886202276014;5711.914321285184;5713.542916566665;5715.342735585377;5723.771049157987;5518.144687573352;5578.30271216098;5579.191017302468;5615.550755939515;5650.011248031578;5588.050031494656;5601.271834661549;5603.271574695345;5612.719364031782;5614.214010038598;4269.87190384289;4392.077663690597;4397.84607538741;4402.3836662867225;4451.243288640939;3885.4948856648457;3916.4908561886773;3921.686265098785;3956.2680904032845;3959.1092004298803;5248.816291429782;5288.8413347599635;5302.390225124083;5316.016536940601;5352.411234764173;5490.5882058844945;5647.37878833328;5660.924424359358;5673.773049078073;5702.54379649627;5305.734713264398;5307.787688492494;5336.946630533723;5343.65266257692;5344.038073146871;4885.340479035285;4900.632452566;4901.36282283308;4910.189818679878;4942;5737.77048918047;5916.230889984275;5941.494972927263;5943.70281485924;5984.401559844068;5736.368999409978;5745.511631511368;5746.9712651436475;5748.770049197985;5748.798792042258;5725.770969161354;5962.284525856925;5975.492083172979;5980.073088671263;5982.042873140276;5624.212610234488;5641.802536911188;5667.121596152603;5673.489385955284;5711.143328500592;5688.175214593944;5689.516391106802;5730.770769169187;5738.340090889601;5745.052066408995;5294.655847369909;5589.552835773047;5595.664260144405;5604.551635869202;5701.059325211294;5490.917636235539;5517.751701173537;5540.556755459473;5544.057510223352;5545.694986775766;5455.536279416294;5460.071787796005;5460.726963651881;5461.235427040138;5511.862203444946;5348.625596208383;5478.808241711521;5546.55627549787;5565.638233514808;5610.9158362623775;5327.280817089798;5409.702466364388;5413.9729301353245;5443.945560544344;5533.6126471148245 06:45:45 INFO - PROCESS | 8075 | |1;ext.html;527.0197432775037;528.735632183908;541.8699512117093;552.3951273355675;581.1050981488505;35640.82179589102;36281.45577816335;36365.090872728164;36399;36420.72213500785;40050.399244011365;40590.594094059124;40724.185516289734;40761.38857917126;40859;8623.396362254645;8791.64833406663;8793.208611224989;8822.779430514225;8823.691170809023;8492.957535212347;8551.486910785341;8609.39734218605;8609.741707748777;8617.310615150773;8799.120087991181;8879.422837515573;8935.463872167658;8943.329250306253;8952.955235223815;8767.51778652174;8873.778155546099;8908.153725396078;8924.196822285961;8930.508822014786;8860.335474839412;8975.506347150904;8987.820243595157;8994.730158095268;9006.1894429501;39426.21147577061;40005.79997099996;40008.199836003405;40008.399874001916;40066.399004014966;2318.652202169671;3310.2882880180637;3359.5800524934384;3573.8213089345427;4050.25070361984;26511;26734.197974060808;26817.73182268172;26831.865840670867;26871.462570748474;3514.9824250878582;3526.982365088184;3746.8499824242604;3751.456038874348;3772.4529943158363;174805.12597436932;175202;175476;176844.11577942155;176915;53748.73125634347;53812.461875380744;54200.18699719507;54250;54277.72861135748;57564.71217643885;57613.42386576081;57623.71188144032;57678;57733;16254.43109491162;16392.672146557;16527;16534.917325413535;16557.751633725504;12850.807237891438;12854.228746275254;12876.484940602459;12882.033847461478;12962.092653514164;18763.544662910215;19138.425847224604;19306.227750890088;19393.32123375675;19440.125194366286;7502.512336698097;7759.7672069838;7857.489263197874;7967.243111904476;7978.481398709066;936.5083331251011;964.3827950111934;965.0590674092844;1012.9696109116738;1045.273534893242;24234.87882560576;24276.87861560681;24329.148479803123;24383.634245486333;24439.511209775705;904.1681652879366;956.5982287439153;1054.082947835388;1070.1331921143899;1171.841801356823;12698.42857071434;14933;15215.17519838491;15791.842081579267;15917.442889498812;306707;306903;310546;311084;311386;43682.12635747267;49987;51151.48848511467;51808.48191518112;52118;1315.2305901047803;1323.126736354021;1338.5783478204335;1342.5301144599507;1362.9011322563142;24725;24876.875615621808;26106.608400874382;26809.463810723286;27157.185284441497;41362;47127.76436117935;48222.517774821805;48592.75703621459;48791.268130977354;183046;185051;186893;187180;187391;29192.562111567917;29525.852370738008;29545.40909181761;29548.852255739443;29635.110946671633;41233;42280.57719422766;42463.5753642472;43094.35358469563;43312.566874332115;35486.46770298499;35690;35734.28531429409;35849.82075089608;36585.268294634494;36210.27579448344;36260.91217263486;36416.635833641325;36577.45133823048;36668.083297917765;34603.30793384169;35569.46645800264;35643.46534801928;35689.82155089208;35735.82132089323;29932.850335748182;32670.34659306848;32953.17617059593;33343.83328083441;33375.49936750902;24341;24411.26766197017;24957.376065598506;25310.240692779247;25421.364465888502 06:45:45 INFO - PROCESS | 8075 | |2;jquery.html;350.59156083163117;350.81808001427066;353.7877273635818;355.479222938395;359.72121605755535;16710.33158673653;16953.21991190926;18226.817731822695;18472.261109555635;18481.260749570036;16851.494455166336;16909.070001149932;17067;17110.31558737652;17120.657586848287;4125.2780763366445;5237.266782650413;5275.683458992454;6096.055111457731;6102.877942441149;5675.631083979549;6065.181200537915;6078.452939235468;6084.6957652117435;6087.269527656666;5785.479306862381;5974.133750606159;5979.940200598004;6007.339192688801;6009;4020.3165461871404;5797.217375654317;5973.522118230553;6002.579819412643;6005.549583781234;5278.498542638482;5302.443243459458;5304.549113325372;5338.306020217386;5342.091844386464;19151.23395064196;20675.689864652042;21477.463063423384;21482.140714371562;21617.78382216189;2235.396442960408;2260.8530445520987;2328.1502251678185;2800.425912687894;3050.710182532678;13521.32393380327;13601.523946661919;13706.794398084037;13913.791293130611;14126.505572305023;1902.6004539046817;1927.7012063130237;1963.4796778853615;2028.6247044296852;2060.7527096748486;68836.65581672109;71545;72080;72092.2790772096;73785;14726.821854251633;15600.609984750472;15682.137482438575;15789.842101579066;15830.28763705636;24598.262052138463;25052.624210636855;25098.498030039296;25124;25140.12009579656;8800.207981281716;8852;8892;8915.643374265086;9044.954775226213;6606.405423511907;6652.301508341651;6659.567128136752;6908.0674108995645;7473.916282139168;7789.805254868674;7929.643166057541;7930.76207713758;7948.761537153895;7965.362770978308;3033.393321335742;3044.1932887784756;3048.116046346579;3070.923226919345;3117.8441077946013;835.7325655790089;948.4404201521136;972.6887396033202;1006.8691070160978;1040.7086015915556;13138.343082845819;15813.525594232191;16453.341866325452;16552.83447165513;17189.226484808212;946.7822400847843;947.3131385197753;960.8126415348939;981.283662926068;1012.099231683802;6987.8602427951155;9154.40496367734;9312.115349041831;9809.074785252667;9822.459764713009;435743;436021;436453;436829;446788;45768.313475297895;50053.49946500561;70972;72657.2734272661;73130;1034.2966782587762;1041.729150420911;1044.6604853422668;1056.6618682021833;1059.2796898109204;15488.922555387151;15591.064536127415;15752.448664297153;15771.23223364193;15786;30764.846175768977;31423.685763142075;32052;34815.477767833;35314;42451.56014719023;42762.786186070116;42806.35790463208;42898.571014290705;43120.35319470148;7138.393236574741;7138.85722285541;7256.15441766778;7361.815954600964;7377.4098072155175;9407.905920940977;11789.646310610695;12154;12257.203281786655;12580.811287830507;9857.35927164732;9909.55407006672;10075.496225188857;10831.404272765074;11010.339379637247;7647.961760191163;9870.901290986998;9990.800183996425;10207.642732504326;10541.894581054092;5459.399466058651;6474.866898292874;10118.59525618967;10560.577576897145;10610;7502.249775022454;7511.887321690288;7576.24237576238;7622.5426474411715;7871.173526779606;8959.238464730572;10362.740931476774;10387.896121038693;10463.424511651932;10583.735406614896 06:45:45 INFO - PROCESS | 8075 | |3;mootools.html;1314.4413624209722;1490.716763814875;1500.3848422146918;1669.4240487031977;1821.1258595873987;7462.888056679148;7649.04386951631;7655.92344076559;7675.232476752315;7689.961550192255;7761.185075567055;7941.801454963629;7953.045634523865;7953.483023603461;7963.402744794134;2025.6860186671015;2078.7297651305385;2302.735185453669;2338.7310459297187;2370.525894821034;2363.869987150706;2364.834461587681;2373.1575290771784;2374.7625237476286;2386.1648423051965;2253.324002799162;2297.9425514362106;2299.908003679851;2304.389336825734;2307.6423154411095;2288.519410923708;2324.4537533679654;2324.569954558412;2324.7094113235844;2328.4178955261186;2320.918767843117;2327.080803082773;2327.359976006595;2341.2976107167783;2346.7887890089974;7688.115866675348;7708.306252437307;7759.728409505697;7763.611819409007;7784.805379865492;4783.162946484351;4903.289023091632;4912.508749125094;4961.578265847407;4962.330085438456;3203.3112880730755;3266.8203248821305;3282.852271647758;3291.753118516097;3322.4684050551796;1083.1226706367868;1100.27381927928;1110.9277896936753;1120.1207052463858;1128.5598616539555;10898.673039808818;10966.396848173346;10976.396298203596;10977.28647637901;10980.396078215696;4360.890977725582;4439.933400998988;4441.800118994653;4527.547245275446;4527.592516673515;9345.719628411158;9362.485063321446;9362.578683959102;9374.296927730311;9394.624215031323;4244;4886.657933944661;4888.95111048885;4891.9755401222765;4892.021595680878;4218.8523401680795;4248.256555102845;4285.550017248206;4298.527162012176;4314.9784251078545;3766.642168993941;3779.281936432069;3782.470454136423;3823.9044023899623;3837.1558257183374;1183.644906528038;1189.0962868220215;1203.5366383942246;1210.8304837322783;1227.1287385955893;1308.1758492150075;1327.6282640860575;1329.7539955108336;1344.9394777235048;1351.2365513485047;7295.89056164158;7333.963330183422;7446.292602202782;7459.142198647117;7465.477416580788;474.3833017077785;475.79303003193723;478.37333093647436;478.39005268283216;488.64329039801146;5834.620749651259;5882.823515294463;5892.263467066617;5927.31835838884;5936.257967754031;8903.599338029804;9501.23990080792;9512.714618561455;9519.428834269966;9523.190528804991;8983.46099234048;9111.362204645611;9330.58012389444;9332.786737724053;9337.439753614804;7165.89251161233;7312.707491700273;7379.2251813558805;7383.335499805044;7384.335409813142;7368.070037477553;7369.557826530426;7435.591042492715;7445.516041457288;7445.590492522963;8608.354373422144;8650.1349865013;8724.083971182934;8843.115688431106;8844.071372505794;8882.15619516145;8906.599203036008;9027.09729027092;9035.728928132166;9044.773880652772;5904.291485021825;6692.665366731741;6820.283870193558;7015.754448594274;7110.7511237106455;7439.962800185965;7463.738769143271;7470.925290747023;7499.212582678741;7506.512076714996;6483.189601299838;6600.933990660032;6632.701528431328;6669.799906002828;6879.243283238739;6609;6650.467962562887;6655.101561289358;6726.831829204309;6756.425703815231;6949.061876646588;6983.580985140908;6997.615131167631;7077.469189810682;7093.397061249645;6432.710528026344;6441.581297215666;6483.546151769519;6488.156539649815;6493.967530162319;6654.234763002317;6664.200295964515;6670.866582668416;6675.365840245169;6686.866262674816 06:45:45 INFO - PROCESS | 8075 | |4;prototype.html;335.381221646063;337.7163182926343;340.2378671775221;341.8888861120136;346.5425638157631;5696.088625819859;5840.299164100314;5888.528917686585;5904.940950590498;5936.198613187218;5857.531397488201;5938.109283607461;5950.166976623276;5962.135490353896;5962.135490353907;4626.05165940983;4626.282926146453;4627.23650597651;4632.559906808865;4636.4436267647925;4368.541303163154;4418.5581441855875;4538.95604011076;4549.385832912548;4628.333799832058;4518.638508919295;4520.954790452102;4533.161365147442;4543.886402839939;4547.7953492092765;4532.13889361022;4539.273716205391;4542.636589072899;4544.1593305238475;4551.431071116111;4010.017545701293;4020.2562525932794;4021.8190181441905;4028.254772867029;4029.37544680575;5539.224508568804;5555.055640541118;5561.636304570541;5564.1931919871795;5576.888462230773;5279.577633789288;5280.102382594968;5286.312779338661;5287.101192797195;5287.603429742746;6009.57932944694;6148.1392605035335;6183.350748171422;6184;6192.907106393408;4328.026194106333;4331.350297455407;4334.068175342285;4334.891627709301;4339;6382.425581697669;6467.708953097075;6547.279799222129;6587.176602924586;6599.736010559572;4446.5331140230455;4460.219461594273;4466.950266687326;4469.374287599739;4471.530489298641;4499.235130027903;4502.257127573914;4503.662225333113;4503.7522936238165;4508.143452743968;5222.529972302511;5227.869303267449;5230.947690523046;5232.895342093137;5243.5542978847225;6046.637201767908;6116.29662588808;6254.655993920378;6272.1219029335925;6330.873382532323;1542.2365928865283;1578.4633224703655;1588.3805315926797;1592.235726851118;1596.7684685720506;1039.9220058495644;1041.7135287795916;1061.6602687140196;1063.3088492479794;1064.8668916385452;5973.940260597426;5975.910361344583;5985.25184351956;5988.550858685616;5997.250343707036;6442.387973142544;6459.61242325462;6459.806205813833;6465.094886715863;6465.612063276219;5939.495142912814;5979.4618484336615;5993.730282137314;5998.580099393088;6001.879962400728;3462.307538492312;3491.581010278732;3492.0571445709516;3494.1963348430004;3496.5104885316077;6599.73601055962;6774.153230846145;6778.966105169541;6876.415504682158;6880.449564034865;6664.5334826561675;6702.329767023356;6707.262201157869;6734.494912881455;6742.831429214309;6838.760643377458;6844.9732540119385;6845.110135682429;6845.8973115403305;6851.2121106071445;6520.347965203442;6526.216853977553;6528.118703974903;6528.183977002875;6528.281888992302;6275.905861411991;6391.808245752635;6461.64460954652;6472.061551075162;6484.708188131451;6851.9657401712675;6854.7600833972565;6857;6857.862842743018;6862.9313706862295;4457.977710111429;4500.752458614807;4502.189605870974;4508.278675411918;4513.819447222074;6285.308616052139;6431.839204019937;6557.311482294291;6567.2447668518735;6567.737290508326;6235.098295020062;6335.429811317003;6353.205849268841;6369.20384951881;6373.426391624776;6338;6339.049142628643;6343.873122537431;6347.492200624031;6350.206224221973;6238.095476156022;6240.594361366497;6246.031865060922;6246.625202487865;6247.156633854372;6206.937930620636;6360.109584658244;6364.840878978062;6365.809025729235;6401.135846660642;6228.408301211378;6246.344133865879;6257.812265632038;6267.592606480564;6269.561130720988 06:45:45 INFO - PROCESS | 8075 | |5;yui.html;730.2150188547312;809.1261437647341;817.8486979908718;840.0045945554515;844.4046946902432;13470.124441911268;13693.520726774565;13701.040927135104;13762.311884405777;13782.310884455776;13410.128341657786;14711.48509802157;15159.469418570352;15272.770908436383;15346.386144554204;672.2705864137392;819.8688209886419;822.1080128061061;833.954132522711;835.3734698975768;809.1746418652971;821.8602837517636;827.2720006394395;829.8381815545971;829.8838162657232;861.1388611388611;873.1661263493348;873.2184694698241;874.1826392323167;874.3180319350917;697.1425147069108;878.0955615715791;889.244142478891;889.5374405309203;890.3278025091015;629.175779728557;633.1168020611268;636.0427556527443;636.0903907412398;636.2174525333819;13567.59297221085;13614.727705445935;13626.93186534061;13630.659233519142;13639.659008524766;12886.226826390446;13120.60638180856;13157.144785588906;13186.274754888573;13224.206547607078;10179.389236645826;10325.48372581368;10710;11169;11465;3588.730845186595;3619.9457008144636;3635.709143268532;3667.5960963951243;3762.9435558466644;48827;49540.75229623865;50069.24896126561;50146;50268.24597631038;10431.68704938853;10577.153827693766;10667.893321066846;10738.570457181626;10740.462976851126;18955.620887582172;18970.24119035223;18974.14616342268;19012.239510419706;19042.80957190438;7809.297163255221;7978.162292959272;8014.719484818003;8057.234562716532;8093.838123237502;4357.433533640607;4361.214981303396;4380.123975204971;4412.580804823537;4428;3128.483800172946;3161.68383161682;3164.4620414529586;3165.572647692532;3189.6172459304566;477.6632474105747;627.5324882962223;629.6788637794758;633.6514916795744;650.417876000986;529.6345521590091;566.4448840136689;674.2583158525582;676.2594958520413;721.5346101764437;8184.959075204586;8249.422540422232;8336.62485188168;8502.319814414956;8602.39783215169;483.7653737937098;490.77914938277917;529.317180836724;634.3149398649448;672.7174586673609;3554.9466757998653;4428.446444194476;4462.799174037176;4492.550744925481;4539.6368290536675;53152.73423632934;54750.45249547533;54809.45190548043;54876.17685734717;54909.1763623546;48087.278690819665;48343.274850877264;49147.75426122847;49622.50377496179;50142.498575013786;44919.77540112279;45606.54393456089;46009.539904601195;46199.30701039487;46383.30425043627;8975.955120224357;8992.190702836777;9088.500132492776;9121.739564111622;9234.861477077984;33417;33761.66238337683;34300.828495857364;34685.306293874484;34751.82624086965;39604.10887006096;42605;42686.57313426826;42785.14429711451;42863;11764.88235117672;11897.524099035942;12072.33602151855;12354.382280886099;12380.133390662568;11814.763704726029;12214.694632634255;12818.102732808615;12831;13001.15492492985;11530.250533715282;11830.585929492427;11919.940400297943;12038.277703337477;12404.441800119197;11742.150267024803;12168.695782605506;12207.145499814927;12368.628941131781;12581.433835477608;11281.379524126252;11295.096392288762;11418.371989540656;11840.230385024946;11942.462589183333;10019.298649094784;10289.897101029193;10479;10488.213383996079;10589.735256618338;9424.95287523558;9527.237820974444;9837.458939758382;9876.703698889045;9939.204863611038 06:45:45 INFO - PROCESS | 8075 | __end_tp_report 06:45:45 INFO - PROCESS | 8075 | __start_cc_report 06:45:45 INFO - PROCESS | 8075 | _x_x_mozilla_cycle_collect,1018 06:45:45 INFO - PROCESS | 8075 | __end_cc_report 06:45:45 INFO - PROCESS | 8075 | __startTimestamp1456152345567__endTimestamp 06:45:45 INFO - PROCESS | 8075 | 06:45:45 INFO - PROCESS | 8075 | ------- Summary: start ------- 06:45:45 INFO - PROCESS | 8075 | Number of tests: 6 06:45:45 INFO - PROCESS | 8075 | 06:45:45 INFO - PROCESS | 8075 | [#0] dojo.html Cycles:165 Average:5273.72 Median:5460.07 stddev:579.16 (10.6%) stddev-sans-first:556.85 06:45:45 INFO - PROCESS | 8075 | Values: 3166.8 3168.6 3236.9 3238.5 3268.7 5129.7 5220.1 5263.1 5281.0 5334.1 5203.1 5208.9 5209.2 5230.9 5282.2 4681.8 4797.5 4871.8 4873.2 4939.6 4682.5 4808.0 4889.0 4893.9 4992.5 4827.2 4836.5 4838.0 4845.5 4885.5 4845.6 4848.0 4856.1 4871.6 4903.5 4725.2 4762.0 4823.2 4842.2 4844.8 5105.3 5117.8 5148.4 5158.8 5176.9 5573.9 5636.6 5644.9 5651.4 5667.3 5665.9 5687.5 5714.6 5727.2 5776.5 5336.3 5362.5 5366.2 5368.1 5372.0 5676.5 5796.9 5802.8 5860.0 5955.7 5626.7 5636.1 5640.9 5653.9 5661.8 5689.9 5711.9 5713.5 5715.3 5723.8 5518.1 5578.3 5579.2 5615.6 5650.0 5588.1 5601.3 5603.3 5612.7 5614.2 4269.9 4392.1 4397.8 4402.4 4451.2 3885.5 3916.5 3921.7 3956.3 3959.1 5248.8 5288.8 5302.4 5316.0 5352.4 5490.6 5647.4 5660.9 5673.8 5702.5 5305.7 5307.8 5336.9 5343.7 5344.0 4885.3 4900.6 4901.4 4910.2 4942.0 5737.8 5916.2 5941.5 5943.7 5984.4 5736.4 5745.5 5747.0 5748.8 5748.8 5725.8 5962.3 5975.5 5980.1 5982.0 5624.2 5641.8 5667.1 5673.5 5711.1 5688.2 5689.5 5730.8 5738.3 5745.1 5294.7 5589.6 5595.7 5604.6 5701.1 5490.9 5517.8 5540.6 5544.1 5545.7 5455.5 5460.1 5460.7 5461.2 5511.9 5348.6 5478.8 5546.6 5565.6 5610.9 5327.3 5409.7 5414.0 5443.9 5533.6 06:45:45 INFO - PROCESS | 8075 | 06:45:45 INFO - PROCESS | 8075 | [#1] ext.html Cycles:180 Average:39900.04 Median:36030.05 stddev:60504.16 (167.9%) stddev-sans-first:60601.66 06:45:45 INFO - PROCESS | 8075 | Values: 527.0 528.7 541.9 552.4 581.1 35640.8 36281.5 36365.1 36399.0 36420.7 40050.4 40590.6 40724.2 40761.4 40859.0 8623.4 8791.6 8793.2 8822.8 8823.7 8493.0 8551.5 8609.4 8609.7 8617.3 8799.1 8879.4 8935.5 8943.3 8953.0 8767.5 8873.8 8908.2 8924.2 8930.5 8860.3 8975.5 8987.8 8994.7 9006.2 39426.2 40005.8 40008.2 40008.4 40066.4 2318.7 3310.3 3359.6 3573.8 4050.3 26511.0 26734.2 26817.7 26831.9 26871.5 3515.0 3527.0 3746.8 3751.5 3772.5 174805.1 175202.0 175476.0 176844.1 176915.0 53748.7 53812.5 54200.2 54250.0 54277.7 57564.7 57613.4 57623.7 57678.0 57733.0 16254.4 16392.7 16527.0 16534.9 16557.8 12850.8 12854.2 12876.5 12882.0 12962.1 18763.5 19138.4 19306.2 19393.3 19440.1 7502.5 7759.8 7857.5 7967.2 7978.5 936.5 964.4 965.1 1013.0 1045.3 24234.9 24276.9 24329.1 24383.6 24439.5 904.2 956.6 1054.1 1070.1 1171.8 12698.4 14933.0 15215.2 15791.8 15917.4 306707.0 306903.0 310546.0 311084.0 311386.0 43682.1 49987.0 51151.5 51808.5 52118.0 1315.2 1323.1 1338.6 1342.5 1362.9 24725.0 24876.9 26106.6 26809.5 27157.2 41362.0 47127.8 48222.5 48592.8 48791.3 183046.0 185051.0 186893.0 187180.0 187391.0 29192.6 29525.9 29545.4 29548.9 29635.1 41233.0 42280.6 42463.6 43094.4 43312.6 35486.5 35690.0 35734.3 35849.8 36585.3 36210.3 36260.9 36416.6 36577.5 36668.1 34603.3 35569.5 35643.5 35689.8 35735.8 29932.9 32670.3 32953.2 33343.8 33375.5 24341.0 24411.3 24957.4 25310.2 25421.4 06:45:45 INFO - PROCESS | 8075 | 06:45:45 INFO - PROCESS | 8075 | [#2] jquery.html Cycles:180 Average:25744.05 Median:23288.42 stddev:71714.10 (307.9%) stddev-sans-first:71889.93 06:45:45 INFO - PROCESS | 8075 | Values: 350.6 350.8 353.8 355.5 359.7 16710.3 16953.2 18226.8 18472.3 18481.3 16851.5 16909.1 17067.0 17110.3 17120.7 4125.3 5237.3 5275.7 6096.1 6102.9 5675.6 6065.2 6078.5 6084.7 6087.3 5785.5 5974.1 5979.9 6007.3 6009.0 4020.3 5797.2 5973.5 6002.6 6005.5 5278.5 5302.4 5304.5 5338.3 5342.1 19151.2 20675.7 21477.5 21482.1 21617.8 2235.4 2260.9 2328.2 2800.4 3050.7 13521.3 13601.5 13706.8 13913.8 14126.5 1902.6 1927.7 1963.5 2028.6 2060.8 68836.7 71545.0 72080.0 72092.3 73785.0 14726.8 15600.6 15682.1 15789.8 15830.3 24598.3 25052.6 25098.5 25124.0 25140.1 8800.2 8852.0 8892.0 8915.6 9045.0 6606.4 6652.3 6659.6 6908.1 7473.9 7789.8 7929.6 7930.8 7948.8 7965.4 3033.4 3044.2 3048.1 3070.9 3117.8 835.7 948.4 972.7 1006.9 1040.7 13138.3 15813.5 16453.3 16552.8 17189.2 946.8 947.3 960.8 981.3 1012.1 6987.9 9154.4 9312.1 9809.1 9822.5 435743.0 436021.0 436453.0 436829.0 446788.0 45768.3 50053.5 70972.0 72657.3 73130.0 1034.3 1041.7 1044.7 1056.7 1059.3 15488.9 15591.1 15752.4 15771.2 15786.0 30764.8 31423.7 32052.0 34815.5 35314.0 42451.6 42762.8 42806.4 42898.6 43120.4 7138.4 7138.9 7256.2 7361.8 7377.4 9407.9 11789.6 12154.0 12257.2 12580.8 9857.4 9909.6 10075.5 10831.4 11010.3 7648.0 9870.9 9990.8 10207.6 10541.9 5459.4 6474.9 10118.6 10560.6 10610.0 7502.2 7511.9 7576.2 7622.5 7871.2 8959.2 10362.7 10387.9 10463.4 10583.7 06:45:45 INFO - PROCESS | 8075 | 06:45:45 INFO - PROCESS | 8075 | [#3] mootools.html Cycles:180 Average:5509.28 Median:6184.48 stddev:2864.60 (46.3%) stddev-sans-first:2855.28 06:45:45 INFO - PROCESS | 8075 | Values: 1314.4 1490.7 1500.4 1669.4 1821.1 7462.9 7649.0 7655.9 7675.2 7690.0 7761.2 7941.8 7953.0 7953.5 7963.4 2025.7 2078.7 2302.7 2338.7 2370.5 2363.9 2364.8 2373.2 2374.8 2386.2 2253.3 2297.9 2299.9 2304.4 2307.6 2288.5 2324.5 2324.6 2324.7 2328.4 2320.9 2327.1 2327.4 2341.3 2346.8 7688.1 7708.3 7759.7 7763.6 7784.8 4783.2 4903.3 4912.5 4961.6 4962.3 3203.3 3266.8 3282.9 3291.8 3322.5 1083.1 1100.3 1110.9 1120.1 1128.6 10898.7 10966.4 10976.4 10977.3 10980.4 4360.9 4439.9 4441.8 4527.5 4527.6 9345.7 9362.5 9362.6 9374.3 9394.6 4244.0 4886.7 4889.0 4892.0 4892.0 4218.9 4248.3 4285.6 4298.5 4315.0 3766.6 3779.3 3782.5 3823.9 3837.2 1183.6 1189.1 1203.5 1210.8 1227.1 1308.2 1327.6 1329.8 1344.9 1351.2 7295.9 7334.0 7446.3 7459.1 7465.5 474.4 475.8 478.4 478.4 488.6 5834.6 5882.8 5892.3 5927.3 5936.3 8903.6 9501.2 9512.7 9519.4 9523.2 8983.5 9111.4 9330.6 9332.8 9337.4 7165.9 7312.7 7379.2 7383.3 7384.3 7368.1 7369.6 7435.6 7445.5 7445.6 8608.4 8650.1 8724.1 8843.1 8844.1 8882.2 8906.6 9027.1 9035.7 9044.8 5904.3 6692.7 6820.3 7015.8 7110.8 7440.0 7463.7 7470.9 7499.2 7506.5 6483.2 6600.9 6632.7 6669.8 6879.2 6609.0 6650.5 6655.1 6726.8 6756.4 6949.1 6983.6 6997.6 7077.5 7093.4 6432.7 6441.6 6483.5 6488.2 6494.0 6654.2 6664.2 6670.9 6675.4 6686.9 06:45:45 INFO - PROCESS | 8075 | 06:45:45 INFO - PROCESS | 8075 | [#4] prototype.html Cycles:180 Average:5271.43 Median:5968.04 stddev:1593.03 (26.7%) stddev-sans-first:1553.82 06:45:45 INFO - PROCESS | 8075 | Values: 335.4 337.7 340.2 341.9 346.5 5696.1 5840.3 5888.5 5904.9 5936.2 5857.5 5938.1 5950.2 5962.1 5962.1 4626.1 4626.3 4627.2 4632.6 4636.4 4368.5 4418.6 4539.0 4549.4 4628.3 4518.6 4521.0 4533.2 4543.9 4547.8 4532.1 4539.3 4542.6 4544.2 4551.4 4010.0 4020.3 4021.8 4028.3 4029.4 5539.2 5555.1 5561.6 5564.2 5576.9 5279.6 5280.1 5286.3 5287.1 5287.6 6009.6 6148.1 6183.4 6184.0 6192.9 4328.0 4331.4 4334.1 4334.9 4339.0 6382.4 6467.7 6547.3 6587.2 6599.7 4446.5 4460.2 4467.0 4469.4 4471.5 4499.2 4502.3 4503.7 4503.8 4508.1 5222.5 5227.9 5230.9 5232.9 5243.6 6046.6 6116.3 6254.7 6272.1 6330.9 1542.2 1578.5 1588.4 1592.2 1596.8 1039.9 1041.7 1061.7 1063.3 1064.9 5973.9 5975.9 5985.3 5988.6 5997.3 6442.4 6459.6 6459.8 6465.1 6465.6 5939.5 5979.5 5993.7 5998.6 6001.9 3462.3 3491.6 3492.1 3494.2 3496.5 6599.7 6774.2 6779.0 6876.4 6880.4 6664.5 6702.3 6707.3 6734.5 6742.8 6838.8 6845.0 6845.1 6845.9 6851.2 6520.3 6526.2 6528.1 6528.2 6528.3 6275.9 6391.8 6461.6 6472.1 6484.7 6852.0 6854.8 6857.0 6857.9 6862.9 4458.0 4500.8 4502.2 4508.3 4513.8 6285.3 6431.8 6557.3 6567.2 6567.7 6235.1 6335.4 6353.2 6369.2 6373.4 6338.0 6339.0 6343.9 6347.5 6350.2 6238.1 6240.6 6246.0 6246.6 6247.2 6206.9 6360.1 6364.8 6365.8 6401.1 6228.4 6246.3 6257.8 6267.6 6269.6 06:45:45 INFO - PROCESS | 8075 | 06:45:45 INFO - PROCESS | 8075 | [#5] yui.html Cycles:180 Average:13861.34 Median:4428.22 stddev:15454.63 (349.0%) stddev-sans-first:15466.52 06:45:45 INFO - PROCESS | 8075 | Values: 730.2 809.1 817.8 840.0 844.4 13470.1 13693.5 13701.0 13762.3 13782.3 13410.1 14711.5 15159.5 15272.8 15346.4 672.3 819.9 822.1 834.0 835.4 809.2 821.9 827.3 829.8 829.9 861.1 873.2 873.2 874.2 874.3 697.1 878.1 889.2 889.5 890.3 629.2 633.1 636.0 636.1 636.2 13567.6 13614.7 13626.9 13630.7 13639.7 12886.2 13120.6 13157.1 13186.3 13224.2 10179.4 10325.5 10710.0 11169.0 11465.0 3588.7 3619.9 3635.7 3667.6 3762.9 48827.0 49540.8 50069.2 50146.0 50268.2 10431.7 10577.2 10667.9 10738.6 10740.5 18955.6 18970.2 18974.1 19012.2 19042.8 7809.3 7978.2 8014.7 8057.2 8093.8 4357.4 4361.2 4380.1 4412.6 4428.0 3128.5 3161.7 3164.5 3165.6 3189.6 477.7 627.5 629.7 633.7 650.4 529.6 566.4 674.3 676.3 721.5 8185.0 8249.4 8336.6 8502.3 8602.4 483.8 490.8 529.3 634.3 672.7 3554.9 4428.4 4462.8 4492.6 4539.6 53152.7 54750.5 54809.5 54876.2 54909.2 48087.3 48343.3 49147.8 49622.5 50142.5 44919.8 45606.5 46009.5 46199.3 46383.3 8976.0 8992.2 9088.5 9121.7 9234.9 33417.0 33761.7 34300.8 34685.3 34751.8 39604.1 42605.0 42686.6 42785.1 42863.0 11764.9 11897.5 12072.3 12354.4 12380.1 11814.8 12214.7 12818.1 12831.0 13001.2 11530.3 11830.6 11919.9 12038.3 12404.4 11742.2 12168.7 12207.1 12368.6 12581.4 11281.4 11295.1 11418.4 11840.2 11942.5 10019.3 10289.9 10479.0 10488.2 10589.7 9425.0 9527.2 9837.5 9876.7 9939.2 06:45:45 INFO - PROCESS | 8075 | -------- Summary: end -------- 06:45:45 INFO - PROCESS | 8075 | 06:45:46 INFO - TEST-INFO | 8075: exit 0 06:45:46 INFO - TEST-OK | dromaeo_css | took 1113901ms 06:45:46 INFO - TEST-START | kraken 06:45:46 INFO - operating with platform_type : linux_ 06:45:46 INFO - Initialising browser for kraken test... 06:45:46 INFO - TEST-INFO | started process 8261 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp61JBNC/profile http://localhost:42239/getInfo.html) 06:45:50 INFO - PROCESS | 8261 | __metrics Screen width/height:1600/1200 06:45:50 INFO - PROCESS | 8261 | colorDepth:24 06:45:50 INFO - PROCESS | 8261 | Browser inner width/height: 1024/697 06:45:50 INFO - PROCESS | 8261 | __metrics 06:45:51 INFO - PROCESS | 8261 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:45:52 INFO - TEST-INFO | 8261: exit 0 06:45:52 INFO - Browser initialized. 06:45:52 INFO - Running cycle 1/1 for kraken test... 06:45:52 INFO - TEST-INFO | started process 8345 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp61JBNC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:46:04 INFO - PROCESS | 8345 | RSS: Main: 148254720 06:46:04 INFO - PROCESS | 8345 | 06:46:06 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42239/tests/kraken/driver.html?testName=audio-beat-detection) 06:46:07 INFO - PROCESS | 8345 | RSS: Main: 190877696 06:46:07 INFO - PROCESS | 8345 | 06:46:09 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42239/tests/kraken/driver.html?testName=audio-dft) 06:46:10 INFO - PROCESS | 8345 | RSS: Main: 180408320 06:46:10 INFO - PROCESS | 8345 | 06:46:13 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42239/tests/kraken/driver.html?testName=audio-fft) 06:46:14 INFO - PROCESS | 8345 | RSS: Main: 167075840 06:46:14 INFO - PROCESS | 8345 | 06:46:15 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42239/tests/kraken/driver.html?testName=audio-oscillator) 06:46:16 INFO - PROCESS | 8345 | RSS: Main: 168480768 06:46:16 INFO - PROCESS | 8345 | 06:46:18 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:46:19 INFO - PROCESS | 8345 | RSS: Main: 171335680 06:46:19 INFO - PROCESS | 8345 | 06:46:22 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42239/tests/kraken/driver.html?testName=imaging-darkroom) 06:46:23 INFO - PROCESS | 8345 | RSS: Main: 170549248 06:46:23 INFO - PROCESS | 8345 | 06:46:26 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42239/tests/kraken/driver.html?testName=imaging-desaturate) 06:46:26 INFO - PROCESS | 8345 | RSS: Main: 172425216 06:46:26 INFO - PROCESS | 8345 | 06:46:29 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42239/tests/kraken/driver.html?testName=json-parse-financial) 06:46:30 INFO - PROCESS | 8345 | RSS: Main: 169275392 06:46:30 INFO - PROCESS | 8345 | 06:46:31 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:46:32 INFO - PROCESS | 8345 | RSS: Main: 179945472 06:46:32 INFO - PROCESS | 8345 | 06:46:34 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42239/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:46:34 INFO - PROCESS | 8345 | RSS: Main: 176930816 06:46:34 INFO - PROCESS | 8345 | 06:46:36 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:46:37 INFO - PROCESS | 8345 | RSS: Main: 191795200 06:46:37 INFO - PROCESS | 8345 | 06:46:39 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:46:40 INFO - PROCESS | 8345 | RSS: Main: 197353472 06:46:40 INFO - PROCESS | 8345 | 06:46:43 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:46:43 INFO - PROCESS | 8345 | RSS: Main: 197947392 06:46:43 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | Cycle 1(1): loaded http://localhost:42239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42239/tests/kraken/driver.html?testName=ai-astar) 06:46:45 INFO - PROCESS | 8345 | RSS: Main: 259055616 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | __start_tp_report 06:46:45 INFO - PROCESS | 8345 | _x_x_mozilla_page_load 06:46:45 INFO - PROCESS | 8345 | _x_x_mozilla_page_load_details 06:46:45 INFO - PROCESS | 8345 | |i|pagename|runs| 06:46:45 INFO - PROCESS | 8345 | |0;ai-astar;110;111;106;111;113;114;102;111;111;111 06:46:45 INFO - PROCESS | 8345 | |1;audio-beat-detection;161;126;153;174;131;153;151;128;167;127 06:46:45 INFO - PROCESS | 8345 | |2;audio-dft;161;161;170;160;161;162;161;163;162;160 06:46:45 INFO - PROCESS | 8345 | |3;audio-fft;75;73;98;94;72;74;73;111;94;73 06:46:45 INFO - PROCESS | 8345 | |4;audio-oscillator;96;96;141;96;96;96;146;97;97;142 06:46:45 INFO - PROCESS | 8345 | |5;imaging-gaussian-blur;119;116;114;114;115;115;115;114;114;114 06:46:45 INFO - PROCESS | 8345 | |6;imaging-darkroom;146;146;146;146;146;145;147;145;145;145 06:46:45 INFO - PROCESS | 8345 | |7;imaging-desaturate;96;96;97;96;96;95;96;96;96;96 06:46:45 INFO - PROCESS | 8345 | |8;json-parse-financial;57;58;58;58;57;58;58;68;55;58 06:46:45 INFO - PROCESS | 8345 | |9;json-stringify-tinderbox;69;68;67;68;68;69;68;69;67;69 06:46:45 INFO - PROCESS | 8345 | |10;stanford-crypto-aes;81;84;84;84;83;83;82;83;83;83 06:46:45 INFO - PROCESS | 8345 | |11;stanford-crypto-ccm;119;116;116;125;121;121;117;119;116;128 06:46:45 INFO - PROCESS | 8345 | |12;stanford-crypto-pbkdf2;162;141;151;152;165;145;155;154;150;150 06:46:45 INFO - PROCESS | 8345 | |13;stanford-crypto-sha256-iterative;69;71;71;72;69;68;70;69;70;68 06:46:45 INFO - PROCESS | 8345 | __end_tp_report 06:46:45 INFO - PROCESS | 8345 | __start_cc_report 06:46:45 INFO - PROCESS | 8345 | _x_x_mozilla_cycle_collect,963 06:46:45 INFO - PROCESS | 8345 | __end_cc_report 06:46:45 INFO - PROCESS | 8345 | __startTimestamp1456152405669__endTimestamp 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | ------- Summary: start ------- 06:46:45 INFO - PROCESS | 8345 | Number of tests: 14 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.50 (3.1%) stddev-sans-first:3.71 06:46:45 INFO - PROCESS | 8345 | Values: 110.0 111.0 106.0 111.0 113.0 114.0 102.0 111.0 111.0 111.0 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:153.00 stddev:17.86 (11.7%) stddev-sans-first:18.22 06:46:45 INFO - PROCESS | 8345 | Values: 161.0 126.0 153.0 174.0 131.0 153.0 151.0 128.0 167.0 127.0 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#2] audio-dft Cycles:10 Average:162.10 Median:161.50 stddev:2.92 (1.8%) stddev-sans-first:3.07 06:46:45 INFO - PROCESS | 8345 | Values: 161.0 161.0 170.0 160.0 161.0 162.0 161.0 163.0 162.0 160.0 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#3] audio-fft Cycles:10 Average:83.70 Median:74.50 stddev:14.19 (19.0%) stddev-sans-first:14.70 06:46:45 INFO - PROCESS | 8345 | Values: 75.0 73.0 98.0 94.0 72.0 74.0 73.0 111.0 94.0 73.0 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:96.00 stddev:22.60 (23.5%) stddev-sans-first:23.37 06:46:45 INFO - PROCESS | 8345 | Values: 96.0 96.0 141.0 96.0 96.0 96.0 146.0 97.0 97.0 142.0 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.56 (1.4%) stddev-sans-first:0.73 06:46:45 INFO - PROCESS | 8345 | Values: 119.0 116.0 114.0 114.0 115.0 115.0 115.0 114.0 114.0 114.0 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 06:46:45 INFO - PROCESS | 8345 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 147.0 145.0 145.0 145.0 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 06:46:45 INFO - PROCESS | 8345 | Values: 96.0 96.0 97.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.00 stddev:3.47 (6.0%) stddev-sans-first:3.64 06:46:45 INFO - PROCESS | 8345 | Values: 57.0 58.0 58.0 58.0 57.0 58.0 58.0 68.0 55.0 58.0 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 06:46:45 INFO - PROCESS | 8345 | Values: 69.0 68.0 67.0 68.0 68.0 69.0 68.0 69.0 67.0 69.0 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:0.94 (1.1%) stddev-sans-first:0.67 06:46:45 INFO - PROCESS | 8345 | Values: 81.0 84.0 84.0 84.0 83.0 83.0 82.0 83.0 83.0 83.0 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:120.00 stddev:4.08 (3.4%) stddev-sans-first:4.31 06:46:45 INFO - PROCESS | 8345 | Values: 119.0 116.0 116.0 125.0 121.0 121.0 117.0 119.0 116.0 128.0 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:153.00 stddev:7.14 (4.7%) stddev-sans-first:6.69 06:46:45 INFO - PROCESS | 8345 | Values: 162.0 141.0 151.0 152.0 165.0 145.0 155.0 154.0 150.0 150.0 06:46:45 INFO - PROCESS | 8345 | 06:46:45 INFO - PROCESS | 8345 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.34 (1.9%) stddev-sans-first:1.39 06:46:45 INFO - PROCESS | 8345 | Values: 69.0 71.0 71.0 72.0 69.0 68.0 70.0 69.0 70.0 68.0 06:46:45 INFO - PROCESS | 8345 | -------- Summary: end -------- 06:46:45 INFO - PROCESS | 8345 | 06:46:46 INFO - TEST-INFO | 8345: exit 0 06:46:46 INFO - TEST-OK | kraken | took 60301ms 06:46:46 INFO - SUITE-END | took 1174s 06:46:46 INFO - Completed test suite (00:19:34) 06:46:46 INFO - Working with test: dromaeo_css 06:46:46 INFO - Generating results file: dromaeo_css 06:46:46 INFO - Working with test: kraken 06:46:46 INFO - Generating results file: kraken 06:46:46 INFO - javascript benchmark 06:46:46 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:46:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:46:46 INFO - process_Request line: dromaeo_css 6951.80 graph.html#tests=[[72,1,35]] 06:46:46 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:46:46 INFO - process_Request line: kraken 1521.60 graph.html#tests=[[232,1,35]] 06:46:46 INFO - RETURN: dromaeo_css: 6951.80 06:46:46 INFO - RETURN: kraken: 1521.60 06:46:46 INFO - javascript benchmark 06:46:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3166.8416579171035, 3168.635606905206, 3236.902892913212, 3238.498032804916, 3268.738500919926, 5129.743512824353, 5220.138677118271, 5263.078961181792, 5281.049411106, 5334.119870221413, 5203.115470370037, 5208.921866172011, 5209.244659524376, 5230.92153617696, 5282.2076688496745, 4681.83613573525, 4797.52024797521, 4871.829485967992, 4873.195922672755, 4939.629527785412, 4682.531746825324, 4808.0, 4888.951110488885, 4893.926591101136, 4992.500749925015, 4827.179379505493, 4836.540528649773, 4838.03239352131, 4845.515448455161, 4885.5358740919555, 4845.588125009378, 4848.0, 4856.101621200054, 4871.634627402959, 4903.4851340609075, 4725.22033864412, 4761.9761751223305, 4823.180059389877, 4842.15262329091, 4844.781984810692, 5105.285260063594, 5117.82087626935, 5148.3564554430695, 5158.793648254065, 5176.948230517684, 5573.944260557383, 5636.577256705764, 5644.943550564483, 5651.40660230674, 5667.263255776764, 5665.858353541194, 5687.544996400278, 5714.571407144439, 5727.2268243787385, 5776.537876969875, 5336.306280183551, 5362.517373436371, 5366.248725178478, 5368.087425137736, 5371.973140134313, 5676.489115979582, 5796.94203057964, 5802.767889284381, 5860.0, 5955.702214889238, 5626.662400255997, 5636.098224284095, 5640.858978525488, 5653.886922261614, 5661.801836935688, 5689.886202276014, 5711.914321285184, 5713.542916566665, 5715.342735585377, 5723.771049157987, 5518.144687573352, 5578.30271216098, 5579.191017302468, 5615.550755939515, 5650.011248031578, 5588.050031494656, 5601.271834661549, 5603.271574695345, 5612.719364031782, 5614.214010038598, 4269.87190384289, 4392.077663690597, 4397.84607538741, 4402.3836662867225, 4451.243288640939, 3885.4948856648457, 3916.4908561886773, 3921.686265098785, 3956.2680904032845, 3959.1092004298803, 5248.816291429782, 5288.8413347599635, 5302.390225124083, 5316.016536940601, 5352.411234764173, 5490.5882058844945, 5647.37878833328, 5660.924424359358, 5673.773049078073, 5702.54379649627, 5305.734713264398, 5307.787688492494, 5336.946630533723, 5343.65266257692, 5344.038073146871, 4885.340479035285, 4900.632452566, 4901.36282283308, 4910.189818679878, 4942.0, 5737.77048918047, 5916.230889984275, 5941.494972927263, 5943.70281485924, 5984.401559844068, 5736.368999409978, 5745.511631511368, 5746.9712651436475, 5748.770049197985, 5748.798792042258, 5725.770969161354, 5962.284525856925, 5975.492083172979, 5980.073088671263, 5982.042873140276, 5624.212610234488, 5641.802536911188, 5667.121596152603, 5673.489385955284, 5711.143328500592, 5688.175214593944, 5689.516391106802, 5730.770769169187, 5738.340090889601, 5745.052066408995, 5294.655847369909, 5589.552835773047, 5595.664260144405, 5604.551635869202, 5701.059325211294, 5490.917636235539, 5517.751701173537, 5540.556755459473, 5544.057510223352, 5545.694986775766, 5455.536279416294, 5460.071787796005, 5460.726963651881, 5461.235427040138, 5511.862203444946, 5348.625596208383, 5478.808241711521, 5546.55627549787, 5565.638233514808, 5610.9158362623775, 5327.280817089798, 5409.702466364388, 5413.9729301353245, 5443.945560544344, 5533.6126471148245], "unit": "score", "name": "dojo.html", "value": 5236.927313093665}, {"lowerIsBetter": false, "replicates": [527.0197432775037, 528.735632183908, 541.8699512117093, 552.3951273355675, 581.1050981488505, 35640.82179589102, 36281.45577816335, 36365.090872728164, 36399.0, 36420.72213500785, 40050.399244011365, 40590.594094059124, 40724.185516289734, 40761.38857917126, 40859.0, 8623.396362254645, 8791.64833406663, 8793.208611224989, 8822.779430514225, 8823.691170809023, 8492.957535212347, 8551.486910785341, 8609.39734218605, 8609.741707748777, 8617.310615150773, 8799.120087991181, 8879.422837515573, 8935.463872167658, 8943.329250306253, 8952.955235223815, 8767.51778652174, 8873.778155546099, 8908.153725396078, 8924.196822285961, 8930.508822014786, 8860.335474839412, 8975.506347150904, 8987.820243595157, 8994.730158095268, 9006.1894429501, 39426.21147577061, 40005.79997099996, 40008.199836003405, 40008.399874001916, 40066.399004014966, 2318.652202169671, 3310.2882880180637, 3359.5800524934384, 3573.8213089345427, 4050.25070361984, 26511.0, 26734.197974060808, 26817.73182268172, 26831.865840670867, 26871.462570748474, 3514.9824250878582, 3526.982365088184, 3746.8499824242604, 3751.456038874348, 3772.4529943158363, 174805.12597436932, 175202.0, 175476.0, 176844.11577942155, 176915.0, 53748.73125634347, 53812.461875380744, 54200.18699719507, 54250.0, 54277.72861135748, 57564.71217643885, 57613.42386576081, 57623.71188144032, 57678.0, 57733.0, 16254.43109491162, 16392.672146557, 16527.0, 16534.917325413535, 16557.751633725504, 12850.807237891438, 12854.228746275254, 12876.484940602459, 12882.033847461478, 12962.092653514164, 18763.544662910215, 19138.425847224604, 19306.227750890088, 19393.32123375675, 19440.125194366286, 7502.512336698097, 7759.7672069838, 7857.489263197874, 7967.243111904476, 7978.481398709066, 936.5083331251011, 964.3827950111934, 965.0590674092844, 1012.9696109116738, 1045.273534893242, 24234.87882560576, 24276.87861560681, 24329.148479803123, 24383.634245486333, 24439.511209775705, 904.1681652879366, 956.5982287439153, 1054.082947835388, 1070.1331921143899, 1171.841801356823, 12698.42857071434, 14933.0, 15215.17519838491, 15791.842081579267, 15917.442889498812, 306707.0, 306903.0, 310546.0, 311084.0, 311386.0, 43682.12635747267, 49987.0, 51151.48848511467, 51808.48191518112, 52118.0, 1315.2305901047803, 1323.126736354021, 1338.5783478204335, 1342.5301144599507, 1362.9011322563142, 24725.0, 24876.875615621808, 26106.608400874382, 26809.463810723286, 27157.185284441497, 41362.0, 47127.76436117935, 48222.517774821805, 48592.75703621459, 48791.268130977354, 183046.0, 185051.0, 186893.0, 187180.0, 187391.0, 29192.562111567917, 29525.852370738008, 29545.40909181761, 29548.852255739443, 29635.110946671633, 41233.0, 42280.57719422766, 42463.5753642472, 43094.35358469563, 43312.566874332115, 35486.46770298499, 35690.0, 35734.28531429409, 35849.82075089608, 36585.268294634494, 36210.27579448344, 36260.91217263486, 36416.635833641325, 36577.45133823048, 36668.083297917765, 34603.30793384169, 35569.46645800264, 35643.46534801928, 35689.82155089208, 35735.82132089323, 29932.850335748182, 32670.34659306848, 32953.17617059593, 33343.83328083441, 33375.49936750902, 24341.0, 24411.26766197017, 24957.376065598506, 25310.240692779247, 25421.364465888502], "unit": "score", "name": "ext.html", "value": 17661.24371778213}, {"lowerIsBetter": false, "replicates": [350.59156083163117, 350.81808001427066, 353.7877273635818, 355.479222938395, 359.72121605755535, 16710.33158673653, 16953.21991190926, 18226.817731822695, 18472.261109555635, 18481.260749570036, 16851.494455166336, 16909.070001149932, 17067.0, 17110.31558737652, 17120.657586848287, 4125.2780763366445, 5237.266782650413, 5275.683458992454, 6096.055111457731, 6102.877942441149, 5675.631083979549, 6065.181200537915, 6078.452939235468, 6084.6957652117435, 6087.269527656666, 5785.479306862381, 5974.133750606159, 5979.940200598004, 6007.339192688801, 6009.0, 4020.3165461871404, 5797.217375654317, 5973.522118230553, 6002.579819412643, 6005.549583781234, 5278.498542638482, 5302.443243459458, 5304.549113325372, 5338.306020217386, 5342.091844386464, 19151.23395064196, 20675.689864652042, 21477.463063423384, 21482.140714371562, 21617.78382216189, 2235.396442960408, 2260.8530445520987, 2328.1502251678185, 2800.425912687894, 3050.710182532678, 13521.32393380327, 13601.523946661919, 13706.794398084037, 13913.791293130611, 14126.505572305023, 1902.6004539046817, 1927.7012063130237, 1963.4796778853615, 2028.6247044296852, 2060.7527096748486, 68836.65581672109, 71545.0, 72080.0, 72092.2790772096, 73785.0, 14726.821854251633, 15600.609984750472, 15682.137482438575, 15789.842101579066, 15830.28763705636, 24598.262052138463, 25052.624210636855, 25098.498030039296, 25124.0, 25140.12009579656, 8800.207981281716, 8852.0, 8892.0, 8915.643374265086, 9044.954775226213, 6606.405423511907, 6652.301508341651, 6659.567128136752, 6908.0674108995645, 7473.916282139168, 7789.805254868674, 7929.643166057541, 7930.76207713758, 7948.761537153895, 7965.362770978308, 3033.393321335742, 3044.1932887784756, 3048.116046346579, 3070.923226919345, 3117.8441077946013, 835.7325655790089, 948.4404201521136, 972.6887396033202, 1006.8691070160978, 1040.7086015915556, 13138.343082845819, 15813.525594232191, 16453.341866325452, 16552.83447165513, 17189.226484808212, 946.7822400847843, 947.3131385197753, 960.8126415348939, 981.283662926068, 1012.099231683802, 6987.8602427951155, 9154.40496367734, 9312.115349041831, 9809.074785252667, 9822.459764713009, 435743.0, 436021.0, 436453.0, 436829.0, 446788.0, 45768.313475297895, 50053.49946500561, 70972.0, 72657.2734272661, 73130.0, 1034.2966782587762, 1041.729150420911, 1044.6604853422668, 1056.6618682021833, 1059.2796898109204, 15488.922555387151, 15591.064536127415, 15752.448664297153, 15771.23223364193, 15786.0, 30764.846175768977, 31423.685763142075, 32052.0, 34815.477767833, 35314.0, 42451.56014719023, 42762.786186070116, 42806.35790463208, 42898.571014290705, 43120.35319470148, 7138.393236574741, 7138.85722285541, 7256.15441766778, 7361.815954600964, 7377.4098072155175, 9407.905920940977, 11789.646310610695, 12154.0, 12257.203281786655, 12580.811287830507, 9857.35927164732, 9909.55407006672, 10075.496225188857, 10831.404272765074, 11010.339379637247, 7647.961760191163, 9870.901290986998, 9990.800183996425, 10207.642732504326, 10541.894581054092, 5459.399466058651, 6474.866898292874, 10118.59525618967, 10560.577576897145, 10610.0, 7502.249775022454, 7511.887321690288, 7576.24237576238, 7622.5426474411715, 7871.173526779606, 8959.238464730572, 10362.740931476774, 10387.896121038693, 10463.424511651932, 10583.735406614896], "unit": "score", "name": "jquery.html", "value": 8931.957381273507}, {"lowerIsBetter": false, "replicates": [1314.4413624209722, 1490.716763814875, 1500.3848422146918, 1669.4240487031977, 1821.1258595873987, 7462.888056679148, 7649.04386951631, 7655.92344076559, 7675.232476752315, 7689.961550192255, 7761.185075567055, 7941.801454963629, 7953.045634523865, 7953.483023603461, 7963.402744794134, 2025.6860186671015, 2078.7297651305385, 2302.735185453669, 2338.7310459297187, 2370.525894821034, 2363.869987150706, 2364.834461587681, 2373.1575290771784, 2374.7625237476286, 2386.1648423051965, 2253.324002799162, 2297.9425514362106, 2299.908003679851, 2304.389336825734, 2307.6423154411095, 2288.519410923708, 2324.4537533679654, 2324.569954558412, 2324.7094113235844, 2328.4178955261186, 2320.918767843117, 2327.080803082773, 2327.359976006595, 2341.2976107167783, 2346.7887890089974, 7688.115866675348, 7708.306252437307, 7759.728409505697, 7763.611819409007, 7784.805379865492, 4783.162946484351, 4903.289023091632, 4912.508749125094, 4961.578265847407, 4962.330085438456, 3203.3112880730755, 3266.8203248821305, 3282.852271647758, 3291.753118516097, 3322.4684050551796, 1083.1226706367868, 1100.27381927928, 1110.9277896936753, 1120.1207052463858, 1128.5598616539555, 10898.673039808818, 10966.396848173346, 10976.396298203596, 10977.28647637901, 10980.396078215696, 4360.890977725582, 4439.933400998988, 4441.800118994653, 4527.547245275446, 4527.592516673515, 9345.719628411158, 9362.485063321446, 9362.578683959102, 9374.296927730311, 9394.624215031323, 4244.0, 4886.657933944661, 4888.95111048885, 4891.9755401222765, 4892.021595680878, 4218.8523401680795, 4248.256555102845, 4285.550017248206, 4298.527162012176, 4314.9784251078545, 3766.642168993941, 3779.281936432069, 3782.470454136423, 3823.9044023899623, 3837.1558257183374, 1183.644906528038, 1189.0962868220215, 1203.5366383942246, 1210.8304837322783, 1227.1287385955893, 1308.1758492150075, 1327.6282640860575, 1329.7539955108336, 1344.9394777235048, 1351.2365513485047, 7295.89056164158, 7333.963330183422, 7446.292602202782, 7459.142198647117, 7465.477416580788, 474.3833017077785, 475.79303003193723, 478.37333093647436, 478.39005268283216, 488.64329039801146, 5834.620749651259, 5882.823515294463, 5892.263467066617, 5927.31835838884, 5936.257967754031, 8903.599338029804, 9501.23990080792, 9512.714618561455, 9519.428834269966, 9523.190528804991, 8983.46099234048, 9111.362204645611, 9330.58012389444, 9332.786737724053, 9337.439753614804, 7165.89251161233, 7312.707491700273, 7379.2251813558805, 7383.335499805044, 7384.335409813142, 7368.070037477553, 7369.557826530426, 7435.591042492715, 7445.516041457288, 7445.590492522963, 8608.354373422144, 8650.1349865013, 8724.083971182934, 8843.115688431106, 8844.071372505794, 8882.15619516145, 8906.599203036008, 9027.09729027092, 9035.728928132166, 9044.773880652772, 5904.291485021825, 6692.665366731741, 6820.283870193558, 7015.754448594274, 7110.7511237106455, 7439.962800185965, 7463.738769143271, 7470.925290747023, 7499.212582678741, 7506.512076714996, 6483.189601299838, 6600.933990660032, 6632.701528431328, 6669.799906002828, 6879.243283238739, 6609.0, 6650.467962562887, 6655.101561289358, 6726.831829204309, 6756.425703815231, 6949.061876646588, 6983.580985140908, 6997.615131167631, 7077.469189810682, 7093.397061249645, 6432.710528026344, 6441.581297215666, 6483.546151769519, 6488.156539649815, 6493.967530162319, 6654.234763002317, 6664.200295964515, 6670.866582668416, 6675.365840245169, 6686.866262674816], "unit": "score", "name": "mootools.html", "value": 4466.719743047989}, {"lowerIsBetter": false, "replicates": [335.381221646063, 337.7163182926343, 340.2378671775221, 341.8888861120136, 346.5425638157631, 5696.088625819859, 5840.299164100314, 5888.528917686585, 5904.940950590498, 5936.198613187218, 5857.531397488201, 5938.109283607461, 5950.166976623276, 5962.135490353896, 5962.135490353907, 4626.05165940983, 4626.282926146453, 4627.23650597651, 4632.559906808865, 4636.4436267647925, 4368.541303163154, 4418.5581441855875, 4538.95604011076, 4549.385832912548, 4628.333799832058, 4518.638508919295, 4520.954790452102, 4533.161365147442, 4543.886402839939, 4547.7953492092765, 4532.13889361022, 4539.273716205391, 4542.636589072899, 4544.1593305238475, 4551.431071116111, 4010.017545701293, 4020.2562525932794, 4021.8190181441905, 4028.254772867029, 4029.37544680575, 5539.224508568804, 5555.055640541118, 5561.636304570541, 5564.1931919871795, 5576.888462230773, 5279.577633789288, 5280.102382594968, 5286.312779338661, 5287.101192797195, 5287.603429742746, 6009.57932944694, 6148.1392605035335, 6183.350748171422, 6184.0, 6192.907106393408, 4328.026194106333, 4331.350297455407, 4334.068175342285, 4334.891627709301, 4339.0, 6382.425581697669, 6467.708953097075, 6547.279799222129, 6587.176602924586, 6599.736010559572, 4446.5331140230455, 4460.219461594273, 4466.950266687326, 4469.374287599739, 4471.530489298641, 4499.235130027903, 4502.257127573914, 4503.662225333113, 4503.7522936238165, 4508.143452743968, 5222.529972302511, 5227.869303267449, 5230.947690523046, 5232.895342093137, 5243.5542978847225, 6046.637201767908, 6116.29662588808, 6254.655993920378, 6272.1219029335925, 6330.873382532323, 1542.2365928865283, 1578.4633224703655, 1588.3805315926797, 1592.235726851118, 1596.7684685720506, 1039.9220058495644, 1041.7135287795916, 1061.6602687140196, 1063.3088492479794, 1064.8668916385452, 5973.940260597426, 5975.910361344583, 5985.25184351956, 5988.550858685616, 5997.250343707036, 6442.387973142544, 6459.61242325462, 6459.806205813833, 6465.094886715863, 6465.612063276219, 5939.495142912814, 5979.4618484336615, 5993.730282137314, 5998.580099393088, 6001.879962400728, 3462.307538492312, 3491.581010278732, 3492.0571445709516, 3494.1963348430004, 3496.5104885316077, 6599.73601055962, 6774.153230846145, 6778.966105169541, 6876.415504682158, 6880.449564034865, 6664.5334826561675, 6702.329767023356, 6707.262201157869, 6734.494912881455, 6742.831429214309, 6838.760643377458, 6844.9732540119385, 6845.110135682429, 6845.8973115403305, 6851.2121106071445, 6520.347965203442, 6526.216853977553, 6528.118703974903, 6528.183977002875, 6528.281888992302, 6275.905861411991, 6391.808245752635, 6461.64460954652, 6472.061551075162, 6484.708188131451, 6851.9657401712675, 6854.7600833972565, 6857.0, 6857.862842743018, 6862.9313706862295, 4457.977710111429, 4500.752458614807, 4502.189605870974, 4508.278675411918, 4513.819447222074, 6285.308616052139, 6431.839204019937, 6557.311482294291, 6567.2447668518735, 6567.737290508326, 6235.098295020062, 6335.429811317003, 6353.205849268841, 6369.20384951881, 6373.426391624776, 6338.0, 6339.049142628643, 6343.873122537431, 6347.492200624031, 6350.206224221973, 6238.095476156022, 6240.594361366497, 6246.031865060922, 6246.625202487865, 6247.156633854372, 6206.937930620636, 6360.109584658244, 6364.840878978062, 6365.809025729235, 6401.135846660642, 6228.408301211378, 6246.344133865879, 6257.812265632038, 6267.592606480564, 6269.561130720988], "unit": "score", "name": "prototype.html", "value": 4754.114097603921}, {"lowerIsBetter": false, "replicates": [730.2150188547312, 809.1261437647341, 817.8486979908718, 840.0045945554515, 844.4046946902432, 13470.124441911268, 13693.520726774565, 13701.040927135104, 13762.311884405777, 13782.310884455776, 13410.128341657786, 14711.48509802157, 15159.469418570352, 15272.770908436383, 15346.386144554204, 672.2705864137392, 819.8688209886419, 822.1080128061061, 833.954132522711, 835.3734698975768, 809.1746418652971, 821.8602837517636, 827.2720006394395, 829.8381815545971, 829.8838162657232, 861.1388611388611, 873.1661263493348, 873.2184694698241, 874.1826392323167, 874.3180319350917, 697.1425147069108, 878.0955615715791, 889.244142478891, 889.5374405309203, 890.3278025091015, 629.175779728557, 633.1168020611268, 636.0427556527443, 636.0903907412398, 636.2174525333819, 13567.59297221085, 13614.727705445935, 13626.93186534061, 13630.659233519142, 13639.659008524766, 12886.226826390446, 13120.60638180856, 13157.144785588906, 13186.274754888573, 13224.206547607078, 10179.389236645826, 10325.48372581368, 10710.0, 11169.0, 11465.0, 3588.730845186595, 3619.9457008144636, 3635.709143268532, 3667.5960963951243, 3762.9435558466644, 48827.0, 49540.75229623865, 50069.24896126561, 50146.0, 50268.24597631038, 10431.68704938853, 10577.153827693766, 10667.893321066846, 10738.570457181626, 10740.462976851126, 18955.620887582172, 18970.24119035223, 18974.14616342268, 19012.239510419706, 19042.80957190438, 7809.297163255221, 7978.162292959272, 8014.719484818003, 8057.234562716532, 8093.838123237502, 4357.433533640607, 4361.214981303396, 4380.123975204971, 4412.580804823537, 4428.0, 3128.483800172946, 3161.68383161682, 3164.4620414529586, 3165.572647692532, 3189.6172459304566, 477.6632474105747, 627.5324882962223, 629.6788637794758, 633.6514916795744, 650.417876000986, 529.6345521590091, 566.4448840136689, 674.2583158525582, 676.2594958520413, 721.5346101764437, 8184.959075204586, 8249.422540422232, 8336.62485188168, 8502.319814414956, 8602.39783215169, 483.7653737937098, 490.77914938277917, 529.317180836724, 634.3149398649448, 672.7174586673609, 3554.9466757998653, 4428.446444194476, 4462.799174037176, 4492.550744925481, 4539.6368290536675, 53152.73423632934, 54750.45249547533, 54809.45190548043, 54876.17685734717, 54909.1763623546, 48087.278690819665, 48343.274850877264, 49147.75426122847, 49622.50377496179, 50142.498575013786, 44919.77540112279, 45606.54393456089, 46009.539904601195, 46199.30701039487, 46383.30425043627, 8975.955120224357, 8992.190702836777, 9088.500132492776, 9121.739564111622, 9234.861477077984, 33417.0, 33761.66238337683, 34300.828495857364, 34685.306293874484, 34751.82624086965, 39604.10887006096, 42605.0, 42686.57313426826, 42785.14429711451, 42863.0, 11764.88235117672, 11897.524099035942, 12072.33602151855, 12354.382280886099, 12380.133390662568, 11814.763704726029, 12214.694632634255, 12818.102732808615, 12831.0, 13001.15492492985, 11530.250533715282, 11830.585929492427, 11919.940400297943, 12038.277703337477, 12404.441800119197, 11742.150267024803, 12168.695782605506, 12207.145499814927, 12368.628941131781, 12581.433835477608, 11281.379524126252, 11295.096392288762, 11418.371989540656, 11840.230385024946, 11942.462589183333, 10019.298649094784, 10289.897101029193, 10479.0, 10488.213383996079, 10589.735256618338, 9424.95287523558, 9527.237820974444, 9837.458939758382, 9876.703698889045, 9939.204863611038], "unit": "score", "name": "yui.html", "value": 6433.472654540092}], "name": "dromaeo_css", "value": 6951.805350195498}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 111.0, 113.0, 114.0, 102.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [161.0, 126.0, 153.0, 174.0, 131.0, 153.0, 151.0, 128.0, 167.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 170.0, 160.0, 161.0, 162.0, 161.0, 163.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 98.0, 94.0, 72.0, 74.0, 73.0, 111.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 141.0, 96.0, 96.0, 96.0, 146.0, 97.0, 97.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 114.0, 114.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 58.0, 58.0, 57.0, 58.0, 58.0, 68.0, 55.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 69.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 84.0, 84.0, 83.0, 83.0, 82.0, 83.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 116.0, 125.0, 121.0, 121.0, 117.0, 119.0, 116.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.8}, {"lowerIsBetter": true, "replicates": [162.0, 141.0, 151.0, 152.0, 165.0, 145.0, 155.0, 154.0, 150.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.5}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 71.0, 72.0, 69.0, 68.0, 70.0, 69.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1521.6000000000001}]} 06:46:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1521.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6951.80"}}} 06:46:47 INFO - Return code: 0 06:46:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:46:47 INFO - # TBPL SUCCESS # 06:46:47 INFO - Running post-action listener: _resource_record_post_action 06:46:47 INFO - Running post-run listener: _resource_record_post_run 06:46:48 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544190464; Read time: 48; Write time: 624264 06:46:48 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 247939072; Read time: 0; Write time: 413044 06:46:48 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296251392; Read time: 48; Write time: 211220 06:46:48 INFO - Running post-run listener: _upload_blobber_files 06:46:48 INFO - Blob upload gear active. 06:46:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:46:48 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:46:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:46:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:46:48 INFO - (blobuploader) - INFO - Open directory for files ... 06:46:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:46:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:46:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:46:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:46:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:46:49 INFO - (blobuploader) - INFO - Done attempting. 06:46:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:46:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:46:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:46:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:46:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:46:50 INFO - (blobuploader) - INFO - Done attempting. 06:46:50 INFO - (blobuploader) - INFO - Iteration through files over. 06:46:50 INFO - Return code: 0 06:46:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:46:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:46:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdcc30b776fea858bd3599685dda983d3ceee2ce00e465edf3049e30e7e98798ac2b8bab4ffeef5938a6d9e68cf4ee989d0d5f5a0df064447f6487b909bf6083", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a538fe90528f3eb54354cd99d1dc61bba27b75c2c314a0627686604ee29f6bfcc9bcb4dfb53f23f2b5d4f053c8b3fea567909e3ecb4fc7e89305195ec4005a0c"} 06:46:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:46:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:46:50 INFO - Contents: 06:46:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdcc30b776fea858bd3599685dda983d3ceee2ce00e465edf3049e30e7e98798ac2b8bab4ffeef5938a6d9e68cf4ee989d0d5f5a0df064447f6487b909bf6083", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a538fe90528f3eb54354cd99d1dc61bba27b75c2c314a0627686604ee29f6bfcc9bcb4dfb53f23f2b5d4f053c8b3fea567909e3ecb4fc7e89305195ec4005a0c"} 06:46:50 INFO - Running post-run listener: copy_logs_to_upload_dir 06:46:50 INFO - Copying logs to upload dir... 06:46:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:46:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.896919 ========= master_lag: 1.35 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-22 06:46:50.543154) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 06:46:50.550587) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdcc30b776fea858bd3599685dda983d3ceee2ce00e465edf3049e30e7e98798ac2b8bab4ffeef5938a6d9e68cf4ee989d0d5f5a0df064447f6487b909bf6083", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a538fe90528f3eb54354cd99d1dc61bba27b75c2c314a0627686604ee29f6bfcc9bcb4dfb53f23f2b5d4f053c8b3fea567909e3ecb4fc7e89305195ec4005a0c"} build_url:https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdcc30b776fea858bd3599685dda983d3ceee2ce00e465edf3049e30e7e98798ac2b8bab4ffeef5938a6d9e68cf4ee989d0d5f5a0df064447f6487b909bf6083", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a538fe90528f3eb54354cd99d1dc61bba27b75c2c314a0627686604ee29f6bfcc9bcb4dfb53f23f2b5d4f053c8b3fea567909e3ecb4fc7e89305195ec4005a0c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 06:46:50.577026) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:46:50.580373) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456149765.751896-593036607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:46:50.631867) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 06:46:50.632174) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 06:46:50.632474) ========= ========= Total master_lag: 1.62 =========