builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1458935719.02 results: success (0) buildid: 20160325103025 builduid: 94ee88abf95d45738fece2868f46988f revision: b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.023584) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.023988) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.024283) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006281 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.050156) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.050445) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.066091) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.066392) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.132391) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.132653) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.132987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.133325) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-25 12:55:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.0M=0s 2016-03-25 12:55:20 (67.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093224 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.246086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.246433) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023307 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.297855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.298158) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2 --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 b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2 --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=a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-25 12:55:20,462 truncating revision to first 12 chars 2016-03-25 12:55:20,462 Setting DEBUG logging. 2016-03-25 12:55:20,462 attempt 1/10 2016-03-25 12:55:20,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b2dbee5ca727?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 12:55:20,734 unpacking tar archive at: mozilla-central-b2dbee5ca727/testing/mozharness/ program finished with exit code 0 elapsedTime=0.576627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.889444) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.889982) ========= echo b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2'] 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=a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2 program finished with exit code 0 elapsedTime=0.004346 script_repo_revision: 'b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.942945) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.943429) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 12:55:19.958602) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-03-25 12:55:19.959045) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:55:21 INFO - MultiFileLogger online at 20160325 12:55:21 in /builds/slave/test-pgo 12:55:21 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 12:55:21 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:55:21 INFO - {'append_to_log': False, 12:55:21 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:55:21 INFO - 'blob_upload_branch': 'Firefox', 12:55:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:55:21 INFO - 'branch': 'Firefox', 12:55:21 INFO - 'buildbot_json_path': 'buildprops.json', 12:55:21 INFO - 'config_files': ('talos/linux_config.py',), 12:55:21 INFO - 'default_actions': ('clobber', 12:55:21 INFO - 'read-buildbot-config', 12:55:21 INFO - 'download-and-extract', 12:55:21 INFO - 'populate-webroot', 12:55:21 INFO - 'create-virtualenv', 12:55:21 INFO - 'install', 12:55:21 INFO - 'run-tests'), 12:55:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:55:21 INFO - 'download_minidump_stackwalk': True, 12:55:21 INFO - 'download_symbols': 'ondemand', 12:55:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:55:21 INFO - 'tooltool.py': '/tools/tooltool.py', 12:55:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:55:21 INFO - '/tools/misc-python/virtualenv.py')}, 12:55:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:55:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:55:21 INFO - 'installer_path': 'installer.exe', 12:55:21 INFO - 'log_level': 'info', 12:55:21 INFO - 'log_name': 'talos', 12:55:21 INFO - 'log_to_console': True, 12:55:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:55:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:55:21 INFO - 'opt_config_files': (), 12:55:21 INFO - 'pip_index': False, 12:55:21 INFO - 'sps_profile': False, 12:55:21 INFO - 'sps_profile_interval': 0, 12:55:21 INFO - 'suite': 'dromaeojs', 12:55:21 INFO - 'system_bits': '32', 12:55:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:55:21 INFO - 'title': 'talos-linux64-ix-062', 12:55:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:55:21 INFO - 'use_talos_json': True, 12:55:21 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:55:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:55:21 INFO - 'work_dir': 'build'} 12:55:21 INFO - ##### 12:55:21 INFO - ##### Running clobber step. 12:55:21 INFO - ##### 12:55:21 INFO - Running pre-action listener: _resource_record_pre_action 12:55:21 INFO - Running main action method: clobber 12:55:21 INFO - rmtree: /builds/slave/test-pgo/build 12:55:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:55:22 INFO - Running post-action listener: _resource_record_post_action 12:55:22 INFO - ##### 12:55:22 INFO - ##### Running read-buildbot-config step. 12:55:22 INFO - ##### 12:55:22 INFO - Running pre-action listener: _resource_record_pre_action 12:55:22 INFO - Running main action method: read_buildbot_config 12:55:22 INFO - Using buildbot properties: 12:55:22 INFO - { 12:55:22 INFO - "project": "", 12:55:22 INFO - "product": "firefox", 12:55:22 INFO - "script_repo_revision": "production", 12:55:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:55:22 INFO - "repository": "", 12:55:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 12:55:22 INFO - "buildid": "20160325103025", 12:55:22 INFO - "pgo_build": "True", 12:55:22 INFO - "basedir": "/builds/slave/test-pgo", 12:55:22 INFO - "buildnumber": 383, 12:55:22 INFO - "slavename": "talos-linux64-ix-062", 12:55:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:55:22 INFO - "platform": "ubuntu64_hw", 12:55:22 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 12:55:22 INFO - "branch": "mozilla-central", 12:55:22 INFO - "repo_path": "mozilla-central", 12:55:22 INFO - "revision": "b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2", 12:55:22 INFO - "stage_platform": "linux64-pgo", 12:55:22 INFO - "builduid": "94ee88abf95d45738fece2868f46988f", 12:55:22 INFO - "slavebuilddir": "test" 12:55:22 INFO - } 12:55:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:55:22 INFO - Running post-action listener: _resource_record_post_action 12:55:22 INFO - ##### 12:55:22 INFO - ##### Running download-and-extract step. 12:55:22 INFO - ##### 12:55:22 INFO - Running pre-action listener: _resource_record_pre_action 12:55:22 INFO - Running main action method: download_and_extract 12:55:22 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:22 INFO - https://queue.taskcluster.net/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:55:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:55:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:55:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:55:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:55:35 INFO - Downloaded 1361 bytes. 12:55:35 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:55:35 INFO - Using the following test package requirements: 12:55:35 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:55:35 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:55:35 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:55:35 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:35 INFO - u'jsshell-linux-x86_64.zip'], 12:55:35 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:55:35 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:55:35 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:55:35 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:55:35 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:55:35 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:55:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:35 INFO - https://queue.taskcluster.net/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:55:52 INFO - Downloaded 23655429 bytes. 12:55:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:55:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:55:53 INFO - Return code: 0 12:55:53 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:53 INFO - https://queue.taskcluster.net/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:55:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:55:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:55:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:55:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:55:55 INFO - Downloaded 23655429 bytes. 12:55:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:55:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:55:57 INFO - Return code: 0 12:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:57 INFO - https://queue.taskcluster.net/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:55:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:55:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:55:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:55:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:55:58 INFO - Downloaded 10847531 bytes. 12:55:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:55:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 12:55:58 INFO - Return code: 0 12:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:58 INFO - https://queue.taskcluster.net/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:55:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:55:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:55:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:55:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:56:02 INFO - Downloaded 57719496 bytes. 12:56:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:56:02 INFO - mkdir: /builds/slave/test-pgo/properties 12:56:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:56:02 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:56:02 INFO - Contents: 12:56:02 INFO - build_url:https://queue.taskcluster.net/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:56:03 INFO - Running post-action listener: _resource_record_post_action 12:56:03 INFO - Running post-action listener: set_extra_try_arguments 12:56:03 INFO - ##### 12:56:03 INFO - ##### Running populate-webroot step. 12:56:03 INFO - ##### 12:56:03 INFO - Running pre-action listener: _resource_record_pre_action 12:56:03 INFO - Running main action method: populate_webroot 12:56:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:56:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:56:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:56:03 INFO - '--tppagecycles', 12:56:03 INFO - '7'], 12:56:03 INFO - 'tests': ['tsvgm']}}, 12:56:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:56:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:56:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:56:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:56:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:56:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:56:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:03 INFO - 'talos_options': ['--e10s'], 12:56:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:03 INFO - 'tests': ['damp', 'tps']}, 12:56:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:03 INFO - 'talos_options': ['--e10s'], 12:56:03 INFO - 'tests': ['damp', 'tps']}, 12:56:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:56:03 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 12:56:03 INFO - 'tests': ['dromaeo_dom']}, 12:56:03 INFO - 'other': {'tests': ['a11yr', 12:56:03 INFO - 'ts_paint', 12:56:03 INFO - 'tpaint', 12:56:03 INFO - 'sessionrestore', 12:56:03 INFO - 'sessionrestore_no_auto_restore', 12:56:03 INFO - 'tabpaint']}, 12:56:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:56:03 INFO - 'tests': ['a11yr', 12:56:03 INFO - 'ts_paint', 12:56:03 INFO - 'tpaint', 12:56:03 INFO - 'sessionrestore', 12:56:03 INFO - 'sessionrestore_no_auto_restore', 12:56:03 INFO - 'tabpaint']}, 12:56:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:56:03 INFO - 'tests': ['a11yr', 12:56:03 INFO - 'ts_paint', 12:56:03 INFO - 'tpaint', 12:56:03 INFO - 'sessionrestore', 12:56:03 INFO - 'sessionrestore_no_auto_restore', 12:56:03 INFO - 'tabpaint']}, 12:56:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:56:03 INFO - 'tests': ['a11yr', 12:56:03 INFO - 'ts_paint', 12:56:03 INFO - 'tpaint', 12:56:03 INFO - 'sessionrestore', 12:56:03 INFO - 'sessionrestore_no_auto_restore', 12:56:03 INFO - 'tabpaint']}, 12:56:03 INFO - 'other_l64': {'tests': ['a11yr', 12:56:03 INFO - 'ts_paint', 12:56:03 INFO - 'tpaint', 12:56:03 INFO - 'sessionrestore', 12:56:03 INFO - 'sessionrestore_no_auto_restore', 12:56:03 INFO - 'tabpaint']}, 12:56:03 INFO - 'other_nol64': {'tests': ['a11yr', 12:56:03 INFO - 'ts_paint', 12:56:03 INFO - 'tpaint', 12:56:03 INFO - 'sessionrestore', 12:56:03 INFO - 'sessionrestore_no_auto_restore', 12:56:03 INFO - 'tabpaint']}, 12:56:03 INFO - 'svgr': {'tests': ['tsvgx', 12:56:03 INFO - 'tsvgr_opacity', 12:56:03 INFO - 'tart', 12:56:03 INFO - 'tscrollx', 12:56:03 INFO - 'cart']}, 12:56:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:56:03 INFO - 'tests': ['tsvgx', 12:56:03 INFO - 'tsvgr_opacity', 12:56:03 INFO - 'tart', 12:56:03 INFO - 'tscrollx', 12:56:03 INFO - 'cart']}, 12:56:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:03 INFO - 'tests': ['tp5o']}, 12:56:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:03 INFO - 'talos_options': ['--e10s'], 12:56:03 INFO - 'tests': ['tp5o']}, 12:56:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:03 INFO - 'talos_options': ['--xperf_path', 12:56:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:03 INFO - 'tests': ['tp5n']}, 12:56:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:03 INFO - 'talos_options': ['--e10s', 12:56:03 INFO - '--xperf_path', 12:56:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:03 INFO - 'tests': ['tp5n']}}, 12:56:03 INFO - 'talos.zip': {'path': '', 12:56:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:56:03 INFO - Running post-action listener: _resource_record_post_action 12:56:03 INFO - ##### 12:56:03 INFO - ##### Running create-virtualenv step. 12:56:03 INFO - ##### 12:56:03 INFO - Running pre-action listener: _resource_record_pre_action 12:56:03 INFO - Running main action method: create_virtualenv 12:56:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:56:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 12:56:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:56:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:56:03 INFO - Using real prefix '/usr' 12:56:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:56:03 INFO - Installing distribute.............................................................................................................................................................................................done. 12:56:05 INFO - Installing pip.................done. 12:56:05 INFO - Return code: 0 12:56:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:05 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 0x7f074fd7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af21d0>, '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 0x1af5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af5be0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:05 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 12:56:05 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 12:56:05 INFO - Using env: {'DISPLAY': ':0', 12:56:05 INFO - 'HOME': '/home/cltbld', 12:56:05 INFO - 'LANG': 'en_US.UTF-8', 12:56:05 INFO - 'LANGUAGE': 'en_US:en', 12:56:05 INFO - 'LOGNAME': 'cltbld', 12:56:05 INFO - 'MAIL': '/var/mail/cltbld', 12:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:05 INFO - 'MOZ_NO_REMOTE': '1', 12:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:05 INFO - 'NO_EM_RESTART': '1', 12:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:05 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:05 INFO - 'SHELL': '/bin/bash', 12:56:05 INFO - 'SHLVL': '1', 12:56:05 INFO - 'TERM': 'linux', 12:56:05 INFO - 'TMOUT': '86400', 12:56:05 INFO - 'USER': 'cltbld', 12:56:05 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 12:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:05 INFO - '_': '/tools/buildbot/bin/python'} 12:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:56:05 INFO - Cleaning up... 12:56:05 INFO - Return code: 0 12:56:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:05 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 0x7f074fd7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af21d0>, '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 0x1af5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af5be0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:05 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 12:56:05 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 12:56:05 INFO - Using env: {'DISPLAY': ':0', 12:56:05 INFO - 'HOME': '/home/cltbld', 12:56:05 INFO - 'LANG': 'en_US.UTF-8', 12:56:05 INFO - 'LANGUAGE': 'en_US:en', 12:56:05 INFO - 'LOGNAME': 'cltbld', 12:56:05 INFO - 'MAIL': '/var/mail/cltbld', 12:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:05 INFO - 'MOZ_NO_REMOTE': '1', 12:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:05 INFO - 'NO_EM_RESTART': '1', 12:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:05 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:05 INFO - 'SHELL': '/bin/bash', 12:56:05 INFO - 'SHLVL': '1', 12:56:05 INFO - 'TERM': 'linux', 12:56:05 INFO - 'TMOUT': '86400', 12:56:05 INFO - 'USER': 'cltbld', 12:56:05 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 12:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:05 INFO - '_': '/tools/buildbot/bin/python'} 12:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:06 INFO - Downloading/unpacking psutil>=0.7.1 12:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:56:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:08 INFO - Installing collected packages: psutil 12:56:08 INFO - Running setup.py install for psutil 12:56:08 INFO - building 'psutil._psutil_linux' extension 12:56:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:56:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:56:08 INFO - building 'psutil._psutil_posix' extension 12:56:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:56:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:56:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:08 INFO - Successfully installed psutil 12:56:08 INFO - Cleaning up... 12:56:08 INFO - Return code: 0 12:56:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:08 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 0x7f074fd7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af21d0>, '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 0x1af5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af5be0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:08 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 12:56:08 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 12:56:08 INFO - Using env: {'DISPLAY': ':0', 12:56:08 INFO - 'HOME': '/home/cltbld', 12:56:08 INFO - 'LANG': 'en_US.UTF-8', 12:56:08 INFO - 'LANGUAGE': 'en_US:en', 12:56:08 INFO - 'LOGNAME': 'cltbld', 12:56:08 INFO - 'MAIL': '/var/mail/cltbld', 12:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:08 INFO - 'MOZ_NO_REMOTE': '1', 12:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:08 INFO - 'NO_EM_RESTART': '1', 12:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:08 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:08 INFO - 'SHELL': '/bin/bash', 12:56:08 INFO - 'SHLVL': '1', 12:56:08 INFO - 'TERM': 'linux', 12:56:08 INFO - 'TMOUT': '86400', 12:56:08 INFO - 'USER': 'cltbld', 12:56:08 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 12:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:08 INFO - '_': '/tools/buildbot/bin/python'} 12:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:56:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:56:10 INFO - Installing collected packages: mozsystemmonitor 12:56:10 INFO - Running setup.py install for mozsystemmonitor 12:56:10 INFO - Successfully installed mozsystemmonitor 12:56:10 INFO - Cleaning up... 12:56:10 INFO - Return code: 0 12:56:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:10 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 0x7f074fd7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af21d0>, '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 0x1af5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af5be0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:10 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 12:56:10 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 12:56:10 INFO - Using env: {'DISPLAY': ':0', 12:56:10 INFO - 'HOME': '/home/cltbld', 12:56:10 INFO - 'LANG': 'en_US.UTF-8', 12:56:10 INFO - 'LANGUAGE': 'en_US:en', 12:56:10 INFO - 'LOGNAME': 'cltbld', 12:56:10 INFO - 'MAIL': '/var/mail/cltbld', 12:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:10 INFO - 'MOZ_NO_REMOTE': '1', 12:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:10 INFO - 'NO_EM_RESTART': '1', 12:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:10 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:10 INFO - 'SHELL': '/bin/bash', 12:56:10 INFO - 'SHLVL': '1', 12:56:10 INFO - 'TERM': 'linux', 12:56:10 INFO - 'TMOUT': '86400', 12:56:10 INFO - 'USER': 'cltbld', 12:56:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 12:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:10 INFO - '_': '/tools/buildbot/bin/python'} 12:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:11 INFO - Downloading/unpacking blobuploader==1.2.4 12:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:13 INFO - Downloading blobuploader-1.2.4.tar.gz 12:56:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:56:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:56:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:13 INFO - Downloading docopt-0.6.1.tar.gz 12:56:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:56:13 INFO - Installing collected packages: blobuploader, requests, docopt 12:56:13 INFO - Running setup.py install for blobuploader 12:56:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:56:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:56:13 INFO - Running setup.py install for requests 12:56:14 INFO - Running setup.py install for docopt 12:56:14 INFO - Successfully installed blobuploader requests docopt 12:56:14 INFO - Cleaning up... 12:56:14 INFO - Return code: 0 12:56:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:14 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 0x7f074fd7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af21d0>, '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 0x1af5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af5be0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:14 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 12:56:14 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 12:56:14 INFO - Using env: {'DISPLAY': ':0', 12:56:14 INFO - 'HOME': '/home/cltbld', 12:56:14 INFO - 'LANG': 'en_US.UTF-8', 12:56:14 INFO - 'LANGUAGE': 'en_US:en', 12:56:14 INFO - 'LOGNAME': 'cltbld', 12:56:14 INFO - 'MAIL': '/var/mail/cltbld', 12:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:14 INFO - 'MOZ_NO_REMOTE': '1', 12:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:14 INFO - 'NO_EM_RESTART': '1', 12:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:14 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:14 INFO - 'SHELL': '/bin/bash', 12:56:14 INFO - 'SHLVL': '1', 12:56:14 INFO - 'TERM': 'linux', 12:56:14 INFO - 'TMOUT': '86400', 12:56:14 INFO - 'USER': 'cltbld', 12:56:14 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 12:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:14 INFO - '_': '/tools/buildbot/bin/python'} 12:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:56:14 INFO - Running setup.py (path:/tmp/pip-y85Tty-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:56:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:56:14 INFO - Running setup.py (path:/tmp/pip-_UK4rA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:56:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:56:14 INFO - Running setup.py (path:/tmp/pip-1hxkih-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:56:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:56:14 INFO - Running setup.py (path:/tmp/pip-Khb2nF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:56:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:56:14 INFO - Running setup.py (path:/tmp/pip-ml25v4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:56:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:56:14 INFO - Running setup.py (path:/tmp/pip-zMZwXk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:56:15 INFO - Running setup.py (path:/tmp/pip-DHdFWc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:56:15 INFO - Running setup.py (path:/tmp/pip-Y7X1rx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:56:15 INFO - Running setup.py (path:/tmp/pip-6h81uo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:56:15 INFO - Running setup.py (path:/tmp/pip-hjPb7U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:56:15 INFO - Running setup.py (path:/tmp/pip-QCDpSx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:56:15 INFO - Running setup.py (path:/tmp/pip-xp2w82-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:56:15 INFO - Running setup.py (path:/tmp/pip-0TYZt1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:56:15 INFO - Running setup.py (path:/tmp/pip-eX6XOt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:56:15 INFO - Running setup.py (path:/tmp/pip-G3ELA7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:56:15 INFO - Running setup.py (path:/tmp/pip-Fq1UkU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:56:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:56:15 INFO - Running setup.py (path:/tmp/pip-ISvVof-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:56:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:56:15 INFO - Running setup.py install for manifestparser 12:56:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:56:15 INFO - Running setup.py install for mozcrash 12:56:16 INFO - Running setup.py install for mozdebug 12:56:16 INFO - Running setup.py install for mozdevice 12:56:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:56:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:56:16 INFO - Running setup.py install for mozfile 12:56:16 INFO - Running setup.py install for mozhttpd 12:56:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:56:16 INFO - Running setup.py install for mozinfo 12:56:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:56:16 INFO - Running setup.py install for mozInstall 12:56:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:56:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:56:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:56:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:56:16 INFO - Running setup.py install for mozleak 12:56:16 INFO - Running setup.py install for mozlog 12:56:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:56:16 INFO - Running setup.py install for moznetwork 12:56:16 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:56:16 INFO - Running setup.py install for mozprocess 12:56:17 INFO - Running setup.py install for mozprofile 12:56:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:56:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:56:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:56:17 INFO - Running setup.py install for mozrunner 12:56:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:56:17 INFO - Running setup.py install for mozscreenshot 12:56:17 INFO - Running setup.py install for moztest 12:56:17 INFO - Running setup.py install for mozversion 12:56:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:56:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:56:17 INFO - Cleaning up... 12:56:17 INFO - Return code: 0 12:56:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:17 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 0x7f074fd7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af21d0>, '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 0x1af5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af5be0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:17 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 12:56:17 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 12:56:17 INFO - Using env: {'DISPLAY': ':0', 12:56:17 INFO - 'HOME': '/home/cltbld', 12:56:17 INFO - 'LANG': 'en_US.UTF-8', 12:56:17 INFO - 'LANGUAGE': 'en_US:en', 12:56:17 INFO - 'LOGNAME': 'cltbld', 12:56:17 INFO - 'MAIL': '/var/mail/cltbld', 12:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:17 INFO - 'MOZ_NO_REMOTE': '1', 12:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:17 INFO - 'NO_EM_RESTART': '1', 12:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:17 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:17 INFO - 'SHELL': '/bin/bash', 12:56:17 INFO - 'SHLVL': '1', 12:56:17 INFO - 'TERM': 'linux', 12:56:17 INFO - 'TMOUT': '86400', 12:56:17 INFO - 'USER': 'cltbld', 12:56:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 12:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:17 INFO - '_': '/tools/buildbot/bin/python'} 12:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:56:17 INFO - Running setup.py (path:/tmp/pip-Fn5Q90-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 12:56:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:56:17 INFO - Running setup.py (path:/tmp/pip-uTkq_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:56:18 INFO - Running setup.py (path:/tmp/pip-9UR2Pw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:56:18 INFO - Running setup.py (path:/tmp/pip-SCC_TP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:56:18 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)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:56:18 INFO - Running setup.py (path:/tmp/pip-r651DM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:56:18 INFO - Running setup.py (path:/tmp/pip-kMLeJb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:56:18 INFO - Running setup.py (path:/tmp/pip-9KWtj4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:56:18 INFO - Running setup.py (path:/tmp/pip-29E90N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:56:18 INFO - Running setup.py (path:/tmp/pip-bV3PLR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:56:18 INFO - Running setup.py (path:/tmp/pip-hI31H9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:56:18 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)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:56:18 INFO - Running setup.py (path:/tmp/pip-1NmZTa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:56:18 INFO - Running setup.py (path:/tmp/pip-eDlZSJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:56:18 INFO - Running setup.py (path:/tmp/pip-WAz81l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:56:18 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)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:56:18 INFO - Running setup.py (path:/tmp/pip-Yw2a8O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:56:18 INFO - Running setup.py (path:/tmp/pip-CpY9zF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 12:56:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:56:18 INFO - Running setup.py (path:/tmp/pip-HusgLu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:56:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 12:56:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:56:19 INFO - Running setup.py (path:/tmp/pip-8ZnxMM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:56:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 12:56:19 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 12:56:19 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 12:56:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 12:56:19 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)) 12:56:19 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)) 12:56:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:20 INFO - Downloading blessings-1.6.tar.gz 12:56:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:56:21 INFO - Installing collected packages: blessings 12:56:21 INFO - Running setup.py install for blessings 12:56:21 INFO - Successfully installed blessings 12:56:21 INFO - Cleaning up... 12:56:21 INFO - Return code: 0 12:56:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:56:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:56:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:56:21 INFO - Reading from file tmpfile_stdout 12:56:21 INFO - Current package versions: 12:56:21 INFO - argparse == 1.2.1 12:56:21 INFO - blessings == 1.6 12:56:21 INFO - blobuploader == 1.2.4 12:56:21 INFO - docopt == 0.6.1 12:56:21 INFO - manifestparser == 1.1 12:56:21 INFO - mozInstall == 1.12 12:56:21 INFO - mozcrash == 0.17 12:56:21 INFO - mozdebug == 0.1 12:56:21 INFO - mozdevice == 0.48 12:56:21 INFO - mozfile == 1.2 12:56:21 INFO - mozhttpd == 0.7 12:56:21 INFO - mozinfo == 0.9 12:56:21 INFO - mozleak == 0.1 12:56:21 INFO - mozlog == 3.1 12:56:21 INFO - moznetwork == 0.27 12:56:21 INFO - mozprocess == 0.22 12:56:21 INFO - mozprofile == 0.28 12:56:21 INFO - mozrunner == 6.11 12:56:21 INFO - mozscreenshot == 0.1 12:56:21 INFO - mozsystemmonitor == 0.0 12:56:21 INFO - moztest == 0.7 12:56:21 INFO - mozversion == 1.4 12:56:21 INFO - psutil == 3.1.1 12:56:21 INFO - requests == 1.2.3 12:56:21 INFO - wsgiref == 0.1.2 12:56:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:56: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')]} 12:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56: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')]} 12:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:21 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 0x7f074fd7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af21d0>, '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 0x1af5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af5be0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:21 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 12:56:21 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 12:56:21 INFO - Using env: {'DISPLAY': ':0', 12:56:21 INFO - 'HOME': '/home/cltbld', 12:56:21 INFO - 'LANG': 'en_US.UTF-8', 12:56:21 INFO - 'LANGUAGE': 'en_US:en', 12:56:21 INFO - 'LOGNAME': 'cltbld', 12:56:21 INFO - 'MAIL': '/var/mail/cltbld', 12:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:21 INFO - 'MOZ_NO_REMOTE': '1', 12:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:21 INFO - 'NO_EM_RESTART': '1', 12:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:21 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:21 INFO - 'SHELL': '/bin/bash', 12:56:21 INFO - 'SHLVL': '1', 12:56:21 INFO - 'TERM': 'linux', 12:56:21 INFO - 'TMOUT': '86400', 12:56:21 INFO - 'USER': 'cltbld', 12:56:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 12:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:21 INFO - '_': '/tools/buildbot/bin/python'} 12:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 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)) 12:56:21 INFO - Cleaning up... 12:56:21 INFO - Return code: 0 12:56:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:56: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')]} 12:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56: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')]} 12:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:21 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 0x7f074fd7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af21d0>, '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 0x1af5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af5be0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:21 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 12:56:21 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 12:56:21 INFO - Using env: {'DISPLAY': ':0', 12:56:21 INFO - 'HOME': '/home/cltbld', 12:56:21 INFO - 'LANG': 'en_US.UTF-8', 12:56:21 INFO - 'LANGUAGE': 'en_US:en', 12:56:21 INFO - 'LOGNAME': 'cltbld', 12:56:21 INFO - 'MAIL': '/var/mail/cltbld', 12:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:21 INFO - 'MOZ_NO_REMOTE': '1', 12:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:21 INFO - 'NO_EM_RESTART': '1', 12:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:21 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:21 INFO - 'SHELL': '/bin/bash', 12:56:21 INFO - 'SHLVL': '1', 12:56:21 INFO - 'TERM': 'linux', 12:56:21 INFO - 'TMOUT': '86400', 12:56:21 INFO - 'USER': 'cltbld', 12:56:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 12:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:21 INFO - '_': '/tools/buildbot/bin/python'} 12:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:21 INFO - Downloading/unpacking jsonschema 12:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:56:23 INFO - Downloading/unpacking functools32 (from jsonschema) 12:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:23 INFO - Downloading functools32-3.2.3-2.tar.gz 12:56:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:56:23 INFO - warning: no files found matching '*.txt' 12:56:23 INFO - no previously-included directories found matching 'build' 12:56:23 INFO - no previously-included directories found matching 'dist' 12:56:23 INFO - no previously-included directories found matching '.git*' 12:56:23 INFO - Installing collected packages: jsonschema, functools32 12:56:24 INFO - Running setup.py install for functools32 12:56:24 INFO - warning: no files found matching '*.txt' 12:56:24 INFO - no previously-included directories found matching 'build' 12:56:24 INFO - no previously-included directories found matching 'dist' 12:56:24 INFO - no previously-included directories found matching '.git*' 12:56:24 INFO - Successfully installed jsonschema functools32 12:56:24 INFO - Cleaning up... 12:56:24 INFO - Return code: 0 12:56:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:56: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')]} 12:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56: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')]} 12:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:24 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 0x7f074fd7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af21d0>, '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 0x1af5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af5be0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:24 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 12:56:24 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 12:56:24 INFO - Using env: {'DISPLAY': ':0', 12:56:24 INFO - 'HOME': '/home/cltbld', 12:56:24 INFO - 'LANG': 'en_US.UTF-8', 12:56:24 INFO - 'LANGUAGE': 'en_US:en', 12:56:24 INFO - 'LOGNAME': 'cltbld', 12:56:24 INFO - 'MAIL': '/var/mail/cltbld', 12:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:24 INFO - 'MOZ_NO_REMOTE': '1', 12:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:24 INFO - 'NO_EM_RESTART': '1', 12:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:24 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:24 INFO - 'SHELL': '/bin/bash', 12:56:24 INFO - 'SHLVL': '1', 12:56:24 INFO - 'TERM': 'linux', 12:56:24 INFO - 'TMOUT': '86400', 12:56:24 INFO - 'USER': 'cltbld', 12:56:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 12:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:24 INFO - '_': '/tools/buildbot/bin/python'} 12:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:24 INFO - Downloading/unpacking flake8 12:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:56:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:56:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:56:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:56:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:56:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:56:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:56:26 INFO - no previously-included directories found matching 'docs/_build' 12:56:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:56:27 INFO - Running setup.py install for pep8 12:56:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:56:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:56:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:56:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:56:27 INFO - no previously-included directories found matching 'docs/_build' 12:56:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:56:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:56:27 INFO - Cleaning up... 12:56:27 INFO - Return code: 0 12:56:27 INFO - Running post-action listener: _resource_record_post_action 12:56:27 INFO - Running post-action listener: _start_resource_monitoring 12:56:27 INFO - Starting resource monitoring. 12:56:27 INFO - ##### 12:56:27 INFO - ##### Running install step. 12:56:27 INFO - ##### 12:56:27 INFO - Running pre-action listener: _resource_record_pre_action 12:56:27 INFO - Running main action method: install 12:56:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:56:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:56:27 INFO - Reading from file tmpfile_stdout 12:56:27 INFO - Detecting whether we're running mozinstall >=1.0... 12:56:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:56:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:56:27 INFO - Reading from file tmpfile_stdout 12:56:27 INFO - Output received: 12:56:27 INFO - Usage: mozinstall [options] installer 12:56:27 INFO - Options: 12:56:27 INFO - -h, --help show this help message and exit 12:56:27 INFO - -d DEST, --destination=DEST 12:56:27 INFO - Directory to install application into. [default: 12:56:27 INFO - "/builds/slave/test-pgo"] 12:56:27 INFO - --app=APP Application being installed. [default: firefox] 12:56:27 INFO - mkdir: /builds/slave/test-pgo/build/application 12:56:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 12:56:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 12:56:43 INFO - Reading from file tmpfile_stdout 12:56:43 INFO - Output received: 12:56:43 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:56:43 INFO - Running post-action listener: _resource_record_post_action 12:56:43 INFO - ##### 12:56:43 INFO - ##### Running run-tests step. 12:56:43 INFO - ##### 12:56:43 INFO - Running pre-action listener: _resource_record_pre_action 12:56:43 INFO - Running main action method: run_tests 12:56:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:56:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:56:43 INFO - Python 2.7.3 12:56:43 INFO - Return code: 0 12:56:43 INFO - grabbing minidump binary from tooltool 12:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:43 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 0x1af21d0>, '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 0x1af5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af5be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:56:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 12:56:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:56:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:56:44 INFO - Return code: 0 12:56:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:56:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:56:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:56:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:56:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:56:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:56:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:56:45 INFO - Return code: 0 12:56:45 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/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 12:56:45 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/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 12:56:45 INFO - Using env: {'DISPLAY': ':0', 12:56:45 INFO - 'HOME': '/home/cltbld', 12:56:45 INFO - 'LANG': 'en_US.UTF-8', 12:56:45 INFO - 'LANGUAGE': 'en_US:en', 12:56:45 INFO - 'LOGNAME': 'cltbld', 12:56:45 INFO - 'MAIL': '/var/mail/cltbld', 12:56:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:56:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:45 INFO - 'MOZ_NO_REMOTE': '1', 12:56:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:45 INFO - 'NO_EM_RESTART': '1', 12:56:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:45 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:56:45 INFO - 'SHELL': '/bin/bash', 12:56:45 INFO - 'SHLVL': '1', 12:56:45 INFO - 'TERM': 'linux', 12:56:45 INFO - 'TMOUT': '86400', 12:56:45 INFO - 'USER': 'cltbld', 12:56:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546', 12:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:45 INFO - '_': '/tools/buildbot/bin/python'} 12:56:45 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/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 12:56:45 INFO - mozversion application_buildid: 20160325103025 12:56:45 INFO - mozversion application_changeset: b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2 12:56:45 INFO - mozversion application_display_name: Nightly 12:56:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:56:45 INFO - mozversion application_name: Firefox 12:56:45 INFO - mozversion application_remotingname: firefox 12:56:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:56:45 INFO - mozversion application_vendor: Mozilla 12:56:45 INFO - mozversion application_version: 48.0a1 12:56:45 INFO - mozversion platform_buildid: 20160325103025 12:56:45 INFO - mozversion platform_changeset: b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2 12:56:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:56:45 INFO - mozversion platform_version: 48.0a1 12:56:45 INFO - using testdate: 1458935805 12:56:45 INFO - actual date: 1458935805 12:56:45 INFO - starting webserver on 'localhost:59214' 12:56:45 INFO - SUITE-START | Running 2 tests 12:56:45 INFO - TEST-START | dromaeo_css 12:56:45 INFO - operating with platform_type : linux_ 12:56:45 INFO - Initialising browser for dromaeo_css test... 12:56:45 INFO - TEST-INFO | started process 23973 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCb63km/profile http://localhost:59214/getInfo.html) 12:56:49 INFO - PROCESS | 23973 | __metrics Screen width/height:1600/1200 12:56:49 INFO - PROCESS | 23973 | colorDepth:24 12:56:49 INFO - PROCESS | 23973 | Browser inner width/height: 1024/697 12:56:49 INFO - PROCESS | 23973 | __metrics 12:56:49 ERROR - PROCESS | 23973 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:56:49 INFO - PROCESS | 23973 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 12:56:50 INFO - TEST-INFO | 23973: exit 0 12:56:50 INFO - Browser initialized. 12:56:50 INFO - Running cycle 1/1 for dromaeo_css test... 12:56:50 INFO - TEST-INFO | started process 24067 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCb63km/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:57:02 INFO - PROCESS | 24067 | RSS: Main: 153305088 12:57:02 INFO - PROCESS | 24067 | 12:57:54 INFO - PROCESS | 24067 | 1458935874115 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] 13:00:00 INFO - PROCESS | 24067 | Cycle 1(1): loaded http://localhost:59214/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59214/tests/dromaeo/cssquery-ext.html) 13:00:01 INFO - PROCESS | 24067 | RSS: Main: 253521920 13:00:01 INFO - PROCESS | 24067 | 13:03:03 INFO - PROCESS | 24067 | Cycle 1(1): loaded http://localhost:59214/tests/dromaeo/cssquery-ext.html (next: http://localhost:59214/tests/dromaeo/cssquery-jquery.html) 13:03:04 INFO - PROCESS | 24067 | RSS: Main: 237178880 13:03:04 INFO - PROCESS | 24067 | 13:06:06 INFO - PROCESS | 24067 | Cycle 1(1): loaded http://localhost:59214/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59214/tests/dromaeo/cssquery-mootools.html) 13:06:06 INFO - PROCESS | 24067 | RSS: Main: 235393024 13:06:06 INFO - PROCESS | 24067 | 13:09:08 INFO - PROCESS | 24067 | Cycle 1(1): loaded http://localhost:59214/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59214/tests/dromaeo/cssquery-prototype.html) 13:09:08 INFO - PROCESS | 24067 | RSS: Main: 209555456 13:09:08 INFO - PROCESS | 24067 | 13:12:11 INFO - PROCESS | 24067 | Cycle 1(1): loaded http://localhost:59214/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59214/tests/dromaeo/cssquery-yui.html) 13:12:12 INFO - PROCESS | 24067 | RSS: Main: 213729280 13:12:12 INFO - PROCESS | 24067 | 13:15:14 INFO - PROCESS | 24067 | Cycle 1(1): loaded http://localhost:59214/tests/dromaeo/cssquery-yui.html (next: http://localhost:59214/tests/dromaeo/cssquery-dojo.html) 13:15:14 INFO - PROCESS | 24067 | RSS: Main: 266964992 13:15:14 INFO - PROCESS | 24067 | 13:15:14 INFO - PROCESS | 24067 | __start_tp_report 13:15:14 INFO - PROCESS | 24067 | _x_x_mozilla_page_load 13:15:14 INFO - PROCESS | 24067 | _x_x_mozilla_page_load_details 13:15:14 INFO - PROCESS | 24067 | |i|pagename|runs| 13:15:14 INFO - PROCESS | 24067 | |0;dojo.html;2994.8502574871254;3042.376312855865;3063.2188791858075;3075.507918733003;3107.3319236364187;5001.374828146481;5129.051125541778;5159.690418574884;5197.532222100005;5207.583393328534;5229.3201883755055;5241.2924255225535;5248.186531087687;5282.07563676357;5319.335083114611;4644.047970166124;4665.1602711512;4677.976610116944;4750.738709370983;4791.568758811706;4755.3104799804005;4762.761681962697;4789.305550695147;4816.54242846929;4864.464908860023;4589.678722489427;4652.488226295105;4717.905641887178;4722.102800467935;4769.475357710649;4672.345871577982;4704.952950470486;4707.7175369477945;4710.175719249152;4756.429228492569;4498.280275155959;4664.766761661937;4690.742009189493;4721.220998535237;4725.66920315578;5178.093833579109;5199.1161502544655;5201.609879259071;5206.973965130188;5241.109011468059;5580.972095139498;5620.381758006616;5621.100623900156;5624.128260119688;5624.775008999676;5275.683458992473;5595.272614560081;5610.354809196954;5705;5708.657480551139;5097.337346144977;5109.846704598831;5110.080185566597;5114.565261952738;5168.147255702805;5552.69460179694;5567.4432556744005;5569.164625306155;5588.524975377139;5597.160425936061;5355.732213389315;5382.058139825514;5420.620556561003;5471.781128754885;5504.944950550524;5570.136628822539;5584.050711379075;5586.972065139729;5592.496675299242;5604.299462567179;5561.388247292794;5586.245856809279;5596.552275818006;5596.608237423423;5630.155476678531;5404.378496472956;5584.664920104807;5649.350324712711;5666.886662266732;5680.289963754531;4262.062346283813;4273.444452221192;4277.465316835395;4278.764667943293;4312.396264522969;3750.4186851038135;3823.9617603824163;3845.3270677631303;3855.575886652466;3888.183481468867;5295.523402893681;5336.973315133399;5359.035373632705;5398.163284690879;5421.864453388697;5627.127795191752;5640;5668.291463567054;5681.176229446707;5684.37471878093;5094.745262736922;5261.868453288622;5315.707636079976;5315.973420132875;5318.361796584357;4737.976310118427;4752.7861246244;4757.333973243749;4766.451858036301;4813.205821039559;5791.102379131242;5846.239988801429;5876.265466816648;5877.823665290048;5923.022701254331;5516.531094856982;5655.519280861008;5674.687892165971;5691.630044047124;5713.771449141987;5874.471297583238;5883.558733094949;5883.882322353444;5895.380984996514;5911.881762364815;5534.335879694462;5539.25220095282;5546.58400619947;5560.805371811967;5575.9163612545035;5494.945050549603;5603.719814009365;5607.943920560742;5637.3235211774845;5675.943240567542;5468.863278418072;5469.206964989975;5471.890562188654;5472.042392581362;5511.972440137773;5364.839054828361;5409.107497262908;5412.648177868426;5421.40364559906;5464.945350546603;5241;5346.117890548016;5386.649867758583;5389.056915039774;5439.619226654097;5326.733663316896;5374.838754837361;5379.65032272901;5402.75687594067;5452.127659574449;5263.157894736823;5309.123994540858;5311.41574426805;5311.654742441729;5349.705766182898 13:15:14 INFO - PROCESS | 24067 | |1;ext.html;547.6334740961042;559.0635685227244;580.9302883653961;585.6749504025264;587.7443312159211;39477.210455790904;40365.39451908216;40406.59593404065;40514.39228411576;40549.59450405495;43704.781476092576;44063.11873762523;44161;44178;44189.337159942625;8512.914870851306;8664.220220180183;8690.695825646104;8707.912920870805;8740.213380795727;8572.657093716243;8695.782605434852;8701.564921753887;8711.34664900135;8715.128487151265;8901.06538813425;8969;8975.551222438851;8977.416467929595;8980.28157747382;8806.735797926072;8824.514651694155;8835.293176545892;8836.602352894135;8916.108389161065;8571.871421928676;8659.523726195057;8669.826603467958;8688.695895643623;8701.955765308203;41255.58744412548;41830;41920.79039604813;42289.788551057354;42503.36244956328;3524.2775231077567;3653.0867283179205;3844.9231015379537;3859.286032084073;4319.632831209351;31975.6802431975;32202.516962245583;32391.190220244684;32507.187320316945;33625.83187084073;4334.956650433518;4341.370501277297;4348.782560871944;4406.493253275882;4587.128445595326;321437;322784;323194;323336;324059.37970310234;55848.44151558514;58770;65862;66967.66516167486;66991.66504167546;60833;60993.98569164603;61258;61473;61739.38260617426;17170.282971702978;17380.65238695219;17433;17487.125643718016;17502.91248543749;12077.27536347822;12080.818787718192;12809.167404118702;12867.613971580868;12891.097623166475;20646.587068258552;21538.676919846213;21759.456013599785;21818.799966001705;21969.780302197094;6951.374376306157;7023.403010744042;7023.578585284797;7114.561322003492;7174.390176834923;867.3148212911855;882.82343531294;936.6534382278601;1056.7199692081604;1064.5582083435443;27816.582751258746;28040.158795236177;28523;28532.144035678964;28567.85716071448;968.2641192693603;1017.3743147963949;1033.4574348467115;1040.890706475809;1066.5520481397832;14254.429822806971;14830.406783728746;14851.331690073972;14903.254837258311;14996.175210363317;388238;393287;393882;395593;395593;57891;59426.40573594295;59750.40249597535;59950.40049599448;60033;1257.0697683714168;1399.9230042347565;1417.2276109520337;1431.055503367793;1527.2440142129494;29104;30415.54376684307;31247.375052499276;32960.340793183525;32985.505217421276;46482;46569;46878;47188.7640561795;47262.76368618135;267903;268302;269195;269267;270813;30914.227144321572;36765.63234367622;36850.44724329084;37372.62627373692;37449.43825842669;43358.34962475629;43399.34900976425;43472;43755;43839.56160438355;38661.420078699404;39610.60389396069;39779.2044159121;39798.403023955245;39800;38198;39293.21413571655;39332.606673932896;40133.1973360537;40617.79691101644;39890.40164397479;39895.2020959585;41065.38401924033;41115.588844111175;41314.380284295155;32993.67006329906;35273.29453410866;35520;35988.64011359853;36174;27230;27475.86262068677;27486.18094219505;27715.58426623562;27955 13:15:14 INFO - PROCESS | 24067 | |2;jquery.html;322.3392046305074;326.33427807273165;346.99999999999994;348.82384395880075;349.5386090360724;16937.915310423446;17284.827151728477;17920;18695.439136825917;18791.342303019395;17388.391406300783;17666.911665441687;17864.28542858284;17891.910540447312;17906.910465447687;5081.9745901270535;5202.921956170641;5242.449542798008;5247.239150323201;5249.1601343785005;5126.282320475118;5215.556677682402;5234.947650523503;5240.3187585614005;5242.606804489659;5052.292679024939;5197.194434862602;5206.5834733221445;5216.973915130419;5276.868078298035;5198.922016169741;5205.453427390145;5220.556252718524;5227.398849132342;5250.973745131269;4585.358049873021;4644.814207431698;4645.070985802853;4651.976740116278;4655.790489427984;20412.285570004977;20891.68662470049;21034.789652103434;21052.789472105236;21123.47191320214;1908.761404824397;1977.6637971544872;2057.794220577945;2655.81409301349;2725.4004119093765;8335.249827515492;8514.957425212897;12220.694482638006;12260.509579616804;12668.80996785049;1562.2501199424225;1620.8460196281335;1671.6071723145174;1677.2620047179323;1689.6113893804493;67877.32122678809;71201.28798712051;71265.64367178183;71338.2866171342;71659;9828.950855245677;9926.454045027593;9981.401115933068;10010.546361505269;10242.078212960869;13671.248081355621;13824.723505529833;13833.723325533634;13861.544537823384;13970.161790292412;7548.131964824115;7685.5772932488135;7705.345045671069;7758.7672369829;7782.910392545048;7452.441066920002;7522.774316770506;7549.7357592483995;7562.773116806505;7624.809379765439;4076.3477843544892;4119.299719047769;4157.48031496063;4248.702590818675;4527.253003254492;1731.5584525945803;1746.214203608356;1783.6967715488397;1811.9003454810113;1820.7527843427295;892.0811564088999;894.9642014319354;983.5918093990914;992.6228033347281;1000.6697789729371;15841.52475425716;16409;16409.42567010149;16475.67048659044;16760.413385531447;842.1388730904647;854.7179430787825;883.6156272021562;901.7610333261691;911.886014248219;9207.17135457812;9306.162445379812;9441.905580944103;9514.809703805886;10270;476198;480140;492732;497202;497480.2771695111;78671.21328786753;81470.59264703639;82617;82832;83356.58321708352;1046.576136664652;1052.7473406382567;1061.400308825511;1062.033549469994;1091.6070214722693;15865.658411453176;15904.129683498762;15973.520794376187;15980.680386391974;16128;36201.27597447984;36391.818040909624;36742.63257367499;37288.067798304175;37326.25347492981;51024.489755101975;51523.22715159201;51926.221106684185;52340.21489677582;53295.73352133214;7428.517146385468;7741.92258077412;7769.8834517481155;7815.53106813593;7954.363650908029;11522.366269855238;12568.434420450918;12646.114771965875;12850.614481565568;12947.870521294666;10452.895471045496;10594.261067513464;10852.240343176218;10920.922619344741;11155.609553665583;10367.688969330931;10767.730806729895;11003.559857605926;11049;11128.777424451628;6970.9543568463105;8204.794880128045;10556.947215263874;10869.78260434771;11541.249818761753;7626.618669066635;7630.046244219473;7713.961430192813;7724.382049436144;7841.725539606086;7784.026996625422;9540;10760.892391076302;11364.034057104907;11450.37022963745 13:15:14 INFO - PROCESS | 24067 | |3;mootools.html;1252.6805664555536;1445.472402573061;1469.2800527741406;1614.2251719174797;1763.109629637033;7179.461540384473;7370.5577665340115;7418.369438597726;7433.516821406605;7442.516236444627;7321.743738969137;7447.143578488475;7459.4032477401815;7469.178390377067;7472.96263518683;1803.4769916724135;1845.335679155503;2174.0760176924823;2180.040782055898;2204.184451752854;2230.9107635694636;2242.921497747579;2243.6971008913833;2244.820414366855;2246.663000549914;2178.400939741568;2193.2214064007285;2215.7673444288357;2218.5562887422498;2220.1341476823973;2149.473379022134;2179.24815938501;2186.28945592683;2186.365953873375;2195.078067211775;2168.2627906511702;2177;2179.4769255378756;2186.464316242515;2189.2665956904457;7561.357284630813;7584;7585.81035474112;7593.6203189840835;7668.578228197447;4609.585137337622;4831.323614693945;4835.347228124193;4858.732769697665;4861.829835955725;3064.5403189521526;3106.6272047354237;3153.8896138635037;3156.6527681954967;3170.556122142902;902.571278642646;916.5646317998963;956.5217391304348;958.6261358070358;971.5579411367811;10869.130469562495;10937.671869843838;10950.34297942126;10998.780024399468;11018.173636977259;4065.6747460203114;4150.06623509714;4164.12553363797;4177.832886684499;4204.684648651302;9090;9090.227330676835;9112.817743645222;9121.31590130743;9123.680671176477;4787.281907713871;4809.495003024702;4831.637627177975;4844.442889067803;4846.224604063404;3838.328292548793;4343.131373725268;4385.912281754411;4386.561343865588;4418.116376724668;3552.1474846036767;3583.4624806278744;3620.4931309616672;3630.074331045619;3679.1537946271974;1134.387430787382;1149.9770004599861;1153.7173392518887;1153.94807233673;1154.9133814963911;1286.0676009892752;1292.8060790881443;1304.0871390027019;1317.5059352742721;1319.300770591588;7036.331548502884;7073.575585464889;7076.398506126934;7081.044059052065;7084.539504932163;412.24764804232393;416.10329739411617;418.18662701046173;419.427481487767;421.8860907554943;5308.734563271821;5337.386200586904;5350.732463376816;5387.488188622075;5395.62230643859;9154.954225228832;9210.401323913924;9322.953385233166;9323.300752443594;9507.714768556954;9344.719658410258;9365;9394;9414.246860251164;9425.05749425052;6978.70893884633;7120.786376408716;7177.6770045348085;7238.203797582261;7329.853402931912;6854.862902742017;6874.415674667709;6895.172579290517;6904;6940.02839602446;8200.835983280182;8525.19010693983;8531.360147988802;8558.315334773328;8562.443441176303;8507.532085735344;8722.563871806258;8725.520096394504;8726.69456569017;8824.823503530022;6739.19129704419;6888.276730943179;6996.790096297119;7008.299170082951;7018.403435708022;7309.232530584425;7350.338469537767;7367.26327367259;7371.778846634609;7374.446916481178;6243.8126856194385;6398.392152745481;6448.451881590117;6555.901661474986;6575.572587781779;6354.52341074412;6366.395192456709;6414.93585064162;6421.261554921057;6582.572132811352;6565.179352580927;6578.24350199714;6601.042848786803;6605.867882642417;6650.401463868275;5988.850278743066;6226.25284965807;6258.061290806233;6274.152989346379;6316.431521163117;6344.080108384166;6350.333215012357;6351.428371446592;6370.203724534434;6378.936210637834 13:15:14 INFO - PROCESS | 24067 | |4;prototype.html;292.5261077055171;296.91092672198334;297.04500032395845;301.07119536230726;302.5159744408946;5824.504917082042;5964.79123230687;6018.969905150474;6020.789272375468;6055.455009049185;5847.736851841667;5897.085951677497;5902.940970590293;5932.733027013784;5956.434138756822;4170.186813571355;4221.683373746966;4249.915001699964;4331.133773245348;4342.891427714317;4228.154369126171;4241.448611680477;4360.6075453209205;4373.365861950031;4418.403515525395;4317.589828966259;4323.935140972888;4338.544452832454;4351.369051487548;4382.517923028464;4119.958800411988;4205.495340559122;4330.588594083557;4374.103308821684;4383.780810959439;3723.1436769543157;3727.422249551324;3734.9813250933844;3744.6817020553285;3744.9438258426144;5616;5659.8585035374035;5659.971700141514;5696.11710184922;5731.312242530881;4994.90010199794;5006.824761133343;5012.699238045692;5026.89946201074;5038.193888977783;6147.631142131441;6148.631082135042;6157.076438534211;6160.938390616081;6160.969195154041;4118.75287482749;4145.481814773153;4146.419501269825;4154.189932963073;4161.667066634693;6270.576863632092;6409.743610255584;6475;6479.028145778124;6483.902741458882;4194.077302993336;4197.412362269285;4215.768132752728;4221.134667393177;4227.387028880795;4263.019505513687;4268.103698223408;4270.167317373082;4272.551382104896;4282.336237883133;5014.272930425068;5016.899662006739;5018.071656743514;5022.874428139253;5026.396832380065;6218.968905155445;6228.906566401508;6231.563790534619;6234.688265586702;6237.376262373727;1433.3764812306472;1480.2746654139394;1496.3790027138832;1497.2438918346165;1498.2059508460534;949.264320151874;951.9714408567754;965.3918031640162;967.8596603492454;969.7914948286011;5859.091840764689;5907;5946.554008449383;5997.760089596454;6001.309849367379;6449.677516124175;6473;6495.837604059936;6496.480281577463;6507.967460162764;6000.819975400745;6039.78860739872;6056.273247210275;6062.939370606326;6066.150738896558;3445.4315038018444;3467.358538670354;3473.9826300868335;3484.651534846546;3485.7385696072897;6537.477001839841;6705.932940670628;6710.328967103348;6721.6975236114495;6733.797986060328;6566.868662626721;6602.2737498875085;6606.306337834554;6606.636634985026;6616.8345791355605;6678.065070890079;6700.530962832555;6708.899366509506;6725.159355080615;6725.428338591275;6437.935620643733;6454.451371633276;6457.063725759833;6461.547691661539;6471.838204044937;6363.681815909279;6369.713362898588;6369.90445143314;6377.87244255103;6379.872402552016;6531.706073226811;6709.993500974698;6734.158230221223;6742.325767423218;6752.763653272112;4165.750054996589;4209.463545805697;4219;4221.641160501269;4225.408442817947;6463.709133088928;6464.644444555594;6479.838004049937;6482.773102941374;6485.286618472059;6287.685615719287;6301.495880329654;6311;6323.177986861679;6325.746970121328;6070.696465176635;6268.059791031382;6269.090981807703;6289.40250676185;6298;6136.417040381157;6144;6172.105044768573;6176.104464852661;6180.351063138485;6334.746610135728;6344.651044192614;6349.936500634934;6351.2060992375955;6380.521460890359;6109.083637454418;6126.785562505291;6129.540284478593;6161.168242287413;6165.229346331708 13:15:14 INFO - PROCESS | 24067 | |5;yui.html;690.6477696374848;706.4489698035532;720.7261240728526;731.6780616528727;802.542550746075;12990.93504532476;13039.999999999987;13138.934305328472;13145.67135821605;13234.669133271662;11278.943605281962;12234.510619575207;12300.446479908403;12328.260304381743;12331.136820422551;812.10262659761;835.1189495082685;837.0666706622134;838.7903024243939;840.2479780596362;838.3879767769532;842.4692443760422;845.0873057098349;845.446232717571;845.5560830563973;690.6063543780048;850.2177996243471;871.7864123289803;878.0253918150847;879.0418443896152;866.8569686001803;867.9435836670597;870.0646804684926;873.5326600268858;874.8643960186181;626.0077776723898;627.8712863862897;628.6950828848005;629.1569297141851;630.2342653675806;12689.936550317188;12708.491660333575;12744.171628844188;12800.231986080866;12845.293508857008;13133.34333283332;13730.862691373059;13836.515721949783;13838.515651952133;14214.147151170859;10169.288149829516;10474.109700675375;10576.682699519026;10680.732981675521;10697.786044279148;3240.951385729216;3327.450970589874;3360.983195084009;3369.578802649669;3446.87935922244;47253;47670.761646191546;47713;48176.27735583969;48413;9622.326437149472;9964.25268104895;10048.949755251177;10246;10401.167906567456;17439.912800435915;17526.123693815258;17536.29854805819;17545.473635790946;17554.824451755576;7126.964365178141;7172.175199851979;7238.348548630648;7242.818929526698;7377.88933166003;4248.808803603845;4341.45731783527;4374.300111982067;4509.075639493896;4535.478419981679;3045.9238519036758;3088.876444942177;3099.0392978176837;3102.953455698166;3104.456720073978;496.1590104772448;562.7664519224476;565.4034993082255;612.1246617337162;621.3196549777986;754.2758951406711;779.7757520692459;782.3819182845602;805.5207151744703;814.722994181981;8612.18184272493;8889.377743558018;8951.776205594912;9037.141471560191;9040.598707200394;750.4709180028067;794.4597673582019;794.6821271491334;800.2117913854848;830.7258604660448;4199.538050814408;4315.158544083936;4318.201132790381;4330.155619654137;4457.888552786141;61785.382146177966;63304.68347658325;63453;63572;63702;52358.21462678063;52836.20745688818;53496.465035349145;55019.17471237935;56291.90394528258;45276.77361613171;47014.76492617515;47049;48520;49183.50816491789;9784.706458806248;9823.312368134162;9948.900510994798;9980.301378903407;10010.349327293703;36761.26477470489;37144;37404.43893341548;38675;39183.2163356737;47059.29411058768;48446.5155348442;49213.507864920895;50112.49887501078;50748.49251507585;11997.100217483898;12058.577949771716;12172.087093467848;12284.631461056182;12477.440319960006;12028;13157.671058223237;13361.933190334375;13378.264195469343;13527.797083043566;11671.007964322787;12704.491820327083;12905.483780648668;13025.47898084066;13748.381322840696;12355.567555135527;12500.562480313145;12590;12819.615411537668;12933.54732584355;12077.27536347822;12134.939325303318;12459.190152640049;12568.874311257136;12943.741125177256;9385.38994965325;9401.576929038072;9548.283878708986;9626.518674066128;9806.26453016041;9803.803923921625;10063.748406289902;10089.243306751876;10102.191824654157;10119.645812396531 13:15:14 INFO - PROCESS | 24067 | __end_tp_report 13:15:14 INFO - PROCESS | 24067 | __start_cc_report 13:15:14 INFO - PROCESS | 24067 | _x_x_mozilla_cycle_collect,806 13:15:14 INFO - PROCESS | 24067 | __end_cc_report 13:15:14 INFO - PROCESS | 24067 | __startTimestamp1458936914799__endTimestamp 13:15:14 INFO - PROCESS | 24067 | 13:15:14 INFO - PROCESS | 24067 | ------- Summary: start ------- 13:15:14 INFO - PROCESS | 24067 | Number of tests: 6 13:15:14 INFO - PROCESS | 24067 | 13:15:14 INFO - PROCESS | 24067 | [#0] dojo.html Cycles:165 Average:5181.67 Median:5359.04 stddev:594.90 (11.1%) stddev-sans-first:571.46 13:15:14 INFO - PROCESS | 24067 | Values: 2994.9 3042.4 3063.2 3075.5 3107.3 5001.4 5129.1 5159.7 5197.5 5207.6 5229.3 5241.3 5248.2 5282.1 5319.3 4644.0 4665.2 4678.0 4750.7 4791.6 4755.3 4762.8 4789.3 4816.5 4864.5 4589.7 4652.5 4717.9 4722.1 4769.5 4672.3 4705.0 4707.7 4710.2 4756.4 4498.3 4664.8 4690.7 4721.2 4725.7 5178.1 5199.1 5201.6 5207.0 5241.1 5581.0 5620.4 5621.1 5624.1 5624.8 5275.7 5595.3 5610.4 5705.0 5708.7 5097.3 5109.8 5110.1 5114.6 5168.1 5552.7 5567.4 5569.2 5588.5 5597.2 5355.7 5382.1 5420.6 5471.8 5504.9 5570.1 5584.1 5587.0 5592.5 5604.3 5561.4 5586.2 5596.6 5596.6 5630.2 5404.4 5584.7 5649.4 5666.9 5680.3 4262.1 4273.4 4277.5 4278.8 4312.4 3750.4 3824.0 3845.3 3855.6 3888.2 5295.5 5337.0 5359.0 5398.2 5421.9 5627.1 5640.0 5668.3 5681.2 5684.4 5094.7 5261.9 5315.7 5316.0 5318.4 4738.0 4752.8 4757.3 4766.5 4813.2 5791.1 5846.2 5876.3 5877.8 5923.0 5516.5 5655.5 5674.7 5691.6 5713.8 5874.5 5883.6 5883.9 5895.4 5911.9 5534.3 5539.3 5546.6 5560.8 5575.9 5494.9 5603.7 5607.9 5637.3 5675.9 5468.9 5469.2 5471.9 5472.0 5512.0 5364.8 5409.1 5412.6 5421.4 5464.9 5241.0 5346.1 5386.6 5389.1 5439.6 5326.7 5374.8 5379.7 5402.8 5452.1 5263.2 5309.1 5311.4 5311.7 5349.7 13:15:14 INFO - PROCESS | 24067 | 13:15:14 INFO - PROCESS | 24067 | [#1] ext.html Cycles:180 Average:50708.23 Median:40014.20 stddev:87175.90 (217.9%) stddev-sans-first:87339.10 13:15:14 INFO - PROCESS | 24067 | Values: 547.6 559.1 580.9 585.7 587.7 39477.2 40365.4 40406.6 40514.4 40549.6 43704.8 44063.1 44161.0 44178.0 44189.3 8512.9 8664.2 8690.7 8707.9 8740.2 8572.7 8695.8 8701.6 8711.3 8715.1 8901.1 8969.0 8975.6 8977.4 8980.3 8806.7 8824.5 8835.3 8836.6 8916.1 8571.9 8659.5 8669.8 8688.7 8702.0 41255.6 41830.0 41920.8 42289.8 42503.4 3524.3 3653.1 3844.9 3859.3 4319.6 31975.7 32202.5 32391.2 32507.2 33625.8 4335.0 4341.4 4348.8 4406.5 4587.1 321437.0 322784.0 323194.0 323336.0 324059.4 55848.4 58770.0 65862.0 66967.7 66991.7 60833.0 60994.0 61258.0 61473.0 61739.4 17170.3 17380.7 17433.0 17487.1 17502.9 12077.3 12080.8 12809.2 12867.6 12891.1 20646.6 21538.7 21759.5 21818.8 21969.8 6951.4 7023.4 7023.6 7114.6 7174.4 867.3 882.8 936.7 1056.7 1064.6 27816.6 28040.2 28523.0 28532.1 28567.9 968.3 1017.4 1033.5 1040.9 1066.6 14254.4 14830.4 14851.3 14903.3 14996.2 388238.0 393287.0 393882.0 395593.0 395593.0 57891.0 59426.4 59750.4 59950.4 60033.0 1257.1 1399.9 1417.2 1431.1 1527.2 29104.0 30415.5 31247.4 32960.3 32985.5 46482.0 46569.0 46878.0 47188.8 47262.8 267903.0 268302.0 269195.0 269267.0 270813.0 30914.2 36765.6 36850.4 37372.6 37449.4 43358.3 43399.3 43472.0 43755.0 43839.6 38661.4 39610.6 39779.2 39798.4 39800.0 38198.0 39293.2 39332.6 40133.2 40617.8 39890.4 39895.2 41065.4 41115.6 41314.4 32993.7 35273.3 35520.0 35988.6 36174.0 27230.0 27475.9 27486.2 27715.6 27955.0 13:15:14 INFO - PROCESS | 24067 | 13:15:14 INFO - PROCESS | 24067 | [#2] jquery.html Cycles:180 Average:27399.84 Median:4203.09 stddev:80287.23 (1910.2%) stddev-sans-first:80486.71 13:15:14 INFO - PROCESS | 24067 | Values: 322.3 326.3 347.0 348.8 349.5 16937.9 17284.8 17920.0 18695.4 18791.3 17388.4 17666.9 17864.3 17891.9 17906.9 5082.0 5202.9 5242.4 5247.2 5249.2 5126.3 5215.6 5234.9 5240.3 5242.6 5052.3 5197.2 5206.6 5217.0 5276.9 5198.9 5205.5 5220.6 5227.4 5251.0 4585.4 4644.8 4645.1 4652.0 4655.8 20412.3 20891.7 21034.8 21052.8 21123.5 1908.8 1977.7 2057.8 2655.8 2725.4 8335.2 8515.0 12220.7 12260.5 12668.8 1562.3 1620.8 1671.6 1677.3 1689.6 67877.3 71201.3 71265.6 71338.3 71659.0 9829.0 9926.5 9981.4 10010.5 10242.1 13671.2 13824.7 13833.7 13861.5 13970.2 7548.1 7685.6 7705.3 7758.8 7782.9 7452.4 7522.8 7549.7 7562.8 7624.8 4076.3 4119.3 4157.5 4248.7 4527.3 1731.6 1746.2 1783.7 1811.9 1820.8 892.1 895.0 983.6 992.6 1000.7 15841.5 16409.0 16409.4 16475.7 16760.4 842.1 854.7 883.6 901.8 911.9 9207.2 9306.2 9441.9 9514.8 10270.0 476198.0 480140.0 492732.0 497202.0 497480.3 78671.2 81470.6 82617.0 82832.0 83356.6 1046.6 1052.7 1061.4 1062.0 1091.6 15865.7 15904.1 15973.5 15980.7 16128.0 36201.3 36391.8 36742.6 37288.1 37326.3 51024.5 51523.2 51926.2 52340.2 53295.7 7428.5 7741.9 7769.9 7815.5 7954.4 11522.4 12568.4 12646.1 12850.6 12947.9 10452.9 10594.3 10852.2 10920.9 11155.6 10367.7 10767.7 11003.6 11049.0 11128.8 6971.0 8204.8 10556.9 10869.8 11541.2 7626.6 7630.0 7714.0 7724.4 7841.7 7784.0 9540.0 10760.9 11364.0 11450.4 13:15:14 INFO - PROCESS | 24067 | 13:15:14 INFO - PROCESS | 24067 | [#3] mootools.html Cycles:180 Average:5336.51 Median:6330.26 stddev:2832.87 (44.8%) stddev-sans-first:2824.19 13:15:14 INFO - PROCESS | 24067 | Values: 1252.7 1445.5 1469.3 1614.2 1763.1 7179.5 7370.6 7418.4 7433.5 7442.5 7321.7 7447.1 7459.4 7469.2 7473.0 1803.5 1845.3 2174.1 2180.0 2204.2 2230.9 2242.9 2243.7 2244.8 2246.7 2178.4 2193.2 2215.8 2218.6 2220.1 2149.5 2179.2 2186.3 2186.4 2195.1 2168.3 2177.0 2179.5 2186.5 2189.3 7561.4 7584.0 7585.8 7593.6 7668.6 4609.6 4831.3 4835.3 4858.7 4861.8 3064.5 3106.6 3153.9 3156.7 3170.6 902.6 916.6 956.5 958.6 971.6 10869.1 10937.7 10950.3 10998.8 11018.2 4065.7 4150.1 4164.1 4177.8 4204.7 9090.0 9090.2 9112.8 9121.3 9123.7 4787.3 4809.5 4831.6 4844.4 4846.2 3838.3 4343.1 4385.9 4386.6 4418.1 3552.1 3583.5 3620.5 3630.1 3679.2 1134.4 1150.0 1153.7 1153.9 1154.9 1286.1 1292.8 1304.1 1317.5 1319.3 7036.3 7073.6 7076.4 7081.0 7084.5 412.2 416.1 418.2 419.4 421.9 5308.7 5337.4 5350.7 5387.5 5395.6 9155.0 9210.4 9323.0 9323.3 9507.7 9344.7 9365.0 9394.0 9414.2 9425.1 6978.7 7120.8 7177.7 7238.2 7329.9 6854.9 6874.4 6895.2 6904.0 6940.0 8200.8 8525.2 8531.4 8558.3 8562.4 8507.5 8722.6 8725.5 8726.7 8824.8 6739.2 6888.3 6996.8 7008.3 7018.4 7309.2 7350.3 7367.3 7371.8 7374.4 6243.8 6398.4 6448.5 6555.9 6575.6 6354.5 6366.4 6414.9 6421.3 6582.6 6565.2 6578.2 6601.0 6605.9 6650.4 5988.9 6226.3 6258.1 6274.2 6316.4 6344.1 6350.3 6351.4 6370.2 6378.9 13:15:14 INFO - PROCESS | 24067 | 13:15:14 INFO - PROCESS | 24067 | [#4] prototype.html Cycles:180 Average:5168.27 Median:6047.62 stddev:1625.69 (26.9%) stddev-sans-first:1588.52 13:15:14 INFO - PROCESS | 24067 | Values: 292.5 296.9 297.0 301.1 302.5 5824.5 5964.8 6019.0 6020.8 6055.5 5847.7 5897.1 5902.9 5932.7 5956.4 4170.2 4221.7 4249.9 4331.1 4342.9 4228.2 4241.4 4360.6 4373.4 4418.4 4317.6 4323.9 4338.5 4351.4 4382.5 4120.0 4205.5 4330.6 4374.1 4383.8 3723.1 3727.4 3735.0 3744.7 3744.9 5616.0 5659.9 5660.0 5696.1 5731.3 4994.9 5006.8 5012.7 5026.9 5038.2 6147.6 6148.6 6157.1 6160.9 6161.0 4118.8 4145.5 4146.4 4154.2 4161.7 6270.6 6409.7 6475.0 6479.0 6483.9 4194.1 4197.4 4215.8 4221.1 4227.4 4263.0 4268.1 4270.2 4272.6 4282.3 5014.3 5016.9 5018.1 5022.9 5026.4 6219.0 6228.9 6231.6 6234.7 6237.4 1433.4 1480.3 1496.4 1497.2 1498.2 949.3 952.0 965.4 967.9 969.8 5859.1 5907.0 5946.6 5997.8 6001.3 6449.7 6473.0 6495.8 6496.5 6508.0 6000.8 6039.8 6056.3 6062.9 6066.2 3445.4 3467.4 3474.0 3484.7 3485.7 6537.5 6705.9 6710.3 6721.7 6733.8 6566.9 6602.3 6606.3 6606.6 6616.8 6678.1 6700.5 6708.9 6725.2 6725.4 6437.9 6454.5 6457.1 6461.5 6471.8 6363.7 6369.7 6369.9 6377.9 6379.9 6531.7 6710.0 6734.2 6742.3 6752.8 4165.8 4209.5 4219.0 4221.6 4225.4 6463.7 6464.6 6479.8 6482.8 6485.3 6287.7 6301.5 6311.0 6323.2 6325.7 6070.7 6268.1 6269.1 6289.4 6298.0 6136.4 6144.0 6172.1 6176.1 6180.4 6334.7 6344.7 6349.9 6351.2 6380.5 6109.1 6126.8 6129.5 6161.2 6165.2 13:15:14 INFO - PROCESS | 24067 | 13:15:14 INFO - PROCESS | 24067 | [#5] yui.html Cycles:180 Average:14445.73 Median:47054.15 stddev:16925.58 (36.0%) stddev-sans-first:16941.54 13:15:14 INFO - PROCESS | 24067 | Values: 690.6 706.4 720.7 731.7 802.5 12990.9 13040.0 13138.9 13145.7 13234.7 11278.9 12234.5 12300.4 12328.3 12331.1 812.1 835.1 837.1 838.8 840.2 838.4 842.5 845.1 845.4 845.6 690.6 850.2 871.8 878.0 879.0 866.9 867.9 870.1 873.5 874.9 626.0 627.9 628.7 629.2 630.2 12689.9 12708.5 12744.2 12800.2 12845.3 13133.3 13730.9 13836.5 13838.5 14214.1 10169.3 10474.1 10576.7 10680.7 10697.8 3241.0 3327.5 3361.0 3369.6 3446.9 47253.0 47670.8 47713.0 48176.3 48413.0 9622.3 9964.3 10048.9 10246.0 10401.2 17439.9 17526.1 17536.3 17545.5 17554.8 7127.0 7172.2 7238.3 7242.8 7377.9 4248.8 4341.5 4374.3 4509.1 4535.5 3045.9 3088.9 3099.0 3103.0 3104.5 496.2 562.8 565.4 612.1 621.3 754.3 779.8 782.4 805.5 814.7 8612.2 8889.4 8951.8 9037.1 9040.6 750.5 794.5 794.7 800.2 830.7 4199.5 4315.2 4318.2 4330.2 4457.9 61785.4 63304.7 63453.0 63572.0 63702.0 52358.2 52836.2 53496.5 55019.2 56291.9 45276.8 47014.8 47049.0 48520.0 49183.5 9784.7 9823.3 9948.9 9980.3 10010.3 36761.3 37144.0 37404.4 38675.0 39183.2 47059.3 48446.5 49213.5 50112.5 50748.5 11997.1 12058.6 12172.1 12284.6 12477.4 12028.0 13157.7 13361.9 13378.3 13527.8 11671.0 12704.5 12905.5 13025.5 13748.4 12355.6 12500.6 12590.0 12819.6 12933.5 12077.3 12134.9 12459.2 12568.9 12943.7 9385.4 9401.6 9548.3 9626.5 9806.3 9803.8 10063.7 10089.2 10102.2 10119.6 13:15:14 INFO - PROCESS | 24067 | -------- Summary: end -------- 13:15:14 INFO - PROCESS | 24067 | 13:15:15 INFO - TEST-INFO | 24067: exit 0 13:15:15 INFO - TEST-OK | dromaeo_css | took 1110232ms 13:15:15 INFO - TEST-START | kraken 13:15:15 INFO - operating with platform_type : linux_ 13:15:15 INFO - Initialising browser for kraken test... 13:15:15 INFO - TEST-INFO | started process 24251 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiCOERu/profile http://localhost:59214/getInfo.html) 13:15:19 INFO - PROCESS | 24251 | __metrics Screen width/height:1600/1200 13:15:19 INFO - PROCESS | 24251 | colorDepth:24 13:15:19 INFO - PROCESS | 24251 | Browser inner width/height: 1024/697 13:15:19 INFO - PROCESS | 24251 | __metrics 13:15:19 ERROR - PROCESS | 24251 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:15:20 INFO - PROCESS | 24251 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 13:15:20 INFO - TEST-INFO | 24251: exit 0 13:15:20 INFO - Browser initialized. 13:15:20 INFO - Running cycle 1/1 for kraken test... 13:15:20 INFO - TEST-INFO | started process 24335 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiCOERu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:15:32 INFO - PROCESS | 24335 | RSS: Main: 153079808 13:15:32 INFO - PROCESS | 24335 | 13:15:34 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59214/tests/kraken/driver.html?testName=audio-beat-detection) 13:15:35 INFO - PROCESS | 24335 | RSS: Main: 194318336 13:15:35 INFO - PROCESS | 24335 | 13:15:38 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59214/tests/kraken/driver.html?testName=audio-dft) 13:15:38 INFO - PROCESS | 24335 | RSS: Main: 183787520 13:15:38 INFO - PROCESS | 24335 | 13:15:41 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59214/tests/kraken/driver.html?testName=audio-fft) 13:15:42 INFO - PROCESS | 24335 | RSS: Main: 168763392 13:15:42 INFO - PROCESS | 24335 | 13:15:44 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59214/tests/kraken/driver.html?testName=audio-oscillator) 13:15:45 INFO - PROCESS | 24335 | RSS: Main: 170881024 13:15:45 INFO - PROCESS | 24335 | 13:15:47 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59214/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:15:47 INFO - PROCESS | 24335 | RSS: Main: 172572672 13:15:47 INFO - PROCESS | 24335 | 13:15:50 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59214/tests/kraken/driver.html?testName=imaging-darkroom) 13:15:51 INFO - PROCESS | 24335 | RSS: Main: 173359104 13:15:51 INFO - PROCESS | 24335 | 13:15:54 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59214/tests/kraken/driver.html?testName=imaging-desaturate) 13:15:55 INFO - PROCESS | 24335 | RSS: Main: 173948928 13:15:55 INFO - PROCESS | 24335 | 13:15:58 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59214/tests/kraken/driver.html?testName=json-parse-financial) 13:15:58 INFO - PROCESS | 24335 | RSS: Main: 173920256 13:15:58 INFO - PROCESS | 24335 | 13:16:00 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59214/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:16:00 INFO - PROCESS | 24335 | RSS: Main: 187637760 13:16:00 INFO - PROCESS | 24335 | 13:16:02 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:16:03 INFO - PROCESS | 24335 | RSS: Main: 184520704 13:16:03 INFO - PROCESS | 24335 | 13:16:05 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:16:05 INFO - PROCESS | 24335 | RSS: Main: 193327104 13:16:05 INFO - PROCESS | 24335 | 13:16:08 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:16:08 INFO - PROCESS | 24335 | RSS: Main: 201334784 13:16:08 INFO - PROCESS | 24335 | 13:16:11 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:16:11 INFO - PROCESS | 24335 | RSS: Main: 201039872 13:16:11 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | Cycle 1(1): loaded http://localhost:59214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59214/tests/kraken/driver.html?testName=ai-astar) 13:16:13 INFO - PROCESS | 24335 | RSS: Main: 263528448 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | __start_tp_report 13:16:13 INFO - PROCESS | 24335 | _x_x_mozilla_page_load 13:16:13 INFO - PROCESS | 24335 | _x_x_mozilla_page_load_details 13:16:13 INFO - PROCESS | 24335 | |i|pagename|runs| 13:16:13 INFO - PROCESS | 24335 | |0;ai-astar;113;112;105;110;111;110;101;110;110;111 13:16:13 INFO - PROCESS | 24335 | |1;audio-beat-detection;154;128;158;176;129;159;153;132;172;135 13:16:13 INFO - PROCESS | 24335 | |2;audio-dft;163;164;163;164;164;163;164;168;167;164 13:16:13 INFO - PROCESS | 24335 | |3;audio-fft;77;76;101;98;76;72;76;127;112;75 13:16:13 INFO - PROCESS | 24335 | |4;audio-oscillator;94;95;140;93;94;93;138;93;93;139 13:16:13 INFO - PROCESS | 24335 | |5;imaging-gaussian-blur;117;117;117;118;118;117;117;117;117;117 13:16:13 INFO - PROCESS | 24335 | |6;imaging-darkroom;146;146;145;146;147;146;147;150;147;145 13:16:13 INFO - PROCESS | 24335 | |7;imaging-desaturate;95;96;95;96;95;98;95;95;96;96 13:16:13 INFO - PROCESS | 24335 | |8;json-parse-financial;57;58;57;57;56;56;58;65;55;55 13:16:13 INFO - PROCESS | 24335 | |9;json-stringify-tinderbox;61;60;60;61;59;60;64;62;62;60 13:16:13 INFO - PROCESS | 24335 | |10;stanford-crypto-aes;80;79;79;79;79;79;79;80;86;80 13:16:13 INFO - PROCESS | 24335 | |11;stanford-crypto-ccm;123;113;116;115;116;122;112;129;113;110 13:16:13 INFO - PROCESS | 24335 | |12;stanford-crypto-pbkdf2;141;147;141;141;135;134;148;140;141;148 13:16:13 INFO - PROCESS | 24335 | |13;stanford-crypto-sha256-iterative;69;70;66;63;65;64;64;66;65;65 13:16:13 INFO - PROCESS | 24335 | __end_tp_report 13:16:13 INFO - PROCESS | 24335 | __start_cc_report 13:16:13 INFO - PROCESS | 24335 | _x_x_mozilla_cycle_collect,1076 13:16:13 INFO - PROCESS | 24335 | __end_cc_report 13:16:13 INFO - PROCESS | 24335 | __startTimestamp1458936973800__endTimestamp 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | ------- Summary: start ------- 13:16:13 INFO - PROCESS | 24335 | Number of tests: 14 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:3.59 (3.3%) stddev-sans-first:3.55 13:16:13 INFO - PROCESS | 24335 | Values: 113.0 112.0 105.0 110.0 111.0 110.0 101.0 110.0 110.0 111.0 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:156.00 stddev:17.65 (11.3%) stddev-sans-first:18.64 13:16:13 INFO - PROCESS | 24335 | Values: 154.0 128.0 158.0 176.0 129.0 159.0 153.0 132.0 172.0 135.0 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:1.71 (1.0%) stddev-sans-first:1.74 13:16:13 INFO - PROCESS | 24335 | Values: 163.0 164.0 163.0 164.0 164.0 163.0 164.0 168.0 167.0 164.0 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#3] audio-fft Cycles:10 Average:89.00 Median:76.00 stddev:19.25 (25.3%) stddev-sans-first:19.92 13:16:13 INFO - PROCESS | 24335 | Values: 77.0 76.0 101.0 98.0 76.0 72.0 76.0 127.0 112.0 75.0 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#4] audio-oscillator Cycles:10 Average:107.20 Median:93.00 stddev:21.96 (23.6%) stddev-sans-first:22.77 13:16:13 INFO - PROCESS | 24335 | Values: 94.0 95.0 140.0 93.0 94.0 93.0 138.0 93.0 93.0 139.0 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:16:13 INFO - PROCESS | 24335 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:1.43 (1.0%) stddev-sans-first:1.51 13:16:13 INFO - PROCESS | 24335 | Values: 146.0 146.0 145.0 146.0 147.0 146.0 147.0 150.0 147.0 145.0 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 13:16:13 INFO - PROCESS | 24335 | Values: 95.0 96.0 95.0 96.0 95.0 98.0 95.0 95.0 96.0 96.0 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:2.88 (5.0%) stddev-sans-first:3.05 13:16:13 INFO - PROCESS | 24335 | Values: 57.0 58.0 57.0 57.0 56.0 56.0 58.0 65.0 55.0 55.0 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:1.45 (2.4%) stddev-sans-first:1.54 13:16:13 INFO - PROCESS | 24335 | Values: 61.0 60.0 60.0 61.0 59.0 60.0 64.0 62.0 62.0 60.0 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.50 stddev:2.16 (2.7%) stddev-sans-first:2.29 13:16:13 INFO - PROCESS | 24335 | Values: 80.0 79.0 79.0 79.0 79.0 79.0 79.0 80.0 86.0 80.0 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:116.00 stddev:5.93 (5.1%) stddev-sans-first:5.87 13:16:13 INFO - PROCESS | 24335 | Values: 123.0 113.0 116.0 115.0 116.0 122.0 112.0 129.0 113.0 110.0 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.60 Median:141.00 stddev:4.90 (3.5%) stddev-sans-first:5.20 13:16:13 INFO - PROCESS | 24335 | Values: 141.0 147.0 141.0 141.0 135.0 134.0 148.0 140.0 141.0 148.0 13:16:13 INFO - PROCESS | 24335 | 13:16:13 INFO - PROCESS | 24335 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.50 stddev:2.21 (3.4%) stddev-sans-first:2.00 13:16:13 INFO - PROCESS | 24335 | Values: 69.0 70.0 66.0 63.0 65.0 64.0 64.0 66.0 65.0 65.0 13:16:13 INFO - PROCESS | 24335 | -------- Summary: end -------- 13:16:13 INFO - PROCESS | 24335 | 13:16:14 INFO - TEST-INFO | 24335: exit 0 13:16:14 INFO - TEST-OK | kraken | took 59181ms 13:16:14 INFO - SUITE-END | took 1169s 13:16:14 INFO - Completed test suite (00:19:29) 13:16:14 INFO - javascript benchmark 13:16:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2994.8502574871254, 3042.376312855865, 3063.2188791858075, 3075.507918733003, 3107.3319236364187, 5001.374828146481, 5129.051125541778, 5159.690418574884, 5197.532222100005, 5207.583393328534, 5229.3201883755055, 5241.2924255225535, 5248.186531087687, 5282.07563676357, 5319.335083114611, 4644.047970166124, 4665.1602711512, 4677.976610116944, 4750.738709370983, 4791.568758811706, 4755.3104799804005, 4762.761681962697, 4789.305550695147, 4816.54242846929, 4864.464908860023, 4589.678722489427, 4652.488226295105, 4717.905641887178, 4722.102800467935, 4769.475357710649, 4672.345871577982, 4704.952950470486, 4707.7175369477945, 4710.175719249152, 4756.429228492569, 4498.280275155959, 4664.766761661937, 4690.742009189493, 4721.220998535237, 4725.66920315578, 5178.093833579109, 5199.1161502544655, 5201.609879259071, 5206.973965130188, 5241.109011468059, 5580.972095139498, 5620.381758006616, 5621.100623900156, 5624.128260119688, 5624.775008999676, 5275.683458992473, 5595.272614560081, 5610.354809196954, 5705.0, 5708.657480551139, 5097.337346144977, 5109.846704598831, 5110.080185566597, 5114.565261952738, 5168.147255702805, 5552.69460179694, 5567.4432556744005, 5569.164625306155, 5588.524975377139, 5597.160425936061, 5355.732213389315, 5382.058139825514, 5420.620556561003, 5471.781128754885, 5504.944950550524, 5570.136628822539, 5584.050711379075, 5586.972065139729, 5592.496675299242, 5604.299462567179, 5561.388247292794, 5586.245856809279, 5596.552275818006, 5596.608237423423, 5630.155476678531, 5404.378496472956, 5584.664920104807, 5649.350324712711, 5666.886662266732, 5680.289963754531, 4262.062346283813, 4273.444452221192, 4277.465316835395, 4278.764667943293, 4312.396264522969, 3750.4186851038135, 3823.9617603824163, 3845.3270677631303, 3855.575886652466, 3888.183481468867, 5295.523402893681, 5336.973315133399, 5359.035373632705, 5398.163284690879, 5421.864453388697, 5627.127795191752, 5640.0, 5668.291463567054, 5681.176229446707, 5684.37471878093, 5094.745262736922, 5261.868453288622, 5315.707636079976, 5315.973420132875, 5318.361796584357, 4737.976310118427, 4752.7861246244, 4757.333973243749, 4766.451858036301, 4813.205821039559, 5791.102379131242, 5846.239988801429, 5876.265466816648, 5877.823665290048, 5923.022701254331, 5516.531094856982, 5655.519280861008, 5674.687892165971, 5691.630044047124, 5713.771449141987, 5874.471297583238, 5883.558733094949, 5883.882322353444, 5895.380984996514, 5911.881762364815, 5534.335879694462, 5539.25220095282, 5546.58400619947, 5560.805371811967, 5575.9163612545035, 5494.945050549603, 5603.719814009365, 5607.943920560742, 5637.3235211774845, 5675.943240567542, 5468.863278418072, 5469.206964989975, 5471.890562188654, 5472.042392581362, 5511.972440137773, 5364.839054828361, 5409.107497262908, 5412.648177868426, 5421.40364559906, 5464.945350546603, 5241.0, 5346.117890548016, 5386.649867758583, 5389.056915039774, 5439.619226654097, 5326.733663316896, 5374.838754837361, 5379.65032272901, 5402.75687594067, 5452.127659574449, 5263.157894736823, 5309.123994540858, 5311.41574426805, 5311.654742441729, 5349.705766182898], "unit": "score", "name": "dojo.html", "value": 5141.712106788902}, {"lowerIsBetter": false, "replicates": [547.6334740961042, 559.0635685227244, 580.9302883653961, 585.6749504025264, 587.7443312159211, 39477.210455790904, 40365.39451908216, 40406.59593404065, 40514.39228411576, 40549.59450405495, 43704.781476092576, 44063.11873762523, 44161.0, 44178.0, 44189.337159942625, 8512.914870851306, 8664.220220180183, 8690.695825646104, 8707.912920870805, 8740.213380795727, 8572.657093716243, 8695.782605434852, 8701.564921753887, 8711.34664900135, 8715.128487151265, 8901.06538813425, 8969.0, 8975.551222438851, 8977.416467929595, 8980.28157747382, 8806.735797926072, 8824.514651694155, 8835.293176545892, 8836.602352894135, 8916.108389161065, 8571.871421928676, 8659.523726195057, 8669.826603467958, 8688.695895643623, 8701.955765308203, 41255.58744412548, 41830.0, 41920.79039604813, 42289.788551057354, 42503.36244956328, 3524.2775231077567, 3653.0867283179205, 3844.9231015379537, 3859.286032084073, 4319.632831209351, 31975.6802431975, 32202.516962245583, 32391.190220244684, 32507.187320316945, 33625.83187084073, 4334.956650433518, 4341.370501277297, 4348.782560871944, 4406.493253275882, 4587.128445595326, 321437.0, 322784.0, 323194.0, 323336.0, 324059.37970310234, 55848.44151558514, 58770.0, 65862.0, 66967.66516167486, 66991.66504167546, 60833.0, 60993.98569164603, 61258.0, 61473.0, 61739.38260617426, 17170.282971702978, 17380.65238695219, 17433.0, 17487.125643718016, 17502.91248543749, 12077.27536347822, 12080.818787718192, 12809.167404118702, 12867.613971580868, 12891.097623166475, 20646.587068258552, 21538.676919846213, 21759.456013599785, 21818.799966001705, 21969.780302197094, 6951.374376306157, 7023.403010744042, 7023.578585284797, 7114.561322003492, 7174.390176834923, 867.3148212911855, 882.82343531294, 936.6534382278601, 1056.7199692081604, 1064.5582083435443, 27816.582751258746, 28040.158795236177, 28523.0, 28532.144035678964, 28567.85716071448, 968.2641192693603, 1017.3743147963949, 1033.4574348467115, 1040.890706475809, 1066.5520481397832, 14254.429822806971, 14830.406783728746, 14851.331690073972, 14903.254837258311, 14996.175210363317, 388238.0, 393287.0, 393882.0, 395593.0, 395593.0, 57891.0, 59426.40573594295, 59750.40249597535, 59950.40049599448, 60033.0, 1257.0697683714168, 1399.9230042347565, 1417.2276109520337, 1431.055503367793, 1527.2440142129494, 29104.0, 30415.54376684307, 31247.375052499276, 32960.340793183525, 32985.505217421276, 46482.0, 46569.0, 46878.0, 47188.7640561795, 47262.76368618135, 267903.0, 268302.0, 269195.0, 269267.0, 270813.0, 30914.227144321572, 36765.63234367622, 36850.44724329084, 37372.62627373692, 37449.43825842669, 43358.34962475629, 43399.34900976425, 43472.0, 43755.0, 43839.56160438355, 38661.420078699404, 39610.60389396069, 39779.2044159121, 39798.403023955245, 39800.0, 38198.0, 39293.21413571655, 39332.606673932896, 40133.1973360537, 40617.79691101644, 39890.40164397479, 39895.2020959585, 41065.38401924033, 41115.588844111175, 41314.380284295155, 32993.67006329906, 35273.29453410866, 35520.0, 35988.64011359853, 36174.0, 27230.0, 27475.86262068677, 27486.18094219505, 27715.58426623562, 27955.0], "unit": "score", "name": "ext.html", "value": 19464.165609832806}, {"lowerIsBetter": false, "replicates": [322.3392046305074, 326.33427807273165, 346.99999999999994, 348.82384395880075, 349.5386090360724, 16937.915310423446, 17284.827151728477, 17920.0, 18695.439136825917, 18791.342303019395, 17388.391406300783, 17666.911665441687, 17864.28542858284, 17891.910540447312, 17906.910465447687, 5081.9745901270535, 5202.921956170641, 5242.449542798008, 5247.239150323201, 5249.1601343785005, 5126.282320475118, 5215.556677682402, 5234.947650523503, 5240.3187585614005, 5242.606804489659, 5052.292679024939, 5197.194434862602, 5206.5834733221445, 5216.973915130419, 5276.868078298035, 5198.922016169741, 5205.453427390145, 5220.556252718524, 5227.398849132342, 5250.973745131269, 4585.358049873021, 4644.814207431698, 4645.070985802853, 4651.976740116278, 4655.790489427984, 20412.285570004977, 20891.68662470049, 21034.789652103434, 21052.789472105236, 21123.47191320214, 1908.761404824397, 1977.6637971544872, 2057.794220577945, 2655.81409301349, 2725.4004119093765, 8335.249827515492, 8514.957425212897, 12220.694482638006, 12260.509579616804, 12668.80996785049, 1562.2501199424225, 1620.8460196281335, 1671.6071723145174, 1677.2620047179323, 1689.6113893804493, 67877.32122678809, 71201.28798712051, 71265.64367178183, 71338.2866171342, 71659.0, 9828.950855245677, 9926.454045027593, 9981.401115933068, 10010.546361505269, 10242.078212960869, 13671.248081355621, 13824.723505529833, 13833.723325533634, 13861.544537823384, 13970.161790292412, 7548.131964824115, 7685.5772932488135, 7705.345045671069, 7758.7672369829, 7782.910392545048, 7452.441066920002, 7522.774316770506, 7549.7357592483995, 7562.773116806505, 7624.809379765439, 4076.3477843544892, 4119.299719047769, 4157.48031496063, 4248.702590818675, 4527.253003254492, 1731.5584525945803, 1746.214203608356, 1783.6967715488397, 1811.9003454810113, 1820.7527843427295, 892.0811564088999, 894.9642014319354, 983.5918093990914, 992.6228033347281, 1000.6697789729371, 15841.52475425716, 16409.0, 16409.42567010149, 16475.67048659044, 16760.413385531447, 842.1388730904647, 854.7179430787825, 883.6156272021562, 901.7610333261691, 911.886014248219, 9207.17135457812, 9306.162445379812, 9441.905580944103, 9514.809703805886, 10270.0, 476198.0, 480140.0, 492732.0, 497202.0, 497480.2771695111, 78671.21328786753, 81470.59264703639, 82617.0, 82832.0, 83356.58321708352, 1046.576136664652, 1052.7473406382567, 1061.400308825511, 1062.033549469994, 1091.6070214722693, 15865.658411453176, 15904.129683498762, 15973.520794376187, 15980.680386391974, 16128.0, 36201.27597447984, 36391.818040909624, 36742.63257367499, 37288.067798304175, 37326.25347492981, 51024.489755101975, 51523.22715159201, 51926.221106684185, 52340.21489677582, 53295.73352133214, 7428.517146385468, 7741.92258077412, 7769.8834517481155, 7815.53106813593, 7954.363650908029, 11522.366269855238, 12568.434420450918, 12646.114771965875, 12850.614481565568, 12947.870521294666, 10452.895471045496, 10594.261067513464, 10852.240343176218, 10920.922619344741, 11155.609553665583, 10367.688969330931, 10767.730806729895, 11003.559857605926, 11049.0, 11128.777424451628, 6970.9543568463105, 8204.794880128045, 10556.947215263874, 10869.78260434771, 11541.249818761753, 7626.618669066635, 7630.046244219473, 7713.961430192813, 7724.382049436144, 7841.725539606086, 7784.026996625422, 9540.0, 10760.892391076302, 11364.034057104907, 11450.37022963745], "unit": "score", "name": "jquery.html", "value": 8406.586381318279}, {"lowerIsBetter": false, "replicates": [1252.6805664555536, 1445.472402573061, 1469.2800527741406, 1614.2251719174797, 1763.109629637033, 7179.461540384473, 7370.5577665340115, 7418.369438597726, 7433.516821406605, 7442.516236444627, 7321.743738969137, 7447.143578488475, 7459.4032477401815, 7469.178390377067, 7472.96263518683, 1803.4769916724135, 1845.335679155503, 2174.0760176924823, 2180.040782055898, 2204.184451752854, 2230.9107635694636, 2242.921497747579, 2243.6971008913833, 2244.820414366855, 2246.663000549914, 2178.400939741568, 2193.2214064007285, 2215.7673444288357, 2218.5562887422498, 2220.1341476823973, 2149.473379022134, 2179.24815938501, 2186.28945592683, 2186.365953873375, 2195.078067211775, 2168.2627906511702, 2177.0, 2179.4769255378756, 2186.464316242515, 2189.2665956904457, 7561.357284630813, 7584.0, 7585.81035474112, 7593.6203189840835, 7668.578228197447, 4609.585137337622, 4831.323614693945, 4835.347228124193, 4858.732769697665, 4861.829835955725, 3064.5403189521526, 3106.6272047354237, 3153.8896138635037, 3156.6527681954967, 3170.556122142902, 902.571278642646, 916.5646317998963, 956.5217391304348, 958.6261358070358, 971.5579411367811, 10869.130469562495, 10937.671869843838, 10950.34297942126, 10998.780024399468, 11018.173636977259, 4065.6747460203114, 4150.06623509714, 4164.12553363797, 4177.832886684499, 4204.684648651302, 9090.0, 9090.227330676835, 9112.817743645222, 9121.31590130743, 9123.680671176477, 4787.281907713871, 4809.495003024702, 4831.637627177975, 4844.442889067803, 4846.224604063404, 3838.328292548793, 4343.131373725268, 4385.912281754411, 4386.561343865588, 4418.116376724668, 3552.1474846036767, 3583.4624806278744, 3620.4931309616672, 3630.074331045619, 3679.1537946271974, 1134.387430787382, 1149.9770004599861, 1153.7173392518887, 1153.94807233673, 1154.9133814963911, 1286.0676009892752, 1292.8060790881443, 1304.0871390027019, 1317.5059352742721, 1319.300770591588, 7036.331548502884, 7073.575585464889, 7076.398506126934, 7081.044059052065, 7084.539504932163, 412.24764804232393, 416.10329739411617, 418.18662701046173, 419.427481487767, 421.8860907554943, 5308.734563271821, 5337.386200586904, 5350.732463376816, 5387.488188622075, 5395.62230643859, 9154.954225228832, 9210.401323913924, 9322.953385233166, 9323.300752443594, 9507.714768556954, 9344.719658410258, 9365.0, 9394.0, 9414.246860251164, 9425.05749425052, 6978.70893884633, 7120.786376408716, 7177.6770045348085, 7238.203797582261, 7329.853402931912, 6854.862902742017, 6874.415674667709, 6895.172579290517, 6904.0, 6940.02839602446, 8200.835983280182, 8525.19010693983, 8531.360147988802, 8558.315334773328, 8562.443441176303, 8507.532085735344, 8722.563871806258, 8725.520096394504, 8726.69456569017, 8824.823503530022, 6739.19129704419, 6888.276730943179, 6996.790096297119, 7008.299170082951, 7018.403435708022, 7309.232530584425, 7350.338469537767, 7367.26327367259, 7371.778846634609, 7374.446916481178, 6243.8126856194385, 6398.392152745481, 6448.451881590117, 6555.901661474986, 6575.572587781779, 6354.52341074412, 6366.395192456709, 6414.93585064162, 6421.261554921057, 6582.572132811352, 6565.179352580927, 6578.24350199714, 6601.042848786803, 6605.867882642417, 6650.401463868275, 5988.850278743066, 6226.25284965807, 6258.061290806233, 6274.152989346379, 6316.431521163117, 6344.080108384166, 6350.333215012357, 6351.428371446592, 6370.203724534434, 6378.936210637834], "unit": "score", "name": "mootools.html", "value": 4281.890080386132}, {"lowerIsBetter": false, "replicates": [292.5261077055171, 296.91092672198334, 297.04500032395845, 301.07119536230726, 302.5159744408946, 5824.504917082042, 5964.79123230687, 6018.969905150474, 6020.789272375468, 6055.455009049185, 5847.736851841667, 5897.085951677497, 5902.940970590293, 5932.733027013784, 5956.434138756822, 4170.186813571355, 4221.683373746966, 4249.915001699964, 4331.133773245348, 4342.891427714317, 4228.154369126171, 4241.448611680477, 4360.6075453209205, 4373.365861950031, 4418.403515525395, 4317.589828966259, 4323.935140972888, 4338.544452832454, 4351.369051487548, 4382.517923028464, 4119.958800411988, 4205.495340559122, 4330.588594083557, 4374.103308821684, 4383.780810959439, 3723.1436769543157, 3727.422249551324, 3734.9813250933844, 3744.6817020553285, 3744.9438258426144, 5616.0, 5659.8585035374035, 5659.971700141514, 5696.11710184922, 5731.312242530881, 4994.90010199794, 5006.824761133343, 5012.699238045692, 5026.89946201074, 5038.193888977783, 6147.631142131441, 6148.631082135042, 6157.076438534211, 6160.938390616081, 6160.969195154041, 4118.75287482749, 4145.481814773153, 4146.419501269825, 4154.189932963073, 4161.667066634693, 6270.576863632092, 6409.743610255584, 6475.0, 6479.028145778124, 6483.902741458882, 4194.077302993336, 4197.412362269285, 4215.768132752728, 4221.134667393177, 4227.387028880795, 4263.019505513687, 4268.103698223408, 4270.167317373082, 4272.551382104896, 4282.336237883133, 5014.272930425068, 5016.899662006739, 5018.071656743514, 5022.874428139253, 5026.396832380065, 6218.968905155445, 6228.906566401508, 6231.563790534619, 6234.688265586702, 6237.376262373727, 1433.3764812306472, 1480.2746654139394, 1496.3790027138832, 1497.2438918346165, 1498.2059508460534, 949.264320151874, 951.9714408567754, 965.3918031640162, 967.8596603492454, 969.7914948286011, 5859.091840764689, 5907.0, 5946.554008449383, 5997.760089596454, 6001.309849367379, 6449.677516124175, 6473.0, 6495.837604059936, 6496.480281577463, 6507.967460162764, 6000.819975400745, 6039.78860739872, 6056.273247210275, 6062.939370606326, 6066.150738896558, 3445.4315038018444, 3467.358538670354, 3473.9826300868335, 3484.651534846546, 3485.7385696072897, 6537.477001839841, 6705.932940670628, 6710.328967103348, 6721.6975236114495, 6733.797986060328, 6566.868662626721, 6602.2737498875085, 6606.306337834554, 6606.636634985026, 6616.8345791355605, 6678.065070890079, 6700.530962832555, 6708.899366509506, 6725.159355080615, 6725.428338591275, 6437.935620643733, 6454.451371633276, 6457.063725759833, 6461.547691661539, 6471.838204044937, 6363.681815909279, 6369.713362898588, 6369.90445143314, 6377.87244255103, 6379.872402552016, 6531.706073226811, 6709.993500974698, 6734.158230221223, 6742.325767423218, 6752.763653272112, 4165.750054996589, 4209.463545805697, 4219.0, 4221.641160501269, 4225.408442817947, 6463.709133088928, 6464.644444555594, 6479.838004049937, 6482.773102941374, 6485.286618472059, 6287.685615719287, 6301.495880329654, 6311.0, 6323.177986861679, 6325.746970121328, 6070.696465176635, 6268.059791031382, 6269.090981807703, 6289.40250676185, 6298.0, 6136.417040381157, 6144.0, 6172.105044768573, 6176.104464852661, 6180.351063138485, 6334.746610135728, 6344.651044192614, 6349.936500634934, 6351.2060992375955, 6380.521460890359, 6109.083637454418, 6126.785562505291, 6129.540284478593, 6161.168242287413, 6165.229346331708], "unit": "score", "name": "prototype.html", "value": 4621.760291011258}, {"lowerIsBetter": false, "replicates": [690.6477696374848, 706.4489698035532, 720.7261240728526, 731.6780616528727, 802.542550746075, 12990.93504532476, 13039.999999999987, 13138.934305328472, 13145.67135821605, 13234.669133271662, 11278.943605281962, 12234.510619575207, 12300.446479908403, 12328.260304381743, 12331.136820422551, 812.10262659761, 835.1189495082685, 837.0666706622134, 838.7903024243939, 840.2479780596362, 838.3879767769532, 842.4692443760422, 845.0873057098349, 845.446232717571, 845.5560830563973, 690.6063543780048, 850.2177996243471, 871.7864123289803, 878.0253918150847, 879.0418443896152, 866.8569686001803, 867.9435836670597, 870.0646804684926, 873.5326600268858, 874.8643960186181, 626.0077776723898, 627.8712863862897, 628.6950828848005, 629.1569297141851, 630.2342653675806, 12689.936550317188, 12708.491660333575, 12744.171628844188, 12800.231986080866, 12845.293508857008, 13133.34333283332, 13730.862691373059, 13836.515721949783, 13838.515651952133, 14214.147151170859, 10169.288149829516, 10474.109700675375, 10576.682699519026, 10680.732981675521, 10697.786044279148, 3240.951385729216, 3327.450970589874, 3360.983195084009, 3369.578802649669, 3446.87935922244, 47253.0, 47670.761646191546, 47713.0, 48176.27735583969, 48413.0, 9622.326437149472, 9964.25268104895, 10048.949755251177, 10246.0, 10401.167906567456, 17439.912800435915, 17526.123693815258, 17536.29854805819, 17545.473635790946, 17554.824451755576, 7126.964365178141, 7172.175199851979, 7238.348548630648, 7242.818929526698, 7377.88933166003, 4248.808803603845, 4341.45731783527, 4374.300111982067, 4509.075639493896, 4535.478419981679, 3045.9238519036758, 3088.876444942177, 3099.0392978176837, 3102.953455698166, 3104.456720073978, 496.1590104772448, 562.7664519224476, 565.4034993082255, 612.1246617337162, 621.3196549777986, 754.2758951406711, 779.7757520692459, 782.3819182845602, 805.5207151744703, 814.722994181981, 8612.18184272493, 8889.377743558018, 8951.776205594912, 9037.141471560191, 9040.598707200394, 750.4709180028067, 794.4597673582019, 794.6821271491334, 800.2117913854848, 830.7258604660448, 4199.538050814408, 4315.158544083936, 4318.201132790381, 4330.155619654137, 4457.888552786141, 61785.382146177966, 63304.68347658325, 63453.0, 63572.0, 63702.0, 52358.21462678063, 52836.20745688818, 53496.465035349145, 55019.17471237935, 56291.90394528258, 45276.77361613171, 47014.76492617515, 47049.0, 48520.0, 49183.50816491789, 9784.706458806248, 9823.312368134162, 9948.900510994798, 9980.301378903407, 10010.349327293703, 36761.26477470489, 37144.0, 37404.43893341548, 38675.0, 39183.2163356737, 47059.29411058768, 48446.5155348442, 49213.507864920895, 50112.49887501078, 50748.49251507585, 11997.100217483898, 12058.577949771716, 12172.087093467848, 12284.631461056182, 12477.440319960006, 12028.0, 13157.671058223237, 13361.933190334375, 13378.264195469343, 13527.797083043566, 11671.007964322787, 12704.491820327083, 12905.483780648668, 13025.47898084066, 13748.381322840696, 12355.567555135527, 12500.562480313145, 12590.0, 12819.615411537668, 12933.54732584355, 12077.27536347822, 12134.939325303318, 12459.190152640049, 12568.874311257136, 12943.741125177256, 9385.38994965325, 9401.576929038072, 9548.283878708986, 9626.518674066128, 9806.26453016041, 9803.803923921625, 10063.748406289902, 10089.243306751876, 10102.191824654157, 10119.645812396531], "unit": "score", "name": "yui.html", "value": 6549.914866494959}], "name": "dromaeo_css", "value": 6912.165999655101}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 105.0, 110.0, 111.0, 110.0, 101.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [154.0, 128.0, 158.0, 176.0, 129.0, 159.0, 153.0, 132.0, 172.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 164.0, 164.0, 163.0, 164.0, 168.0, 167.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 101.0, 98.0, 76.0, 72.0, 76.0, 127.0, 112.0, 75.0], "unit": "score", "name": "audio-fft", "value": 89.0}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 140.0, 93.0, 94.0, 93.0, 138.0, 93.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 147.0, 150.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 98.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 57.0, 57.0, 56.0, 56.0, 58.0, 65.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 60.0, 61.0, 59.0, 60.0, 64.0, 62.0, 62.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.9}, {"lowerIsBetter": true, "replicates": [80.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 80.0, 86.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.0}, {"lowerIsBetter": true, "replicates": [123.0, 113.0, 116.0, 115.0, 116.0, 122.0, 112.0, 129.0, 113.0, 110.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.9}, {"lowerIsBetter": true, "replicates": [141.0, 147.0, 141.0, 141.0, 135.0, 134.0, 148.0, 140.0, 141.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.6}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 66.0, 63.0, 65.0, 64.0, 64.0, 66.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.7}], "name": "kraken", "value": 1501.4000000000003}]} 13:16:15 INFO - Return code: 0 13:16:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:16:15 ERROR - # TBPL SUCCESS # 13:16:15 INFO - Running post-action listener: _resource_record_post_action 13:16:15 INFO - Running post-run listener: _resource_record_post_run 13:16:16 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 529772544; Read time: 12; Write time: 570524 13:16:16 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 249253888; Read time: 0; Write time: 360164 13:16:16 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280518656; Read time: 12; Write time: 210360 13:16:16 INFO - Running post-run listener: _upload_blobber_files 13:16:16 INFO - Blob upload gear active. 13:16:16 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:16:16 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 13:16:16 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'] 13:16:16 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 13:16:16 INFO - (blobuploader) - INFO - Open directory for files ... 13:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 13:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:16:17 INFO - (blobuploader) - INFO - Done attempting. 13:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:16:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:16:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:16:18 INFO - (blobuploader) - INFO - Done attempting. 13:16:18 INFO - (blobuploader) - INFO - Iteration through files over. 13:16:18 INFO - Return code: 0 13:16:18 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:16:18 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:16:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49109ffb613530ed74235c26aa1682b8ed1acbb706cc74afb1a01f96e4de33968ab7e7c5d77245a25ced7b885edf60f9cdf17c6025e457e7b765eb9b2e2f1877", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ed0e9fe9d2b32b98b0000ecafc29a47c587f7ac9963ed9f54829636eff627af0ecde0a640aa01894c4e05234221510369ac412e91a0f77a1c901f68d8c4a3c9"} 13:16:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:16:18 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:16:18 INFO - Contents: 13:16:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49109ffb613530ed74235c26aa1682b8ed1acbb706cc74afb1a01f96e4de33968ab7e7c5d77245a25ced7b885edf60f9cdf17c6025e457e7b765eb9b2e2f1877", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ed0e9fe9d2b32b98b0000ecafc29a47c587f7ac9963ed9f54829636eff627af0ecde0a640aa01894c4e05234221510369ac412e91a0f77a1c901f68d8c4a3c9"} 13:16:18 INFO - Running post-run listener: copy_logs_to_upload_dir 13:16:18 INFO - Copying logs to upload dir... 13:16:18 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:16:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.309123 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-03-25 13:16:17.282699) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 13:16:17.286801) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546 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/49109ffb613530ed74235c26aa1682b8ed1acbb706cc74afb1a01f96e4de33968ab7e7c5d77245a25ced7b885edf60f9cdf17c6025e457e7b765eb9b2e2f1877", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ed0e9fe9d2b32b98b0000ecafc29a47c587f7ac9963ed9f54829636eff627af0ecde0a640aa01894c4e05234221510369ac412e91a0f77a1c901f68d8c4a3c9"} build_url:https://queue.taskcluster.net/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/bWD4isMWTtmhsA6a7AHXCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49109ffb613530ed74235c26aa1682b8ed1acbb706cc74afb1a01f96e4de33968ab7e7c5d77245a25ced7b885edf60f9cdf17c6025e457e7b765eb9b2e2f1877", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ed0e9fe9d2b32b98b0000ecafc29a47c587f7ac9963ed9f54829636eff627af0ecde0a640aa01894c4e05234221510369ac412e91a0f77a1c901f68d8c4a3c9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 13:16:17.311754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 13:16:17.312091) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1458935045.751157-667784546 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 13:16:17.398338) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 13:16:17.398744) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 13:16:17.399133) ========= ========= Total master_lag: 0.30 =========