builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1458180671.49 results: success (0) buildid: 20160316163020 builduid: 350c09673a344ba88752658240434809 revision: 6449a9493de02ed7b9615d690abda0863ef380bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.493287) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.493843) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.494186) ========= 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=8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006383 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.528510) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.528853) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.549637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.549969) ========= 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=8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004590 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.600937) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.601342) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.601767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.602081) ========= 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=8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-16 19:11:11-- 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% 39.4M=0s 2016-03-16 19:11:11 (39.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158112 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.773247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.773613) ========= 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=8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014091 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.824281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:11.824670) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6449a9493de02ed7b9615d690abda0863ef380bf --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 6449a9493de02ed7b9615d690abda0863ef380bf --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=8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-16 19:11:11,943 truncating revision to first 12 chars 2016-03-16 19:11:11,943 Setting DEBUG logging. 2016-03-16 19:11:11,943 attempt 1/10 2016-03-16 19:11:11,943 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6449a9493de0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 19:11:12,202 unpacking tar archive at: mozilla-central-6449a9493de0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.608770 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:12.446665) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:12.447053) ========= echo 6449a9493de02ed7b9615d690abda0863ef380bf in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6449a9493de02ed7b9615d690abda0863ef380bf'] 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=8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6449a9493de02ed7b9615d690abda0863ef380bf program finished with exit code 0 elapsedTime=0.004114 script_repo_revision: '6449a9493de02ed7b9615d690abda0863ef380bf' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:12.502541) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:12.502857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 19:11:12.512843) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-16 19:11:12.513173) ========= /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=8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:11:12 INFO - MultiFileLogger online at 20160316 19:11:12 in /builds/slave/test-pgo 19:11:12 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 19:11:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:11:12 INFO - {'append_to_log': False, 19:11:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:11:12 INFO - 'blob_upload_branch': 'Firefox', 19:11:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:11:12 INFO - 'branch': 'Firefox', 19:11:12 INFO - 'buildbot_json_path': 'buildprops.json', 19:11:12 INFO - 'config_files': ('talos/linux_config.py',), 19:11:12 INFO - 'default_actions': ('clobber', 19:11:12 INFO - 'read-buildbot-config', 19:11:12 INFO - 'download-and-extract', 19:11:12 INFO - 'populate-webroot', 19:11:12 INFO - 'create-virtualenv', 19:11:12 INFO - 'install', 19:11:12 INFO - 'run-tests'), 19:11:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:11:12 INFO - 'download_minidump_stackwalk': True, 19:11:12 INFO - 'download_symbols': 'ondemand', 19:11:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:11:12 INFO - 'tooltool.py': '/tools/tooltool.py', 19:11:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:11:12 INFO - '/tools/misc-python/virtualenv.py')}, 19:11:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:11:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:11:12 INFO - 'installer_path': 'installer.exe', 19:11:12 INFO - 'log_level': 'info', 19:11:12 INFO - 'log_name': 'talos', 19:11:12 INFO - 'log_to_console': True, 19:11:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:11:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:11:12 INFO - 'opt_config_files': (), 19:11:12 INFO - 'pip_index': False, 19:11:12 INFO - 'sps_profile': False, 19:11:12 INFO - 'sps_profile_interval': 0, 19:11:12 INFO - 'suite': 'dromaeojs', 19:11:12 INFO - 'system_bits': '32', 19:11:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:11:12 INFO - 'title': 'talos-linux64-ix-038', 19:11:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:11:12 INFO - 'use_talos_json': True, 19:11:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:11:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:11:12 INFO - 'work_dir': 'build'} 19:11:12 INFO - ##### 19:11:12 INFO - ##### Running clobber step. 19:11:12 INFO - ##### 19:11:12 INFO - Running pre-action listener: _resource_record_pre_action 19:11:12 INFO - Running main action method: clobber 19:11:12 INFO - rmtree: /builds/slave/test-pgo/build 19:11:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:11:13 INFO - Running post-action listener: _resource_record_post_action 19:11:13 INFO - ##### 19:11:13 INFO - ##### Running read-buildbot-config step. 19:11:13 INFO - ##### 19:11:13 INFO - Running pre-action listener: _resource_record_pre_action 19:11:13 INFO - Running main action method: read_buildbot_config 19:11:13 INFO - Using buildbot properties: 19:11:13 INFO - { 19:11:13 INFO - "project": "", 19:11:13 INFO - "product": "firefox", 19:11:13 INFO - "script_repo_revision": "production", 19:11:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:11:13 INFO - "repository": "", 19:11:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:11:13 INFO - "buildid": "20160316163020", 19:11:13 INFO - "pgo_build": "True", 19:11:13 INFO - "basedir": "/builds/slave/test-pgo", 19:11:13 INFO - "buildnumber": 226, 19:11:13 INFO - "slavename": "talos-linux64-ix-038", 19:11:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:11:13 INFO - "platform": "ubuntu64_hw", 19:11:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:11:13 INFO - "branch": "mozilla-central", 19:11:13 INFO - "repo_path": "mozilla-central", 19:11:13 INFO - "revision": "6449a9493de02ed7b9615d690abda0863ef380bf", 19:11:13 INFO - "stage_platform": "linux64-pgo", 19:11:13 INFO - "builduid": "350c09673a344ba88752658240434809", 19:11:13 INFO - "slavebuilddir": "test" 19:11:13 INFO - } 19:11:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:11:13 INFO - Running post-action listener: _resource_record_post_action 19:11:13 INFO - ##### 19:11:13 INFO - ##### Running download-and-extract step. 19:11:13 INFO - ##### 19:11:13 INFO - Running pre-action listener: _resource_record_pre_action 19:11:13 INFO - Running main action method: download_and_extract 19:11:13 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:13 INFO - https://queue.taskcluster.net/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:11:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:11:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:11:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/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 19:11:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/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 19:11:13 INFO - Downloaded 1361 bytes. 19:11:13 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:11:13 INFO - Using the following test package requirements: 19:11:13 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:11:13 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:11:13 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:11:13 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:13 INFO - u'jsshell-linux-x86_64.zip'], 19:11:13 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:11:13 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:11:13 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:11:13 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:11:13 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:11:13 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:11:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:13 INFO - https://queue.taskcluster.net/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:11:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:11:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:11:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/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 19:11:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/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 19:11:19 INFO - Downloaded 23562370 bytes. 19:11:19 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'] 19:11:19 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 19:11:21 INFO - Return code: 0 19:11:21 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 19:11: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')]} 19:11:21 INFO - https://queue.taskcluster.net/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:11:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:11:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:11:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/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 19:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/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 19:11:24 INFO - Downloaded 23562370 bytes. 19:11:24 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'] 19:11:24 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 19:11:26 INFO - Return code: 0 19:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:26 INFO - https://queue.taskcluster.net/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:11:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/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 19:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/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 19:11:27 INFO - Downloaded 10846462 bytes. 19:11:27 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'] 19:11:27 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 19:11:27 INFO - Return code: 0 19:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:27 INFO - https://queue.taskcluster.net/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:11:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:11:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:11:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/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 19:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V9fpQke2QcaiWQHVUZZSUQ/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 19:11:28 INFO - Downloaded 57648531 bytes. 19:11:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:11:28 INFO - mkdir: /builds/slave/test-pgo/properties 19:11:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:11:28 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:11:28 INFO - Contents: 19:11:28 INFO - build_url:https://queue.taskcluster.net/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:11:29 INFO - Running post-action listener: _resource_record_post_action 19:11:29 INFO - Running post-action listener: set_extra_try_arguments 19:11:29 INFO - ##### 19:11:29 INFO - ##### Running populate-webroot step. 19:11:29 INFO - ##### 19:11:29 INFO - Running pre-action listener: _resource_record_pre_action 19:11:29 INFO - Running main action method: populate_webroot 19:11:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:11:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:11:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:11:29 INFO - '--tppagecycles', 19:11:29 INFO - '7'], 19:11:29 INFO - 'tests': ['tsvgm']}}, 19:11:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:11:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:11:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:11:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:11:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:11:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:11:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'talos_options': ['--e10s'], 19:11:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'tests': ['damp', 'tps']}, 19:11:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'talos_options': ['--e10s'], 19:11:29 INFO - 'tests': ['damp', 'tps']}, 19:11:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:11:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:11:29 INFO - 'other': {'tests': ['a11yr', 19:11:29 INFO - 'ts_paint', 19:11:29 INFO - 'tpaint', 19:11:29 INFO - 'sessionrestore', 19:11:29 INFO - 'sessionrestore_no_auto_restore', 19:11:29 INFO - 'tabpaint']}, 19:11:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:11:29 INFO - 'tests': ['a11yr', 19:11:29 INFO - 'ts_paint', 19:11:29 INFO - 'tpaint', 19:11:29 INFO - 'sessionrestore', 19:11:29 INFO - 'sessionrestore_no_auto_restore', 19:11:29 INFO - 'tabpaint']}, 19:11:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:11:29 INFO - 'tests': ['a11yr', 19:11:29 INFO - 'ts_paint', 19:11:29 INFO - 'tpaint', 19:11:29 INFO - 'sessionrestore', 19:11:29 INFO - 'sessionrestore_no_auto_restore', 19:11:29 INFO - 'tabpaint']}, 19:11:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:11:29 INFO - 'tests': ['a11yr', 19:11:29 INFO - 'ts_paint', 19:11:29 INFO - 'tpaint', 19:11:29 INFO - 'sessionrestore', 19:11:29 INFO - 'sessionrestore_no_auto_restore', 19:11:29 INFO - 'tabpaint']}, 19:11:29 INFO - 'other_l64': {'tests': ['a11yr', 19:11:29 INFO - 'ts_paint', 19:11:29 INFO - 'tpaint', 19:11:29 INFO - 'sessionrestore', 19:11:29 INFO - 'sessionrestore_no_auto_restore', 19:11:29 INFO - 'tabpaint']}, 19:11:29 INFO - 'other_nol64': {'tests': ['a11yr', 19:11:29 INFO - 'ts_paint', 19:11:29 INFO - 'tpaint', 19:11:29 INFO - 'sessionrestore', 19:11:29 INFO - 'sessionrestore_no_auto_restore', 19:11:29 INFO - 'tabpaint']}, 19:11:29 INFO - 'svgr': {'tests': ['tsvgx', 19:11:29 INFO - 'tsvgr_opacity', 19:11:29 INFO - 'tart', 19:11:29 INFO - 'tscrollx', 19:11:29 INFO - 'cart']}, 19:11:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:11:29 INFO - 'tests': ['tsvgx', 19:11:29 INFO - 'tsvgr_opacity', 19:11:29 INFO - 'tart', 19:11:29 INFO - 'tscrollx', 19:11:29 INFO - 'cart']}, 19:11:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'tests': ['tp5o']}, 19:11:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'talos_options': ['--e10s'], 19:11:29 INFO - 'tests': ['tp5o']}, 19:11:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'talos_options': ['--xperf_path', 19:11:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:29 INFO - 'tests': ['tp5n']}, 19:11:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:29 INFO - 'talos_options': ['--e10s', 19:11:29 INFO - '--xperf_path', 19:11:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:29 INFO - 'tests': ['tp5n']}}, 19:11:29 INFO - 'talos.zip': {'path': '', 19:11:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:11:29 INFO - Running post-action listener: _resource_record_post_action 19:11:29 INFO - ##### 19:11:29 INFO - ##### Running create-virtualenv step. 19:11:29 INFO - ##### 19:11:29 INFO - Running pre-action listener: _resource_record_pre_action 19:11:29 INFO - Running main action method: create_virtualenv 19:11:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:11:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 19:11:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:11:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:11:29 INFO - Using real prefix '/usr' 19:11:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:11:30 INFO - Installing distribute.............................................................................................................................................................................................done. 19:11:32 INFO - Installing pip.................done. 19:11:32 INFO - Return code: 0 19:11:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:32 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 0x7f7f97b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2248920>, '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 0x2249820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2249cb0>, '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': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:32 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 19:11:32 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 19:11:32 INFO - Using env: {'DISPLAY': ':0', 19:11:32 INFO - 'HOME': '/home/cltbld', 19:11:32 INFO - 'LANG': 'en_US.UTF-8', 19:11:32 INFO - 'LANGUAGE': 'en_US:en', 19:11:32 INFO - 'LOGNAME': 'cltbld', 19:11:32 INFO - 'MAIL': '/var/mail/cltbld', 19:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:32 INFO - 'MOZ_NO_REMOTE': '1', 19:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:32 INFO - 'NO_EM_RESTART': '1', 19:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:11:32 INFO - 'PWD': '/builds/slave/test-pgo', 19:11:32 INFO - 'SHELL': '/bin/bash', 19:11:32 INFO - 'SHLVL': '1', 19:11:32 INFO - 'TERM': 'linux', 19:11:32 INFO - 'TMOUT': '86400', 19:11:32 INFO - 'USER': 'cltbld', 19:11:32 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 19:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:32 INFO - '_': '/tools/buildbot/bin/python'} 19:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:11:32 INFO - Cleaning up... 19:11:32 INFO - Return code: 0 19:11:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:32 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 0x7f7f97b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2248920>, '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 0x2249820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2249cb0>, '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': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:32 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 19:11:32 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 19:11:32 INFO - Using env: {'DISPLAY': ':0', 19:11:32 INFO - 'HOME': '/home/cltbld', 19:11:32 INFO - 'LANG': 'en_US.UTF-8', 19:11:32 INFO - 'LANGUAGE': 'en_US:en', 19:11:32 INFO - 'LOGNAME': 'cltbld', 19:11:32 INFO - 'MAIL': '/var/mail/cltbld', 19:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:32 INFO - 'MOZ_NO_REMOTE': '1', 19:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:32 INFO - 'NO_EM_RESTART': '1', 19:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:11:32 INFO - 'PWD': '/builds/slave/test-pgo', 19:11:32 INFO - 'SHELL': '/bin/bash', 19:11:32 INFO - 'SHLVL': '1', 19:11:32 INFO - 'TERM': 'linux', 19:11:32 INFO - 'TMOUT': '86400', 19:11:32 INFO - 'USER': 'cltbld', 19:11:32 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 19:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:32 INFO - '_': '/tools/buildbot/bin/python'} 19:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:32 INFO - Downloading/unpacking psutil>=0.7.1 19:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:11:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:34 INFO - Installing collected packages: psutil 19:11:34 INFO - Running setup.py install for psutil 19:11:34 INFO - building 'psutil._psutil_linux' extension 19:11:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:11:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:11:34 INFO - building 'psutil._psutil_posix' extension 19:11:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:11:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:11:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:34 INFO - Successfully installed psutil 19:11:34 INFO - Cleaning up... 19:11:34 INFO - Return code: 0 19:11:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:34 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 0x7f7f97b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2248920>, '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 0x2249820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2249cb0>, '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': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:34 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 19:11:34 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 19:11:34 INFO - Using env: {'DISPLAY': ':0', 19:11:34 INFO - 'HOME': '/home/cltbld', 19:11:34 INFO - 'LANG': 'en_US.UTF-8', 19:11:34 INFO - 'LANGUAGE': 'en_US:en', 19:11:34 INFO - 'LOGNAME': 'cltbld', 19:11:34 INFO - 'MAIL': '/var/mail/cltbld', 19:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:34 INFO - 'MOZ_NO_REMOTE': '1', 19:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:34 INFO - 'NO_EM_RESTART': '1', 19:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:11:34 INFO - 'PWD': '/builds/slave/test-pgo', 19:11:34 INFO - 'SHELL': '/bin/bash', 19:11:34 INFO - 'SHLVL': '1', 19:11:34 INFO - 'TERM': 'linux', 19:11:34 INFO - 'TMOUT': '86400', 19:11:34 INFO - 'USER': 'cltbld', 19:11:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 19:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:34 INFO - '_': '/tools/buildbot/bin/python'} 19:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:11:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:11:37 INFO - Installing collected packages: mozsystemmonitor 19:11:37 INFO - Running setup.py install for mozsystemmonitor 19:11:37 INFO - Successfully installed mozsystemmonitor 19:11:37 INFO - Cleaning up... 19:11:37 INFO - Return code: 0 19:11:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:37 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 0x7f7f97b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2248920>, '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 0x2249820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2249cb0>, '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': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:37 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 19:11:37 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 19:11:37 INFO - Using env: {'DISPLAY': ':0', 19:11:37 INFO - 'HOME': '/home/cltbld', 19:11:37 INFO - 'LANG': 'en_US.UTF-8', 19:11:37 INFO - 'LANGUAGE': 'en_US:en', 19:11:37 INFO - 'LOGNAME': 'cltbld', 19:11:37 INFO - 'MAIL': '/var/mail/cltbld', 19:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:37 INFO - 'MOZ_NO_REMOTE': '1', 19:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:37 INFO - 'NO_EM_RESTART': '1', 19:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:11:37 INFO - 'PWD': '/builds/slave/test-pgo', 19:11:37 INFO - 'SHELL': '/bin/bash', 19:11:37 INFO - 'SHLVL': '1', 19:11:37 INFO - 'TERM': 'linux', 19:11:37 INFO - 'TMOUT': '86400', 19:11:37 INFO - 'USER': 'cltbld', 19:11:37 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 19:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:37 INFO - '_': '/tools/buildbot/bin/python'} 19:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:37 INFO - Downloading/unpacking blobuploader==1.2.4 19:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:39 INFO - Downloading blobuploader-1.2.4.tar.gz 19:11:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:11:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:11:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:39 INFO - Downloading docopt-0.6.1.tar.gz 19:11:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:11:40 INFO - Installing collected packages: blobuploader, requests, docopt 19:11:40 INFO - Running setup.py install for blobuploader 19:11:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:11:40 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:11:40 INFO - Running setup.py install for requests 19:11:40 INFO - Running setup.py install for docopt 19:11:40 INFO - Successfully installed blobuploader requests docopt 19:11:40 INFO - Cleaning up... 19:11:40 INFO - Return code: 0 19:11:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:40 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 0x7f7f97b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2248920>, '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 0x2249820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2249cb0>, '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': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:40 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 19:11:40 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 19:11:40 INFO - Using env: {'DISPLAY': ':0', 19:11:40 INFO - 'HOME': '/home/cltbld', 19:11:40 INFO - 'LANG': 'en_US.UTF-8', 19:11:40 INFO - 'LANGUAGE': 'en_US:en', 19:11:40 INFO - 'LOGNAME': 'cltbld', 19:11:40 INFO - 'MAIL': '/var/mail/cltbld', 19:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:40 INFO - 'MOZ_NO_REMOTE': '1', 19:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:40 INFO - 'NO_EM_RESTART': '1', 19:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:11:40 INFO - 'PWD': '/builds/slave/test-pgo', 19:11:40 INFO - 'SHELL': '/bin/bash', 19:11:40 INFO - 'SHLVL': '1', 19:11:40 INFO - 'TERM': 'linux', 19:11:40 INFO - 'TMOUT': '86400', 19:11:40 INFO - 'USER': 'cltbld', 19:11:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 19:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:40 INFO - '_': '/tools/buildbot/bin/python'} 19:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:11:40 INFO - Running setup.py (path:/tmp/pip-_knR17-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:11:40 INFO - Running setup.py (path:/tmp/pip-YnwYF6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:11:40 INFO - Running setup.py (path:/tmp/pip-EgGRet-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:11:41 INFO - Running setup.py (path:/tmp/pip-sbrp16-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:11:41 INFO - Running setup.py (path:/tmp/pip-uFhIov-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:11:41 INFO - Running setup.py (path:/tmp/pip-zGQ2qs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:11:41 INFO - Running setup.py (path:/tmp/pip-nOCSAN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:11:41 INFO - Running setup.py (path:/tmp/pip-EBA5CW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:11:41 INFO - Running setup.py (path:/tmp/pip-QmhXxk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:11:41 INFO - Running setup.py (path:/tmp/pip-kXl5rZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:11:41 INFO - Running setup.py (path:/tmp/pip-VaGJjR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:11:41 INFO - Running setup.py (path:/tmp/pip-ulJpLD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:11:41 INFO - Running setup.py (path:/tmp/pip-BNnPU_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:11:41 INFO - Running setup.py (path:/tmp/pip-9CHkpH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:11:41 INFO - Running setup.py (path:/tmp/pip-Rq7wbK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:11:41 INFO - Running setup.py (path:/tmp/pip-cQPaw0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:11:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:11:41 INFO - Running setup.py (path:/tmp/pip-DRDxbW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:11:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:11:42 INFO - Running setup.py install for manifestparser 19:11:42 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:11:42 INFO - Running setup.py install for mozcrash 19:11:42 INFO - Running setup.py install for mozdebug 19:11:42 INFO - Running setup.py install for mozdevice 19:11:42 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:11:42 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:11:42 INFO - Running setup.py install for mozfile 19:11:42 INFO - Running setup.py install for mozhttpd 19:11:42 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:11:42 INFO - Running setup.py install for mozinfo 19:11:42 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:11:42 INFO - Running setup.py install for mozInstall 19:11:42 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:11:42 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:11:42 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:11:42 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:11:42 INFO - Running setup.py install for mozleak 19:11:42 INFO - Running setup.py install for mozlog 19:11:43 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:11:43 INFO - Running setup.py install for moznetwork 19:11:43 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:11:43 INFO - Running setup.py install for mozprocess 19:11:43 INFO - Running setup.py install for mozprofile 19:11:43 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:11:43 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:11:43 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:11:43 INFO - Running setup.py install for mozrunner 19:11:43 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:11:43 INFO - Running setup.py install for mozscreenshot 19:11:43 INFO - Running setup.py install for moztest 19:11:43 INFO - Running setup.py install for mozversion 19:11:43 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:11:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:11:43 INFO - Cleaning up... 19:11:43 INFO - Return code: 0 19:11:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:11: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')]} 19:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:43 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 0x7f7f97b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2248920>, '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 0x2249820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2249cb0>, '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': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:43 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 19:11:43 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 19:11:43 INFO - Using env: {'DISPLAY': ':0', 19:11:43 INFO - 'HOME': '/home/cltbld', 19:11:43 INFO - 'LANG': 'en_US.UTF-8', 19:11:43 INFO - 'LANGUAGE': 'en_US:en', 19:11:43 INFO - 'LOGNAME': 'cltbld', 19:11:43 INFO - 'MAIL': '/var/mail/cltbld', 19:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:43 INFO - 'MOZ_NO_REMOTE': '1', 19:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:43 INFO - 'NO_EM_RESTART': '1', 19:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:11:43 INFO - 'PWD': '/builds/slave/test-pgo', 19:11:43 INFO - 'SHELL': '/bin/bash', 19:11:43 INFO - 'SHLVL': '1', 19:11:43 INFO - 'TERM': 'linux', 19:11:43 INFO - 'TMOUT': '86400', 19:11:43 INFO - 'USER': 'cltbld', 19:11:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 19:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:43 INFO - '_': '/tools/buildbot/bin/python'} 19:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:11:44 INFO - Running setup.py (path:/tmp/pip-8dO7ev-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:11:44 INFO - Running setup.py (path:/tmp/pip-dUKUGM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:11:44 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)) 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:11:44 INFO - Running setup.py (path:/tmp/pip-ukHmUU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:11:44 INFO - Running setup.py (path:/tmp/pip-dsdN0W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:11:44 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)) 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:11:44 INFO - Running setup.py (path:/tmp/pip-GkRKDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:11:44 INFO - Running setup.py (path:/tmp/pip-44RfIP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:11:44 INFO - Running setup.py (path:/tmp/pip-pAfGcF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:11:44 INFO - Running setup.py (path:/tmp/pip-EKNlLb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:11:44 INFO - Running setup.py (path:/tmp/pip-43QR4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:11:44 INFO - Running setup.py (path:/tmp/pip-Y6pdv0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:11:44 INFO - Running setup.py (path:/tmp/pip-iLSmqC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:11:44 INFO - Running setup.py (path:/tmp/pip-EPWTQX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:11:44 INFO - Running setup.py (path:/tmp/pip-FTp6Qh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:11:44 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)) 19:11:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:11:44 INFO - Running setup.py (path:/tmp/pip-DYIbAH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 19:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:11:45 INFO - Running setup.py (path:/tmp/pip-9py5M_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 19:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:11:45 INFO - Running setup.py (path:/tmp/pip-qz8HJP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 19:11:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:11:45 INFO - Running setup.py (path:/tmp/pip-XXa_Bk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:11:45 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)) 19:11:45 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)) 19:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:11:45 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)) 19:11:45 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)) 19:11:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:47 INFO - Downloading blessings-1.6.tar.gz 19:11:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:11:47 INFO - Installing collected packages: blessings 19:11:47 INFO - Running setup.py install for blessings 19:11:47 INFO - Successfully installed blessings 19:11:47 INFO - Cleaning up... 19:11:47 INFO - Return code: 0 19:11:47 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:11:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:11:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:11:47 INFO - Reading from file tmpfile_stdout 19:11:47 INFO - Current package versions: 19:11:47 INFO - argparse == 1.2.1 19:11:47 INFO - blessings == 1.6 19:11:47 INFO - blobuploader == 1.2.4 19:11:47 INFO - docopt == 0.6.1 19:11:47 INFO - manifestparser == 1.1 19:11:47 INFO - mozInstall == 1.12 19:11:47 INFO - mozcrash == 0.17 19:11:47 INFO - mozdebug == 0.1 19:11:47 INFO - mozdevice == 0.48 19:11:47 INFO - mozfile == 1.2 19:11:47 INFO - mozhttpd == 0.7 19:11:47 INFO - mozinfo == 0.9 19:11:47 INFO - mozleak == 0.1 19:11:47 INFO - mozlog == 3.1 19:11:47 INFO - moznetwork == 0.27 19:11:47 INFO - mozprocess == 0.22 19:11:47 INFO - mozprofile == 0.28 19:11:47 INFO - mozrunner == 6.11 19:11:47 INFO - mozscreenshot == 0.1 19:11:47 INFO - mozsystemmonitor == 0.0 19:11:47 INFO - moztest == 0.7 19:11:47 INFO - mozversion == 1.4 19:11:47 INFO - psutil == 3.1.1 19:11:47 INFO - requests == 1.2.3 19:11:47 INFO - wsgiref == 0.1.2 19:11:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:47 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 0x7f7f97b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2248920>, '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 0x2249820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2249cb0>, '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': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:47 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 19:11:47 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 19:11:47 INFO - Using env: {'DISPLAY': ':0', 19:11:47 INFO - 'HOME': '/home/cltbld', 19:11:47 INFO - 'LANG': 'en_US.UTF-8', 19:11:47 INFO - 'LANGUAGE': 'en_US:en', 19:11:47 INFO - 'LOGNAME': 'cltbld', 19:11:47 INFO - 'MAIL': '/var/mail/cltbld', 19:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:47 INFO - 'MOZ_NO_REMOTE': '1', 19:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:47 INFO - 'NO_EM_RESTART': '1', 19:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:11:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:11:47 INFO - 'SHELL': '/bin/bash', 19:11:47 INFO - 'SHLVL': '1', 19:11:47 INFO - 'TERM': 'linux', 19:11:47 INFO - 'TMOUT': '86400', 19:11:47 INFO - 'USER': 'cltbld', 19:11:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 19:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:47 INFO - '_': '/tools/buildbot/bin/python'} 19:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:47 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)) 19:11:47 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)) 19:11:47 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)) 19:11:47 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)) 19:11:47 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)) 19:11:47 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)) 19:11:47 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)) 19:11:47 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)) 19:11:47 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)) 19:11:47 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)) 19:11:47 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)) 19:11:47 INFO - Cleaning up... 19:11:47 INFO - Return code: 0 19:11:47 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:47 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 0x7f7f97b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2248920>, '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 0x2249820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2249cb0>, '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': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:47 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 19:11:47 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 19:11:47 INFO - Using env: {'DISPLAY': ':0', 19:11:47 INFO - 'HOME': '/home/cltbld', 19:11:47 INFO - 'LANG': 'en_US.UTF-8', 19:11:47 INFO - 'LANGUAGE': 'en_US:en', 19:11:47 INFO - 'LOGNAME': 'cltbld', 19:11:47 INFO - 'MAIL': '/var/mail/cltbld', 19:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:47 INFO - 'MOZ_NO_REMOTE': '1', 19:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:47 INFO - 'NO_EM_RESTART': '1', 19:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:11:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:11:47 INFO - 'SHELL': '/bin/bash', 19:11:47 INFO - 'SHLVL': '1', 19:11:47 INFO - 'TERM': 'linux', 19:11:47 INFO - 'TMOUT': '86400', 19:11:47 INFO - 'USER': 'cltbld', 19:11:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 19:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:47 INFO - '_': '/tools/buildbot/bin/python'} 19:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:47 INFO - Downloading/unpacking jsonschema 19:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:11:49 INFO - Downloading/unpacking functools32 (from jsonschema) 19:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:50 INFO - Downloading functools32-3.2.3-2.tar.gz 19:11:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:11:50 INFO - warning: no files found matching '*.txt' 19:11:50 INFO - no previously-included directories found matching 'build' 19:11:50 INFO - no previously-included directories found matching 'dist' 19:11:50 INFO - no previously-included directories found matching '.git*' 19:11:50 INFO - Installing collected packages: jsonschema, functools32 19:11:50 INFO - Running setup.py install for functools32 19:11:50 INFO - warning: no files found matching '*.txt' 19:11:50 INFO - no previously-included directories found matching 'build' 19:11:50 INFO - no previously-included directories found matching 'dist' 19:11:50 INFO - no previously-included directories found matching '.git*' 19:11:50 INFO - Successfully installed jsonschema functools32 19:11:50 INFO - Cleaning up... 19:11:50 INFO - Return code: 0 19:11:50 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:50 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 0x7f7f97b1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2248920>, '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 0x2249820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2249cb0>, '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': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:50 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 19:11:50 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 19:11:50 INFO - Using env: {'DISPLAY': ':0', 19:11:50 INFO - 'HOME': '/home/cltbld', 19:11:50 INFO - 'LANG': 'en_US.UTF-8', 19:11:50 INFO - 'LANGUAGE': 'en_US:en', 19:11:50 INFO - 'LOGNAME': 'cltbld', 19:11:50 INFO - 'MAIL': '/var/mail/cltbld', 19:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:50 INFO - 'MOZ_NO_REMOTE': '1', 19:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:50 INFO - 'NO_EM_RESTART': '1', 19:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:11:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:11:50 INFO - 'SHELL': '/bin/bash', 19:11:50 INFO - 'SHLVL': '1', 19:11:50 INFO - 'TERM': 'linux', 19:11:50 INFO - 'TMOUT': '86400', 19:11:50 INFO - 'USER': 'cltbld', 19:11:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 19:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:50 INFO - '_': '/tools/buildbot/bin/python'} 19:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:50 INFO - Downloading/unpacking flake8 19:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:11:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:11:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:11:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:11:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:11:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:11:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:11:53 INFO - no previously-included directories found matching 'docs/_build' 19:11:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:11:53 INFO - Running setup.py install for pep8 19:11:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:11:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:11:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:11:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:11:53 INFO - no previously-included directories found matching 'docs/_build' 19:11:53 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:11:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:11:53 INFO - Cleaning up... 19:11:53 INFO - Return code: 0 19:11:53 INFO - Running post-action listener: _resource_record_post_action 19:11:53 INFO - Running post-action listener: _start_resource_monitoring 19:11:53 INFO - Starting resource monitoring. 19:11:53 INFO - ##### 19:11:53 INFO - ##### Running install step. 19:11:53 INFO - ##### 19:11:53 INFO - Running pre-action listener: _resource_record_pre_action 19:11:53 INFO - Running main action method: install 19:11:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:11:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:11:53 INFO - Reading from file tmpfile_stdout 19:11:53 INFO - Detecting whether we're running mozinstall >=1.0... 19:11:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:11:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:11:53 INFO - Reading from file tmpfile_stdout 19:11:53 INFO - Output received: 19:11:53 INFO - Usage: mozinstall [options] installer 19:11:53 INFO - Options: 19:11:53 INFO - -h, --help show this help message and exit 19:11:53 INFO - -d DEST, --destination=DEST 19:11:53 INFO - Directory to install application into. [default: 19:11:53 INFO - "/builds/slave/test-pgo"] 19:11:53 INFO - --app=APP Application being installed. [default: firefox] 19:11:53 INFO - mkdir: /builds/slave/test-pgo/build/application 19:11:53 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'] 19:11:53 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 19:12:10 INFO - Reading from file tmpfile_stdout 19:12:10 INFO - Output received: 19:12:10 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:12:10 INFO - Running post-action listener: _resource_record_post_action 19:12:10 INFO - ##### 19:12:10 INFO - ##### Running run-tests step. 19:12:10 INFO - ##### 19:12:10 INFO - Running pre-action listener: _resource_record_pre_action 19:12:10 INFO - Running main action method: run_tests 19:12:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:12:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:12:10 INFO - Python 2.7.3 19:12:10 INFO - Return code: 0 19:12:10 INFO - grabbing minidump binary from tooltool 19:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:12:10 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 0x2248920>, '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 0x2249820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2249cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:12:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:12:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:12:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:12:10 INFO - Return code: 0 19:12:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:12:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:12:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:12:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:12:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:12:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:12:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:12:11 INFO - Return code: 0 19:12:11 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/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 19:12:11 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/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 19:12:11 INFO - Using env: {'DISPLAY': ':0', 19:12:11 INFO - 'HOME': '/home/cltbld', 19:12:11 INFO - 'LANG': 'en_US.UTF-8', 19:12:11 INFO - 'LANGUAGE': 'en_US:en', 19:12:11 INFO - 'LOGNAME': 'cltbld', 19:12:11 INFO - 'MAIL': '/var/mail/cltbld', 19:12:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:12:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:11 INFO - 'MOZ_NO_REMOTE': '1', 19:12:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:11 INFO - 'NO_EM_RESTART': '1', 19:12:11 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:12:11 INFO - 'PWD': '/builds/slave/test-pgo', 19:12:11 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:12:11 INFO - 'SHELL': '/bin/bash', 19:12:11 INFO - 'SHLVL': '1', 19:12:11 INFO - 'TERM': 'linux', 19:12:11 INFO - 'TMOUT': '86400', 19:12:11 INFO - 'USER': 'cltbld', 19:12:11 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788', 19:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:11 INFO - '_': '/tools/buildbot/bin/python'} 19:12:11 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/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 19:12:11 INFO - mozversion application_buildid: 20160316163020 19:12:11 INFO - mozversion application_changeset: 6449a9493de02ed7b9615d690abda0863ef380bf 19:12:11 INFO - mozversion application_display_name: Nightly 19:12:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:12:11 INFO - mozversion application_name: Firefox 19:12:11 INFO - mozversion application_remotingname: firefox 19:12:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:12:11 INFO - mozversion application_vendor: Mozilla 19:12:11 INFO - mozversion application_version: 48.0a1 19:12:11 INFO - mozversion platform_buildid: 20160316163020 19:12:11 INFO - mozversion platform_changeset: 6449a9493de02ed7b9615d690abda0863ef380bf 19:12:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:12:11 INFO - mozversion platform_version: 48.0a1 19:12:11 INFO - using testdate: 1458180731 19:12:11 INFO - actual date: 1458180731 19:12:11 INFO - starting webserver on 'localhost:54931' 19:12:11 INFO - SUITE-START | Running 2 tests 19:12:11 INFO - TEST-START | dromaeo_css 19:12:11 INFO - operating with platform_type : linux_ 19:12:11 INFO - Initialising browser for dromaeo_css test... 19:12:11 INFO - TEST-INFO | started process 2623 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe59ey3/profile http://localhost:54931/getInfo.html) 19:12:16 INFO - PROCESS | 2623 | __metrics Screen width/height:1600/1200 19:12:16 INFO - PROCESS | 2623 | colorDepth:24 19:12:16 INFO - PROCESS | 2623 | Browser inner width/height: 1024/697 19:12:16 INFO - PROCESS | 2623 | __metrics 19:12:16 ERROR - PROCESS | 2623 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:12:17 INFO - TEST-INFO | 2623: exit 0 19:12:17 INFO - Browser initialized. 19:12:17 INFO - Running cycle 1/1 for dromaeo_css test... 19:12:17 INFO - TEST-INFO | started process 2771 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe59ey3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:29 INFO - PROCESS | 2771 | RSS: Main: 151777280 19:12:29 INFO - PROCESS | 2771 | 19:13:20 INFO - PROCESS | 2771 | 1458180800223 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] 19:15:28 INFO - PROCESS | 2771 | Cycle 1(1): loaded http://localhost:54931/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54931/tests/dromaeo/cssquery-ext.html) 19:15:29 INFO - PROCESS | 2771 | RSS: Main: 258297856 19:15:29 INFO - PROCESS | 2771 | 19:18:31 INFO - PROCESS | 2771 | Cycle 1(1): loaded http://localhost:54931/tests/dromaeo/cssquery-ext.html (next: http://localhost:54931/tests/dromaeo/cssquery-jquery.html) 19:18:31 INFO - PROCESS | 2771 | RSS: Main: 234217472 19:18:31 INFO - PROCESS | 2771 | 19:21:33 INFO - PROCESS | 2771 | Cycle 1(1): loaded http://localhost:54931/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54931/tests/dromaeo/cssquery-mootools.html) 19:21:34 INFO - PROCESS | 2771 | RSS: Main: 224935936 19:21:34 INFO - PROCESS | 2771 | 19:24:35 INFO - PROCESS | 2771 | Cycle 1(1): loaded http://localhost:54931/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54931/tests/dromaeo/cssquery-prototype.html) 19:24:36 INFO - PROCESS | 2771 | RSS: Main: 223784960 19:24:36 INFO - PROCESS | 2771 | 19:27:39 INFO - PROCESS | 2771 | Cycle 1(1): loaded http://localhost:54931/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54931/tests/dromaeo/cssquery-yui.html) 19:27:39 INFO - PROCESS | 2771 | RSS: Main: 218689536 19:27:39 INFO - PROCESS | 2771 | 19:30:41 INFO - PROCESS | 2771 | Cycle 1(1): loaded http://localhost:54931/tests/dromaeo/cssquery-yui.html (next: http://localhost:54931/tests/dromaeo/cssquery-dojo.html) 19:30:42 INFO - PROCESS | 2771 | RSS: Main: 270884864 19:30:42 INFO - PROCESS | 2771 | 19:30:42 INFO - PROCESS | 2771 | __start_tp_report 19:30:42 INFO - PROCESS | 2771 | _x_x_mozilla_page_load 19:30:42 INFO - PROCESS | 2771 | _x_x_mozilla_page_load_details 19:30:42 INFO - PROCESS | 2771 | |i|pagename|runs| 19:30:42 INFO - PROCESS | 2771 | |0;dojo.html;3068.4783586790245;3119.0954623159287;3156.558081868539;3167.461531539638;3184.0766177808437;5203.817866374678;5259.184826351912;5324.254604355388;5379.865503362418;5398.190271459278;5343;5366.973165134179;5368.087425137726;5389;5450.972745136279;4783.115123702109;4799.904001919959;4804.735739534324;4929.4824043475455;4930.506949305059;4724.24412094065;4897.240927656219;4899.265110233476;4913.287573301869;5010.72441015744;4787;4835.323054772335;4851.708897466128;4869.123557759602;4881.170201065827;4829.975850120762;4832.1543729847135;4835.323054772335;4841.298011788271;4867.975660121712;4701.200795864711;4735.431748190204;4788.592969597588;4815.229563269895;4863.9513604864205;5300.575953923715;5301.469853014706;5304.124819404794;5315.574754019708;5333.519983201491;5740.397258287903;5742.655440673573;5755.366909639936;5759.539236861041;5761.135829625548;5637.8590535236535;5675;5767.221425107598;5780.364159942445;5783.710814459302;5349.893002139975;5351.759170837283;5353;5359;5407.540359069484;5849.444302791228;5854.121881717776;5855.326637436664;5856.180134781134;5916.467517923322;5484.890302193934;5616.6068375213345;5617.662940223599;5639.689817060019;5653.971730141323;5744.684042377626;5758.049921762862;5764.423557644202;5764.625299355613;5800.651960882361;5652.604317697804;5692.6015178937905;5699.430056994267;5700.629459085146;5704.914426283609;5573.526250268692;5646.463585959409;5709.486146246774;5799;5800.187973683687;4371.475422949203;4375.168717943644;4377.518472968035;4381.364702118175;4411.051623900813;3875.8837234883;3902.590228026073;3907.5701672815967;3939.290927632996;3951.980240098781;5312.495312945264;5467.125259958388;5492.286002819687;5540.612157148961;5542.667439953616;5732.77068917247;5748.913766293509;5750.166225897222;5762.394948530427;5766.394528574523;5309.5752339812725;5398.865028374322;5413.079776438015;5413.323334583177;5417.052015897202;4775.856724298276;4789.784459699322;4814.855554333376;4821.252705830602;4859.173940430135;5967.254093238345;5976.671283079386;5982.641041537521;5989.431004054608;5990.670513121733;5683.8010669626365;5727.255456790757;5771.971140144273;5795.797147099831;5810.07038873795;5953.6725480097275;5959.493443057216;5959.851003724942;5965.791197308074;5988.311344195299;5662.320521537277;5664.716764161858;5666.17840413146;5668.234788303526;5670.716464176692;5644;5706.400827913176;5739.139129130664;5742.59801813869;5776.306843178677;5606.215129881738;5645.294338207724;5645.858853528694;5669.177969194526;5717.371089180104;5582.720863956867;5637.295338082739;5642.210090587403;5642.576806739593;5648.661080335193;5401.837944861661;5527.917081243865;5542.584306177134;5583.330000399978;5628.549716022791;5629.211910332475;5636.915446268391;5639.605227634026;5673.602847800779;5676.517496012885;5526.06056970308;5539.833804985857;5560.972195138998;5566.109422492382;5566.526845218202 19:30:42 INFO - PROCESS | 2771 | |1;ext.html;548.4871645011912;560.8958477851552;566.2299272988732;583.1107560969521;599.9580029397943;29274.853625731866;29751.40497190055;29752.851235743845;29771.106866793976;29785.553216701766;42155;42717.78641106798;42856.785716071376;42889.35665965005;42892.785536072355;8722.91277087229;8919.866202006942;8924.910750892506;8925.910740892605;8934.597943092576;8722.21500064994;8841.29269658429;8850.911490885073;8856.690015849446;8860.8670869937;8914.375993680445;8998.910010899905;9001.594928228213;9007.234385077243;9008.864867027;8650.65397384104;8656.956715216415;8698.565071746387;8703.912960870373;8723;8760.386772925898;8945.194932456045;8983.101689830964;8985.23625491834;8992.46045237288;36447.4532882007;36574.268514629824;36675.633243667486;36896.81551592225;37365.62634373648;3282.786618869766;3289.243474000993;3318.6183588887347;3424.520567120605;3430.3139372125675;31609.683903160905;31613.051608451784;31794.682053179404;32098.518522222184;32811;4295.398644189816;4301.741895486281;4346.195953748535;4357.586029327209;4363.149185908749;305106;307039.9999999978;308958;312515;312577;58903.41096589065;59138.70430647819;59294.11058834121;59754.92083172979;59807.40192598105;62488.37511624917;67581;68558.65720671364;68763;68865;15848.92075539615;16021.919890400473;16079.839201608069;16082.43711470093;16082.517524474284;12408.62774116778;12445.439955202037;12477;12477.937610312072;12486.875131248753;20173.293934712216;20599.485012874797;21321.68017479739;21374.78625213728;21415.892920535298;7968.840623187504;8446.704365347307;8468;8578.4424012439;8601.61292741828;938.1369140390857;997.528645248253;1003.1710576175261;1069.8127827630133;1101.680512651322;32620.347593048005;32686.509702354484;32786.18034549108;33051.66948330486;33565.16087097793;1160.3560024186488;1186.1400484648561;1228.4103630257348;1254.1659796235401;1286.5111257722006;16591.751123733153;16853.325866965184;16921;16980.830191698173;17170.828291716924;392831;395440;396190;398090;398229;56739;57418.425815741306;57426;57508;57530;1218.670958841108;1360.129517109051;1381.544090450149;1385.902986790935;1414.3988804757937;28730.281742955758;29995.550066749453;30397.544036839023;30438.239044024078;30959.226019349695;39448.802755986035;40262.59737402706;40461.59538404578;40523;41319.96700082522;263288;267136;267947;498490;506779;39133.41299880561;42786.35820462758;46906.76546617245;47213;48172;43203.78398107989;43604.34593481037;43852.56147438485;43971.78014109909;44811.55188448074;37432.81283593673;37658.43512347262;38197.427038595;38381.2323753529;38666.226675466896;36801.26397471982;37027.629723703496;37082.25835483329;37111.25777484489;37417.625823741415;39560.60439395569;40155;40594;40594.79702601468;41097.38353924753;34832.9550113497;36372.63627363693;36380.81809590935;36475.81762091172;40311.79844100761;28023.019194328102;28386;28421.857890710413;28483.572746408405;28585.571216432185 19:30:42 INFO - PROCESS | 2771 | |2;jquery.html;360.3567631777278;366.061053398034;373.372733807204;373.674902834534;383.3463943975522;17647.823521764796;17781.55546111348;18042.45872623822;18079;18121.365752198675;17007.91496042518;18327.90836045818;18946.147423365946;19001.809981900176;19011.04944752764;5527.723613819313;5680.403557626451;5698.629589076697;5704.942950570504;5747.568932330071;4088.121053973395;5646;6014.338422773513;6266.091416744569;6282.24613046435;6184.6289222646565;6198.535109866755;6226.40849119333;6227.813165605016;6228.0657901314935;6129.601575897553;6172.22847144107;6282;6284.27730810958;6284.780032698834;3717.460968159629;5238.319018527605;5350.491703288181;5384.273123128367;5527.474889885454;20882;20917.5816483671;20956.685649715266;22450;22495.66256506154;2342.847714898526;2349.5066036132434;2387.033251533132;2458.299384675377;2484.416162201881;9483.478408687519;9644.421334719938;9646.614135434644;9860.950695246549;10155.136813370873;1950.4538729155859;1982.9504262393411;1986.6821308590556;2027.3208475160839;2093.4766308422895;67508;67953.66023169852;68450;68696.25214991445;69012.99999999949;10887.782244355069;10984.340939543654;11305.886941130484;11337.659870203906;11494.770104597861;14623.78064329036;14646.780298295535;14772.852271477148;14773.704525909421;14784.556463306119;8169.060558035783;8297.336213102937;8344.290735287446;8401.915980840236;8452.450590711584;8099.919000809917;8109.675612975415;8129.918700813035;8148.348132149414;8254.8349033019;4763.976180119077;4767.69010014348;4772.164871147605;4791.401074865642;4855.9074208302845;1773.4502304285713;1806.6603748146183;1826.862985276083;1830.9725354119698;1856.8700190986501;1028.475477506477;1053.4785281285813;1076.0100707349256;1083.4311986207147;1131.1911982932243;18479.30129791552;18496.907515462604;18530.907345463187;18908.243670253036;19001.809981900005;974.0503009565758;985.3102828020415;1005.1205195453978;1038.48075962019;1080.222239987208;10178.491075446198;10533.473326333653;10579.62971296001;10662.360258384522;10768.46157692128;493687;514550;515071;518593;520375;83536.58231708924;84976;86618;86713;87623;1016.8830584482731;1036.3471013261747;1042.551702767802;1058.4548957287004;1058.687687132298;16345.836541634908;16354.509364719077;16441.588960276087;16568.66862662764;16582;36347;37950.810245948596;38865.61134388733;38944.80527597457;39427.60572394239;52244.73877630587;52862.2070668948;53094.203586947;53206.2019069722;53329.733351332994;8302.6678932842;8372.372072094495;8435.24082832548;8520.872186917326;8619.267362274277;9570.425774453555;12852.228866268053;13151.868481315447;13206.735865282833;13269.203847769164;11270.661880143609;11677.240979336317;11924.224925379822;11926.761464770829;12039.337836419081;11180.161487888277;11305.71735706614;11324.830127547928;11498.82751758741;11556.711082223012;10159;11226.438678066228;11715.1799374043;11738.354390508604;11954.58158964432;8066.435349525477;8153.877691834508;8338.499690018618;8343.41596088268;8546.957265213634;10743.08683761889;11330.660080197607;11783.469743861375;11822.82265765997;11894.881051189723 19:30:42 INFO - PROCESS | 2771 | |3;mootools.html;1341.644464216982;1498.0487390507028;1498.6927679825637;1686.8998097368778;1831.8259765322289;8096.7975800604945;8235.505869647825;8244.793880153;8265.91734082659;8266.380021498382;8100.797480063002;8230.91769082309;8248.505089694607;8253.298469630088;8260.91739082609;2359.929202123939;2363.728171260301;2382.118616112032;2383.118246248882;2386.3079706884982;2353.51752890657;2356.611159158737;2423.6849209602815;2441.865697386643;2444.4377793107597;2388.450656349041;2400.3879010852206;2410.204632471289;2410.5781488239577;2412.9276121716375;2356.587597170497;2368.0764501844296;2387.462820865309;2387.7134743830766;2408.9518209635708;2413.6500207469994;2442.46265821519;2456.9877150614134;2457.3856535866034;2460.126655037454;8320.542370169638;8366.916330836735;8371.539565323905;8372.246497815226;8378.622961966665;5084.288199652052;5231.372235331784;5232.319798426181;5239.738013099368;5245.160774276135;3446.2590543033116;3477.2176260341475;3514.3674138655033;3518.700910422617;3525.312564050011;1192.1654841610907;1205.475618106118;1232.12519111431;1258.6349958512021;1260.0549587809144;12085.516579336816;12135.757284854342;12148.271103733716;12158.452869620889;12159.696007599792;4587.587117159472;4748.358971538867;4766.356541866873;4837.6613637045775;4840.515948405202;10217.693469195936;10219;10222.080012798735;10242;10248.692539223835;5235;5252.395974462909;5274.050670879278;5284.841454756363;5291.656042357312;4143.150654115899;4662.580367766849;4792.065547218329;4801.5438533339275;4846.5638092571835;4003.3994900764537;4041.7170798044444;4057.776822274803;4061.1674606705556;4092.652124569445;1304.7651422743807;1305.536534530228;1315.8552559218479;1318.7098838255567;1324.1591589340646;961.2022021721954;1110.5835311758092;1161.5702190189684;1270.6124631987332;1386.4107754204422;7653.387728981668;7729.4202934779;7784.688612455551;7788.299053085137;7805.102413222552;1143.0626885953604;1148.3683973814536;1152.6599653102355;1154.284343706907;1193.397334346167;6161.568690191643;6183.690815459299;6214.8135555933395;6236.656983865841;6300.968495157586;9947.900520994843;10501.264911456125;10637.840432393521;10638.680839574825;10665.146788256921;10022.749431264278;10442.373457592568;10446.529906154241;10446.582136714598;10495.265331426726;8015.639296231567;8114.188581141957;8190.262876341158;8194.180581941759;8197.180281971756;7823.530588164728;7838.098618658927;7864.252895974873;7871.960640196762;7969.442139050211;9081.409708368936;9280.907190928005;9293.791807065309;9299.67451139207;9506.762330941781;9397.154256116983;9445.574949127169;9487.620495180392;9679.564419600994;9681.031896810262;7192.42460603161;7272.41820654357;7284.162321332902;7298.087739032621;7309.853802924018;8024.558649274346;8177.4684645497855;8205.384596155192;8229.711960081368;8238.423310368456;6177.96911015442;7378.29906158914;7510.62446877643;7584.810379740551;7601.543907365576;7166.677499512431;7189;7237.855242895007;7251.673674684546;7296.160941491584;7514.736984205527;7557.244275572399;7569.6593653284635;7575.356094732009;7575.583342916192;6272.466840318624;6280.497560195265;6282.057691346335;6292.937070629235;6294.905576416266;6748.966255168692;7051.823704407431;7056.294370562902;7063.152421709222;7065.258147894397 19:30:42 INFO - PROCESS | 2771 | |4;prototype.html;339.1149100846791;340.94715319125544;349.81110200491736;350.5600471408382;351.546505008539;5891.587588868775;5945.9702701486485;5949.5537834662355;5980.581359304851;5981.192539007233;5880.617759845607;5882.941170588293;5886.234789477373;5886.999999999989;5908.320543137541;4345.6523478121835;4423.845165419211;4494.280915053592;4517.322401639747;4547.454305483347;4504.8198072077075;4515.480719717241;4530.411046563942;4533.523979982104;4536.5236650151755;4469.329600559926;4473.686841921067;4480.417545719069;4481.955180448186;4497.123061003105;4329.783510824446;4374.5188029316905;4438.778061096932;4440.689151759379;4468.8882777930485;3919.3729003359326;3924.50943632046;3928.3321835287784;3929.960700392988;3934.4688467056867;5668.234788303609;5680.6591604503865;5684.090545512699;5684.317881854204;5685.744141513642;5261.184516399964;5264.763085661154;5266.526012658841;5267.710275934822;5270.156774915995;6227.688615569204;6235.282942461629;6237.594556353823;6239.937600623981;6240.656763877985;4337.479502459693;4400.647948164139;4404.427424434803;4459.175052615245;4465.129299786543;6428.742850285983;6497.642629655367;6530.804075877683;6556.18047744032;6573.112629794964;4642.141203877293;4648.790804413809;4649.604783593365;4649.907001859944;4652.232381657056;4706.741129237925;4707.95292047082;4707.987782626683;4709.058188362341;4709.670323077352;5341.946580534222;5346.732663366816;5350.608841701108;5355.491228333302;5392.649477783932;6160.691965401712;6264.906026409608;6331.810045698637;6333.398327158912;6333.46165575922;1636.3618188906337;1641.7619445180383;1659.3694396129395;1659.402615058578;1662.9251683674263;1057.2070946789909;1107.5791199344199;1126.6311431610632;1135.3585224348217;1156.5200441816553;5991.2510936132985;5991.5206783457215;5993.0710739835395;5993.250843644457;5995.910061349084;6418.390252926058;6432.839179020562;6434;6434.806955791334;6438.356164383524;5997.730102145414;6022.18700475439;6024.548158888101;6025.849353766103;6026.186464827192;3434.227298857787;3461.2385275239913;3467.133216695826;3467.4452087665854;3468.9132771680406;6521.608703477807;6676.0987266718375;6683.866322673616;6684.63234522106;6688.7324507019175;6560.803175904731;6576.572522786004;6578.013298005338;6588.209414870151;6593.505487088488;6648.16897887764;6650.667466626746;6655.633940133339;6659.933400666028;6661.367170118831;6353.237611486466;6371.203599550056;6388.872222555616;6394.680265986775;6421.422072013541;6135.8466038347615;6306.65313407767;6318.62088274705;6321.33625969285;6348.492120630246;6630.701618427086;6648.468122550088;6670.099536562696;6673.432758215606;6733.023711561698;4614.2617181250835;4617.238155704271;4618.907621847611;4623.0522742836965;4639.86080417588;6350.872982540416;6355.90466142999;6357.110004599453;6369.426751592379;6377.1390862233;6123.540734444845;6256.5620406572925;6262.46769024638;6268.655223962726;6269.341719119427;6194.256689197326;6199.876002479835;6203.069539569101;6204.038374052029;6206.751729930752;6068.180795592715;6104.847378815565;6107.9083813741945;6109.236345456818;6112.205413296243;6241.282252541016;6243.438090571689;6251.468625166912;6258.311585725475;6260.655663938527;5947.791827286024;6025.548083893638;6050.576459647782;6086.056661217518;6097.115918191748 19:30:42 INFO - PROCESS | 2771 | |5;yui.html;764.1708746010578;800.3557136505111;811.703728139229;816.0778320497838;882.911708829117;13335.333233338342;13467.393967271471;13481.730365392687;13537.864621353783;13546.593602191937;11776.116791240649;12754.68113297168;12795.616131516046;12839.807402888964;12858.678533036678;815.2051749544191;822.7449490657885;828.3704384667666;828.9668413263462;829.2495291760966;816.4529765057425;819.4960099538771;820.995895020524;821;821.1747194069951;854.0733304364771;859.6260626627405;860.2043110123142;861.2722249698994;863.5768473447997;856.8200677857658;860.6127242740791;860.8794768732382;861.2894362151251;861.4960248254747;626.580191271849;628.0265588338103;628.8050704281642;629.361198383641;629.7134803664368;13102.213867168;13112.803307950388;13157.342132893316;13174.736505269937;13177.670558236025;11888.762224755457;11911.463984120648;11989.64031079069;12014.939925300405;12032;10340.638077667321;10541.894581054168;10549.367037977669;10589.523471443727;10754.19343549229;3708.5735140458924;3719.814009299524;3742.251549690073;3776.3957766757185;4479.574440428187;53585.46414535844;55759.44240557583;55780.72109639466;58134.12798808063;58578;10796.568137274578;10895;10945.4527273636;11064.502097405637;11107.222494425312;17146.142692865305;19537.706934395996;19742.90128549348;19759.506012349808;19784.90107549453;8019.35845132388;8029.357651387875;8157;8243.546604936786;8586.31309495239;4393.846215382447;4427.295491235897;4454.198244316054;4455.6212721918355;4552.521985191507;3305.3719793239206;3341.3818443588016;3349.279904820475;3360.1599600099976;3365.9326813463595;621.8445388652837;651.0852252585125;651.7425616881305;652.5693042591867;666.2804171494774;734.2217249715212;741.8590467811099;773.2306355176635;784.5724080376094;805.2873207211543;8675.739727808175;9249.398789078823;9797.16724078447;9821.459819709842;9882.11061004513;737.4395459450856;741.7552207771422;742.4542960923717;752.236479972828;787.1813314153331;4583.495815460296;4638.2115040443205;4655;4680.531946805292;4682.929756053662;59395;59894.70052649796;59947.700261498416;60121;60291;54562.727186363816;54838.177427338625;55379.72310138423;55747.44252557504;56016.43983560112;39969.60030399717;49925.001499969796;50044.49955500471;50922.49077509252;50995.980080398185;9668.419894806335;9680.95159524226;9693.515324233618;9697.709068727949;9756.902430975599;37608.811955940044;37632.43551346677;38128.618713813616;38790;39388.803055984536;43692;45066.549334506235;47880.521194789;48312;50427;11044.171687123337;11128.554857805597;11554.884451155382;11681.88318116808;11744.94127529357;13226.281439031834;13235.735285294048;13262.867371326549;13719.176849389069;13950.720985580028;11942;12204.694882628006;12244.204126731735;12467.189632673848;12841.871581284067;12158.392080395768;12559.43482543306;12720.6819829505;12767.680807979503;13045;12631.178973366701;12667.30329831868;12686.936565317113;12742.554010609585;12820.423080961193;10416;10424;10494.947525262325;10525.36847789135;10617.89382106169;10873.184511161853;10883.12934965185;10898.618548351087;11003.064739497233;11098.778024439627 19:30:42 INFO - PROCESS | 2771 | __end_tp_report 19:30:42 INFO - PROCESS | 2771 | __start_cc_report 19:30:42 INFO - PROCESS | 2771 | _x_x_mozilla_cycle_collect,834 19:30:42 INFO - PROCESS | 2771 | __end_cc_report 19:30:42 INFO - PROCESS | 2771 | __startTimestamp1458181842151__endTimestamp 19:30:42 INFO - PROCESS | 2771 | 19:30:42 INFO - PROCESS | 2771 | ------- Summary: start ------- 19:30:42 INFO - PROCESS | 2771 | Number of tests: 6 19:30:42 INFO - PROCESS | 2771 | 19:30:42 INFO - PROCESS | 2771 | [#0] dojo.html Cycles:165 Average:5323.42 Median:5566.11 stddev:611.57 (11.0%) stddev-sans-first:587.31 19:30:42 INFO - PROCESS | 2771 | Values: 3068.5 3119.1 3156.6 3167.5 3184.1 5203.8 5259.2 5324.3 5379.9 5398.2 5343.0 5367.0 5368.1 5389.0 5451.0 4783.1 4799.9 4804.7 4929.5 4930.5 4724.2 4897.2 4899.3 4913.3 5010.7 4787.0 4835.3 4851.7 4869.1 4881.2 4830.0 4832.2 4835.3 4841.3 4868.0 4701.2 4735.4 4788.6 4815.2 4864.0 5300.6 5301.5 5304.1 5315.6 5333.5 5740.4 5742.7 5755.4 5759.5 5761.1 5637.9 5675.0 5767.2 5780.4 5783.7 5349.9 5351.8 5353.0 5359.0 5407.5 5849.4 5854.1 5855.3 5856.2 5916.5 5484.9 5616.6 5617.7 5639.7 5654.0 5744.7 5758.0 5764.4 5764.6 5800.7 5652.6 5692.6 5699.4 5700.6 5704.9 5573.5 5646.5 5709.5 5799.0 5800.2 4371.5 4375.2 4377.5 4381.4 4411.1 3875.9 3902.6 3907.6 3939.3 3952.0 5312.5 5467.1 5492.3 5540.6 5542.7 5732.8 5748.9 5750.2 5762.4 5766.4 5309.6 5398.9 5413.1 5413.3 5417.1 4775.9 4789.8 4814.9 4821.3 4859.2 5967.3 5976.7 5982.6 5989.4 5990.7 5683.8 5727.3 5772.0 5795.8 5810.1 5953.7 5959.5 5959.9 5965.8 5988.3 5662.3 5664.7 5666.2 5668.2 5670.7 5644.0 5706.4 5739.1 5742.6 5776.3 5606.2 5645.3 5645.9 5669.2 5717.4 5582.7 5637.3 5642.2 5642.6 5648.7 5401.8 5527.9 5542.6 5583.3 5628.5 5629.2 5636.9 5639.6 5673.6 5676.5 5526.1 5539.8 5561.0 5566.1 5566.5 19:30:42 INFO - PROCESS | 2771 | 19:30:42 INFO - PROCESS | 2771 | [#1] ext.html Cycles:180 Average:52643.35 Median:215982.21 stddev:95810.31 (44.4%) stddev-sans-first:95999.25 19:30:42 INFO - PROCESS | 2771 | Values: 548.5 560.9 566.2 583.1 600.0 29274.9 29751.4 29752.9 29771.1 29785.6 42155.0 42717.8 42856.8 42889.4 42892.8 8722.9 8919.9 8924.9 8925.9 8934.6 8722.2 8841.3 8850.9 8856.7 8860.9 8914.4 8998.9 9001.6 9007.2 9008.9 8650.7 8657.0 8698.6 8703.9 8723.0 8760.4 8945.2 8983.1 8985.2 8992.5 36447.5 36574.3 36675.6 36896.8 37365.6 3282.8 3289.2 3318.6 3424.5 3430.3 31609.7 31613.1 31794.7 32098.5 32811.0 4295.4 4301.7 4346.2 4357.6 4363.1 305106.0 307040.0 308958.0 312515.0 312577.0 58903.4 59138.7 59294.1 59754.9 59807.4 62488.4 67581.0 68558.7 68763.0 68865.0 15848.9 16021.9 16079.8 16082.4 16082.5 12408.6 12445.4 12477.0 12477.9 12486.9 20173.3 20599.5 21321.7 21374.8 21415.9 7968.8 8446.7 8468.0 8578.4 8601.6 938.1 997.5 1003.2 1069.8 1101.7 32620.3 32686.5 32786.2 33051.7 33565.2 1160.4 1186.1 1228.4 1254.2 1286.5 16591.8 16853.3 16921.0 16980.8 17170.8 392831.0 395440.0 396190.0 398090.0 398229.0 56739.0 57418.4 57426.0 57508.0 57530.0 1218.7 1360.1 1381.5 1385.9 1414.4 28730.3 29995.6 30397.5 30438.2 30959.2 39448.8 40262.6 40461.6 40523.0 41320.0 263288.0 267136.0 267947.0 498490.0 506779.0 39133.4 42786.4 46906.8 47213.0 48172.0 43203.8 43604.3 43852.6 43971.8 44811.6 37432.8 37658.4 38197.4 38381.2 38666.2 36801.3 37027.6 37082.3 37111.3 37417.6 39560.6 40155.0 40594.0 40594.8 41097.4 34833.0 36372.6 36380.8 36475.8 40311.8 28023.0 28386.0 28421.9 28483.6 28585.6 19:30:42 INFO - PROCESS | 2771 | 19:30:42 INFO - PROCESS | 2771 | [#2] jquery.html Cycles:180 Average:28672.77 Median:2422.67 stddev:84047.94 (3469.2%) stddev-sans-first:84256.83 19:30:42 INFO - PROCESS | 2771 | Values: 360.4 366.1 373.4 373.7 383.3 17647.8 17781.6 18042.5 18079.0 18121.4 17007.9 18327.9 18946.1 19001.8 19011.0 5527.7 5680.4 5698.6 5704.9 5747.6 4088.1 5646.0 6014.3 6266.1 6282.2 6184.6 6198.5 6226.4 6227.8 6228.1 6129.6 6172.2 6282.0 6284.3 6284.8 3717.5 5238.3 5350.5 5384.3 5527.5 20882.0 20917.6 20956.7 22450.0 22495.7 2342.8 2349.5 2387.0 2458.3 2484.4 9483.5 9644.4 9646.6 9861.0 10155.1 1950.5 1983.0 1986.7 2027.3 2093.5 67508.0 67953.7 68450.0 68696.3 69013.0 10887.8 10984.3 11305.9 11337.7 11494.8 14623.8 14646.8 14772.9 14773.7 14784.6 8169.1 8297.3 8344.3 8401.9 8452.5 8099.9 8109.7 8129.9 8148.3 8254.8 4764.0 4767.7 4772.2 4791.4 4855.9 1773.5 1806.7 1826.9 1831.0 1856.9 1028.5 1053.5 1076.0 1083.4 1131.2 18479.3 18496.9 18530.9 18908.2 19001.8 974.1 985.3 1005.1 1038.5 1080.2 10178.5 10533.5 10579.6 10662.4 10768.5 493687.0 514550.0 515071.0 518593.0 520375.0 83536.6 84976.0 86618.0 86713.0 87623.0 1016.9 1036.3 1042.6 1058.5 1058.7 16345.8 16354.5 16441.6 16568.7 16582.0 36347.0 37950.8 38865.6 38944.8 39427.6 52244.7 52862.2 53094.2 53206.2 53329.7 8302.7 8372.4 8435.2 8520.9 8619.3 9570.4 12852.2 13151.9 13206.7 13269.2 11270.7 11677.2 11924.2 11926.8 12039.3 11180.2 11305.7 11324.8 11498.8 11556.7 10159.0 11226.4 11715.2 11738.4 11954.6 8066.4 8153.9 8338.5 8343.4 8547.0 10743.1 11330.7 11783.5 11822.8 11894.9 19:30:42 INFO - PROCESS | 2771 | 19:30:42 INFO - PROCESS | 2771 | [#3] mootools.html Cycles:180 Average:5930.35 Median:5233.66 stddev:3119.78 (59.6%) stddev-sans-first:3109.47 19:30:42 INFO - PROCESS | 2771 | Values: 1341.6 1498.0 1498.7 1686.9 1831.8 8096.8 8235.5 8244.8 8265.9 8266.4 8100.8 8230.9 8248.5 8253.3 8260.9 2359.9 2363.7 2382.1 2383.1 2386.3 2353.5 2356.6 2423.7 2441.9 2444.4 2388.5 2400.4 2410.2 2410.6 2412.9 2356.6 2368.1 2387.5 2387.7 2409.0 2413.7 2442.5 2457.0 2457.4 2460.1 8320.5 8366.9 8371.5 8372.2 8378.6 5084.3 5231.4 5232.3 5239.7 5245.2 3446.3 3477.2 3514.4 3518.7 3525.3 1192.2 1205.5 1232.1 1258.6 1260.1 12085.5 12135.8 12148.3 12158.5 12159.7 4587.6 4748.4 4766.4 4837.7 4840.5 10217.7 10219.0 10222.1 10242.0 10248.7 5235.0 5252.4 5274.1 5284.8 5291.7 4143.2 4662.6 4792.1 4801.5 4846.6 4003.4 4041.7 4057.8 4061.2 4092.7 1304.8 1305.5 1315.9 1318.7 1324.2 961.2 1110.6 1161.6 1270.6 1386.4 7653.4 7729.4 7784.7 7788.3 7805.1 1143.1 1148.4 1152.7 1154.3 1193.4 6161.6 6183.7 6214.8 6236.7 6301.0 9947.9 10501.3 10637.8 10638.7 10665.1 10022.7 10442.4 10446.5 10446.6 10495.3 8015.6 8114.2 8190.3 8194.2 8197.2 7823.5 7838.1 7864.3 7872.0 7969.4 9081.4 9280.9 9293.8 9299.7 9506.8 9397.2 9445.6 9487.6 9679.6 9681.0 7192.4 7272.4 7284.2 7298.1 7309.9 8024.6 8177.5 8205.4 8229.7 8238.4 6178.0 7378.3 7510.6 7584.8 7601.5 7166.7 7189.0 7237.9 7251.7 7296.2 7514.7 7557.2 7569.7 7575.4 7575.6 6272.5 6280.5 6282.1 6292.9 6294.9 6749.0 7051.8 7056.3 7063.2 7065.3 19:30:42 INFO - PROCESS | 2771 | 19:30:42 INFO - PROCESS | 2771 | [#4] prototype.html Cycles:180 Average:5245.08 Median:5986.22 stddev:1550.77 (25.9%) stddev-sans-first:1510.77 19:30:42 INFO - PROCESS | 2771 | Values: 339.1 340.9 349.8 350.6 351.5 5891.6 5946.0 5949.6 5980.6 5981.2 5880.6 5882.9 5886.2 5887.0 5908.3 4345.7 4423.8 4494.3 4517.3 4547.5 4504.8 4515.5 4530.4 4533.5 4536.5 4469.3 4473.7 4480.4 4482.0 4497.1 4329.8 4374.5 4438.8 4440.7 4468.9 3919.4 3924.5 3928.3 3930.0 3934.5 5668.2 5680.7 5684.1 5684.3 5685.7 5261.2 5264.8 5266.5 5267.7 5270.2 6227.7 6235.3 6237.6 6239.9 6240.7 4337.5 4400.6 4404.4 4459.2 4465.1 6428.7 6497.6 6530.8 6556.2 6573.1 4642.1 4648.8 4649.6 4649.9 4652.2 4706.7 4708.0 4708.0 4709.1 4709.7 5341.9 5346.7 5350.6 5355.5 5392.6 6160.7 6264.9 6331.8 6333.4 6333.5 1636.4 1641.8 1659.4 1659.4 1662.9 1057.2 1107.6 1126.6 1135.4 1156.5 5991.3 5991.5 5993.1 5993.3 5995.9 6418.4 6432.8 6434.0 6434.8 6438.4 5997.7 6022.2 6024.5 6025.8 6026.2 3434.2 3461.2 3467.1 3467.4 3468.9 6521.6 6676.1 6683.9 6684.6 6688.7 6560.8 6576.6 6578.0 6588.2 6593.5 6648.2 6650.7 6655.6 6659.9 6661.4 6353.2 6371.2 6388.9 6394.7 6421.4 6135.8 6306.7 6318.6 6321.3 6348.5 6630.7 6648.5 6670.1 6673.4 6733.0 4614.3 4617.2 4618.9 4623.1 4639.9 6350.9 6355.9 6357.1 6369.4 6377.1 6123.5 6256.6 6262.5 6268.7 6269.3 6194.3 6199.9 6203.1 6204.0 6206.8 6068.2 6104.8 6107.9 6109.2 6112.2 6241.3 6243.4 6251.5 6258.3 6260.7 5947.8 6025.5 6050.6 6086.1 6097.1 19:30:42 INFO - PROCESS | 2771 | 19:30:42 INFO - PROCESS | 2771 | [#5] yui.html Cycles:180 Average:14778.48 Median:24773.06 stddev:17220.29 (69.5%) stddev-sans-first:17236.44 19:30:42 INFO - PROCESS | 2771 | Values: 764.2 800.4 811.7 816.1 882.9 13335.3 13467.4 13481.7 13537.9 13546.6 11776.1 12754.7 12795.6 12839.8 12858.7 815.2 822.7 828.4 829.0 829.2 816.5 819.5 821.0 821.0 821.2 854.1 859.6 860.2 861.3 863.6 856.8 860.6 860.9 861.3 861.5 626.6 628.0 628.8 629.4 629.7 13102.2 13112.8 13157.3 13174.7 13177.7 11888.8 11911.5 11989.6 12014.9 12032.0 10340.6 10541.9 10549.4 10589.5 10754.2 3708.6 3719.8 3742.3 3776.4 4479.6 53585.5 55759.4 55780.7 58134.1 58578.0 10796.6 10895.0 10945.5 11064.5 11107.2 17146.1 19537.7 19742.9 19759.5 19784.9 8019.4 8029.4 8157.0 8243.5 8586.3 4393.8 4427.3 4454.2 4455.6 4552.5 3305.4 3341.4 3349.3 3360.2 3365.9 621.8 651.1 651.7 652.6 666.3 734.2 741.9 773.2 784.6 805.3 8675.7 9249.4 9797.2 9821.5 9882.1 737.4 741.8 742.5 752.2 787.2 4583.5 4638.2 4655.0 4680.5 4682.9 59395.0 59894.7 59947.7 60121.0 60291.0 54562.7 54838.2 55379.7 55747.4 56016.4 39969.6 49925.0 50044.5 50922.5 50996.0 9668.4 9681.0 9693.5 9697.7 9756.9 37608.8 37632.4 38128.6 38790.0 39388.8 43692.0 45066.5 47880.5 48312.0 50427.0 11044.2 11128.6 11554.9 11681.9 11744.9 13226.3 13235.7 13262.9 13719.2 13950.7 11942.0 12204.7 12244.2 12467.2 12841.9 12158.4 12559.4 12720.7 12767.7 13045.0 12631.2 12667.3 12686.9 12742.6 12820.4 10416.0 10424.0 10494.9 10525.4 10617.9 10873.2 10883.1 10898.6 11003.1 11098.8 19:30:42 INFO - PROCESS | 2771 | -------- Summary: end -------- 19:30:42 INFO - PROCESS | 2771 | 19:30:42 INFO - TEST-INFO | 2771: exit 0 19:30:42 INFO - TEST-OK | dromaeo_css | took 1111370ms 19:30:42 INFO - TEST-START | kraken 19:30:42 INFO - operating with platform_type : linux_ 19:30:42 INFO - Initialising browser for kraken test... 19:30:42 INFO - TEST-INFO | started process 3007 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEpoZwK/profile http://localhost:54931/getInfo.html) 19:30:47 INFO - PROCESS | 3007 | __metrics Screen width/height:1600/1200 19:30:47 INFO - PROCESS | 3007 | colorDepth:24 19:30:47 INFO - PROCESS | 3007 | Browser inner width/height: 1024/697 19:30:47 INFO - PROCESS | 3007 | __metrics 19:30:48 ERROR - PROCESS | 3007 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:30:49 INFO - TEST-INFO | 3007: exit 0 19:30:49 INFO - Browser initialized. 19:30:49 INFO - Running cycle 1/1 for kraken test... 19:30:49 INFO - TEST-INFO | started process 3091 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEpoZwK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:01 INFO - PROCESS | 3091 | RSS: Main: 151982080 19:31:01 INFO - PROCESS | 3091 | 19:31:03 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54931/tests/kraken/driver.html?testName=audio-beat-detection) 19:31:04 INFO - PROCESS | 3091 | RSS: Main: 193069056 19:31:04 INFO - PROCESS | 3091 | 19:31:06 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54931/tests/kraken/driver.html?testName=audio-dft) 19:31:07 INFO - PROCESS | 3091 | RSS: Main: 184352768 19:31:07 INFO - PROCESS | 3091 | 19:31:10 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54931/tests/kraken/driver.html?testName=audio-fft) 19:31:10 INFO - PROCESS | 3091 | RSS: Main: 169287680 19:31:10 INFO - PROCESS | 3091 | 19:31:12 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54931/tests/kraken/driver.html?testName=audio-oscillator) 19:31:13 INFO - PROCESS | 3091 | RSS: Main: 172183552 19:31:13 INFO - PROCESS | 3091 | 19:31:15 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54931/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:31:16 INFO - PROCESS | 3091 | RSS: Main: 173203456 19:31:16 INFO - PROCESS | 3091 | 19:31:19 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54931/tests/kraken/driver.html?testName=imaging-darkroom) 19:31:19 INFO - PROCESS | 3091 | RSS: Main: 172957696 19:31:19 INFO - PROCESS | 3091 | 19:31:23 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54931/tests/kraken/driver.html?testName=imaging-desaturate) 19:31:23 INFO - PROCESS | 3091 | RSS: Main: 174456832 19:31:23 INFO - PROCESS | 3091 | 19:31:26 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54931/tests/kraken/driver.html?testName=json-parse-financial) 19:31:26 INFO - PROCESS | 3091 | RSS: Main: 174694400 19:31:26 INFO - PROCESS | 3091 | 19:31:28 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54931/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:31:29 INFO - PROCESS | 3091 | RSS: Main: 184963072 19:31:29 INFO - PROCESS | 3091 | 19:31:30 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54931/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:31:31 INFO - PROCESS | 3091 | RSS: Main: 182165504 19:31:31 INFO - PROCESS | 3091 | 19:31:33 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54931/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:31:33 INFO - PROCESS | 3091 | RSS: Main: 191819776 19:31:33 INFO - PROCESS | 3091 | 19:31:36 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:31:36 INFO - PROCESS | 3091 | RSS: Main: 199647232 19:31:36 INFO - PROCESS | 3091 | 19:31:39 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:39 INFO - PROCESS | 3091 | RSS: Main: 200228864 19:31:39 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | Cycle 1(1): loaded http://localhost:54931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54931/tests/kraken/driver.html?testName=ai-astar) 19:31:41 INFO - PROCESS | 3091 | RSS: Main: 260063232 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | __start_tp_report 19:31:41 INFO - PROCESS | 3091 | _x_x_mozilla_page_load 19:31:41 INFO - PROCESS | 3091 | _x_x_mozilla_page_load_details 19:31:41 INFO - PROCESS | 3091 | |i|pagename|runs| 19:31:41 INFO - PROCESS | 3091 | |0;ai-astar;110;111;107;110;109;109;98;108;108;109 19:31:41 INFO - PROCESS | 3091 | |1;audio-beat-detection;151;125;154;161;125;156;150;124;178;124 19:31:41 INFO - PROCESS | 3091 | |2;audio-dft;162;160;160;160;163;160;160;163;159;159 19:31:41 INFO - PROCESS | 3091 | |3;audio-fft;75;75;106;94;75;74;73;119;95;73 19:31:41 INFO - PROCESS | 3091 | |4;audio-oscillator;93;93;153;92;93;93;138;92;92;140 19:31:41 INFO - PROCESS | 3091 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 19:31:41 INFO - PROCESS | 3091 | |6;imaging-darkroom;146;145;146;145;146;145;145;146;145;145 19:31:41 INFO - PROCESS | 3091 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 19:31:41 INFO - PROCESS | 3091 | |8;json-parse-financial;56;56;54;55;54;55;55;63;53;52 19:31:41 INFO - PROCESS | 3091 | |9;json-stringify-tinderbox;59;59;59;59;59;60;59;59;59;61 19:31:41 INFO - PROCESS | 3091 | |10;stanford-crypto-aes;76;77;78;78;77;77;77;76;78;77 19:31:41 INFO - PROCESS | 3091 | |11;stanford-crypto-ccm;117;112;106;115;118;118;118;111;125;114 19:31:41 INFO - PROCESS | 3091 | |12;stanford-crypto-pbkdf2;145;137;144;140;143;131;141;146;141;139 19:31:41 INFO - PROCESS | 3091 | |13;stanford-crypto-sha256-iterative;64;67;64;63;63;65;65;65;62;61 19:31:41 INFO - PROCESS | 3091 | __end_tp_report 19:31:41 INFO - PROCESS | 3091 | __start_cc_report 19:31:41 INFO - PROCESS | 3091 | _x_x_mozilla_cycle_collect,1035 19:31:41 INFO - PROCESS | 3091 | __end_cc_report 19:31:41 INFO - PROCESS | 3091 | __startTimestamp1458181901835__endTimestamp 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | ------- Summary: start ------- 19:31:41 INFO - PROCESS | 3091 | Number of tests: 14 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.50 stddev:3.67 (3.3%) stddev-sans-first:3.81 19:31:41 INFO - PROCESS | 3091 | Values: 110.0 111.0 107.0 110.0 109.0 109.0 98.0 108.0 108.0 109.0 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:152.50 stddev:19.12 (12.5%) stddev-sans-first:20.15 19:31:41 INFO - PROCESS | 3091 | Values: 151.0 125.0 154.0 161.0 125.0 156.0 150.0 124.0 178.0 124.0 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.00 stddev:1.51 (0.9%) stddev-sans-first:1.51 19:31:41 INFO - PROCESS | 3091 | Values: 162.0 160.0 160.0 160.0 163.0 160.0 160.0 163.0 159.0 159.0 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#3] audio-fft Cycles:10 Average:85.90 Median:75.00 stddev:16.60 (22.1%) stddev-sans-first:17.13 19:31:41 INFO - PROCESS | 3091 | Values: 75.0 75.0 106.0 94.0 75.0 74.0 73.0 119.0 95.0 73.0 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:92.50 stddev:24.98 (27.0%) stddev-sans-first:25.91 19:31:41 INFO - PROCESS | 3091 | Values: 93.0 93.0 153.0 92.0 93.0 93.0 138.0 92.0 92.0 140.0 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:31:41 INFO - PROCESS | 3091 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:31:41 INFO - PROCESS | 3091 | Values: 146.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:31:41 INFO - PROCESS | 3091 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:2.98 (5.4%) stddev-sans-first:3.15 19:31:41 INFO - PROCESS | 3091 | Values: 56.0 56.0 54.0 55.0 54.0 55.0 55.0 63.0 53.0 52.0 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 19:31:41 INFO - PROCESS | 3091 | Values: 59.0 59.0 59.0 59.0 59.0 60.0 59.0 59.0 59.0 61.0 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:77.00 stddev:0.74 (1.0%) stddev-sans-first:0.67 19:31:41 INFO - PROCESS | 3091 | Values: 76.0 77.0 78.0 78.0 77.0 77.0 77.0 76.0 78.0 77.0 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#11] stanford-crypto-ccm Cycles:10 Average:115.40 Median:117.50 stddev:5.13 (4.4%) stddev-sans-first:5.40 19:31:41 INFO - PROCESS | 3091 | Values: 117.0 112.0 106.0 115.0 118.0 118.0 118.0 111.0 125.0 114.0 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.70 Median:142.00 stddev:4.40 (3.1%) stddev-sans-first:4.38 19:31:41 INFO - PROCESS | 3091 | Values: 145.0 137.0 144.0 140.0 143.0 131.0 141.0 146.0 141.0 139.0 19:31:41 INFO - PROCESS | 3091 | 19:31:41 INFO - PROCESS | 3091 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.50 stddev:1.73 (2.7%) stddev-sans-first:1.83 19:31:41 INFO - PROCESS | 3091 | Values: 64.0 67.0 64.0 63.0 63.0 65.0 65.0 65.0 62.0 61.0 19:31:41 INFO - PROCESS | 3091 | -------- Summary: end -------- 19:31:41 INFO - PROCESS | 3091 | 19:31:42 INFO - TEST-INFO | 3091: exit 0 19:31:42 INFO - TEST-OK | kraken | took 60132ms 19:31:42 INFO - SUITE-END | took 1171s 19:31:43 INFO - Completed test suite (00:19:31) 19:31:43 INFO - javascript benchmark 19:31:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3068.4783586790245, 3119.0954623159287, 3156.558081868539, 3167.461531539638, 3184.0766177808437, 5203.817866374678, 5259.184826351912, 5324.254604355388, 5379.865503362418, 5398.190271459278, 5343.0, 5366.973165134179, 5368.087425137726, 5389.0, 5450.972745136279, 4783.115123702109, 4799.904001919959, 4804.735739534324, 4929.4824043475455, 4930.506949305059, 4724.24412094065, 4897.240927656219, 4899.265110233476, 4913.287573301869, 5010.72441015744, 4787.0, 4835.323054772335, 4851.708897466128, 4869.123557759602, 4881.170201065827, 4829.975850120762, 4832.1543729847135, 4835.323054772335, 4841.298011788271, 4867.975660121712, 4701.200795864711, 4735.431748190204, 4788.592969597588, 4815.229563269895, 4863.9513604864205, 5300.575953923715, 5301.469853014706, 5304.124819404794, 5315.574754019708, 5333.519983201491, 5740.397258287903, 5742.655440673573, 5755.366909639936, 5759.539236861041, 5761.135829625548, 5637.8590535236535, 5675.0, 5767.221425107598, 5780.364159942445, 5783.710814459302, 5349.893002139975, 5351.759170837283, 5353.0, 5359.0, 5407.540359069484, 5849.444302791228, 5854.121881717776, 5855.326637436664, 5856.180134781134, 5916.467517923322, 5484.890302193934, 5616.6068375213345, 5617.662940223599, 5639.689817060019, 5653.971730141323, 5744.684042377626, 5758.049921762862, 5764.423557644202, 5764.625299355613, 5800.651960882361, 5652.604317697804, 5692.6015178937905, 5699.430056994267, 5700.629459085146, 5704.914426283609, 5573.526250268692, 5646.463585959409, 5709.486146246774, 5799.0, 5800.187973683687, 4371.475422949203, 4375.168717943644, 4377.518472968035, 4381.364702118175, 4411.051623900813, 3875.8837234883, 3902.590228026073, 3907.5701672815967, 3939.290927632996, 3951.980240098781, 5312.495312945264, 5467.125259958388, 5492.286002819687, 5540.612157148961, 5542.667439953616, 5732.77068917247, 5748.913766293509, 5750.166225897222, 5762.394948530427, 5766.394528574523, 5309.5752339812725, 5398.865028374322, 5413.079776438015, 5413.323334583177, 5417.052015897202, 4775.856724298276, 4789.784459699322, 4814.855554333376, 4821.252705830602, 4859.173940430135, 5967.254093238345, 5976.671283079386, 5982.641041537521, 5989.431004054608, 5990.670513121733, 5683.8010669626365, 5727.255456790757, 5771.971140144273, 5795.797147099831, 5810.07038873795, 5953.6725480097275, 5959.493443057216, 5959.851003724942, 5965.791197308074, 5988.311344195299, 5662.320521537277, 5664.716764161858, 5666.17840413146, 5668.234788303526, 5670.716464176692, 5644.0, 5706.400827913176, 5739.139129130664, 5742.59801813869, 5776.306843178677, 5606.215129881738, 5645.294338207724, 5645.858853528694, 5669.177969194526, 5717.371089180104, 5582.720863956867, 5637.295338082739, 5642.210090587403, 5642.576806739593, 5648.661080335193, 5401.837944861661, 5527.917081243865, 5542.584306177134, 5583.330000399978, 5628.549716022791, 5629.211910332475, 5636.915446268391, 5639.605227634026, 5673.602847800779, 5676.517496012885, 5526.06056970308, 5539.833804985857, 5560.972195138998, 5566.109422492382, 5566.526845218202], "unit": "score", "name": "dojo.html", "value": 5282.065238770511}, {"lowerIsBetter": false, "replicates": [548.4871645011912, 560.8958477851552, 566.2299272988732, 583.1107560969521, 599.9580029397943, 29274.853625731866, 29751.40497190055, 29752.851235743845, 29771.106866793976, 29785.553216701766, 42155.0, 42717.78641106798, 42856.785716071376, 42889.35665965005, 42892.785536072355, 8722.91277087229, 8919.866202006942, 8924.910750892506, 8925.910740892605, 8934.597943092576, 8722.21500064994, 8841.29269658429, 8850.911490885073, 8856.690015849446, 8860.8670869937, 8914.375993680445, 8998.910010899905, 9001.594928228213, 9007.234385077243, 9008.864867027, 8650.65397384104, 8656.956715216415, 8698.565071746387, 8703.912960870373, 8723.0, 8760.386772925898, 8945.194932456045, 8983.101689830964, 8985.23625491834, 8992.46045237288, 36447.4532882007, 36574.268514629824, 36675.633243667486, 36896.81551592225, 37365.62634373648, 3282.786618869766, 3289.243474000993, 3318.6183588887347, 3424.520567120605, 3430.3139372125675, 31609.683903160905, 31613.051608451784, 31794.682053179404, 32098.518522222184, 32811.0, 4295.398644189816, 4301.741895486281, 4346.195953748535, 4357.586029327209, 4363.149185908749, 305106.0, 307039.9999999978, 308958.0, 312515.0, 312577.0, 58903.41096589065, 59138.70430647819, 59294.11058834121, 59754.92083172979, 59807.40192598105, 62488.37511624917, 67581.0, 68558.65720671364, 68763.0, 68865.0, 15848.92075539615, 16021.919890400473, 16079.839201608069, 16082.43711470093, 16082.517524474284, 12408.62774116778, 12445.439955202037, 12477.0, 12477.937610312072, 12486.875131248753, 20173.293934712216, 20599.485012874797, 21321.68017479739, 21374.78625213728, 21415.892920535298, 7968.840623187504, 8446.704365347307, 8468.0, 8578.4424012439, 8601.61292741828, 938.1369140390857, 997.528645248253, 1003.1710576175261, 1069.8127827630133, 1101.680512651322, 32620.347593048005, 32686.509702354484, 32786.18034549108, 33051.66948330486, 33565.16087097793, 1160.3560024186488, 1186.1400484648561, 1228.4103630257348, 1254.1659796235401, 1286.5111257722006, 16591.751123733153, 16853.325866965184, 16921.0, 16980.830191698173, 17170.828291716924, 392831.0, 395440.0, 396190.0, 398090.0, 398229.0, 56739.0, 57418.425815741306, 57426.0, 57508.0, 57530.0, 1218.670958841108, 1360.129517109051, 1381.544090450149, 1385.902986790935, 1414.3988804757937, 28730.281742955758, 29995.550066749453, 30397.544036839023, 30438.239044024078, 30959.226019349695, 39448.802755986035, 40262.59737402706, 40461.59538404578, 40523.0, 41319.96700082522, 263288.0, 267136.0, 267947.0, 498490.0, 506779.0, 39133.41299880561, 42786.35820462758, 46906.76546617245, 47213.0, 48172.0, 43203.78398107989, 43604.34593481037, 43852.56147438485, 43971.78014109909, 44811.55188448074, 37432.81283593673, 37658.43512347262, 38197.427038595, 38381.2323753529, 38666.226675466896, 36801.26397471982, 37027.629723703496, 37082.25835483329, 37111.25777484489, 37417.625823741415, 39560.60439395569, 40155.0, 40594.0, 40594.79702601468, 41097.38353924753, 34832.9550113497, 36372.63627363693, 36380.81809590935, 36475.81762091172, 40311.79844100761, 28023.019194328102, 28386.0, 28421.857890710413, 28483.572746408405, 28585.571216432185], "unit": "score", "name": "ext.html", "value": 19589.38481489227}, {"lowerIsBetter": false, "replicates": [360.3567631777278, 366.061053398034, 373.372733807204, 373.674902834534, 383.3463943975522, 17647.823521764796, 17781.55546111348, 18042.45872623822, 18079.0, 18121.365752198675, 17007.91496042518, 18327.90836045818, 18946.147423365946, 19001.809981900176, 19011.04944752764, 5527.723613819313, 5680.403557626451, 5698.629589076697, 5704.942950570504, 5747.568932330071, 4088.121053973395, 5646.0, 6014.338422773513, 6266.091416744569, 6282.24613046435, 6184.6289222646565, 6198.535109866755, 6226.40849119333, 6227.813165605016, 6228.0657901314935, 6129.601575897553, 6172.22847144107, 6282.0, 6284.27730810958, 6284.780032698834, 3717.460968159629, 5238.319018527605, 5350.491703288181, 5384.273123128367, 5527.474889885454, 20882.0, 20917.5816483671, 20956.685649715266, 22450.0, 22495.66256506154, 2342.847714898526, 2349.5066036132434, 2387.033251533132, 2458.299384675377, 2484.416162201881, 9483.478408687519, 9644.421334719938, 9646.614135434644, 9860.950695246549, 10155.136813370873, 1950.4538729155859, 1982.9504262393411, 1986.6821308590556, 2027.3208475160839, 2093.4766308422895, 67508.0, 67953.66023169852, 68450.0, 68696.25214991445, 69012.99999999949, 10887.782244355069, 10984.340939543654, 11305.886941130484, 11337.659870203906, 11494.770104597861, 14623.78064329036, 14646.780298295535, 14772.852271477148, 14773.704525909421, 14784.556463306119, 8169.060558035783, 8297.336213102937, 8344.290735287446, 8401.915980840236, 8452.450590711584, 8099.919000809917, 8109.675612975415, 8129.918700813035, 8148.348132149414, 8254.8349033019, 4763.976180119077, 4767.69010014348, 4772.164871147605, 4791.401074865642, 4855.9074208302845, 1773.4502304285713, 1806.6603748146183, 1826.862985276083, 1830.9725354119698, 1856.8700190986501, 1028.475477506477, 1053.4785281285813, 1076.0100707349256, 1083.4311986207147, 1131.1911982932243, 18479.30129791552, 18496.907515462604, 18530.907345463187, 18908.243670253036, 19001.809981900005, 974.0503009565758, 985.3102828020415, 1005.1205195453978, 1038.48075962019, 1080.222239987208, 10178.491075446198, 10533.473326333653, 10579.62971296001, 10662.360258384522, 10768.46157692128, 493687.0, 514550.0, 515071.0, 518593.0, 520375.0, 83536.58231708924, 84976.0, 86618.0, 86713.0, 87623.0, 1016.8830584482731, 1036.3471013261747, 1042.551702767802, 1058.4548957287004, 1058.687687132298, 16345.836541634908, 16354.509364719077, 16441.588960276087, 16568.66862662764, 16582.0, 36347.0, 37950.810245948596, 38865.61134388733, 38944.80527597457, 39427.60572394239, 52244.73877630587, 52862.2070668948, 53094.203586947, 53206.2019069722, 53329.733351332994, 8302.6678932842, 8372.372072094495, 8435.24082832548, 8520.872186917326, 8619.267362274277, 9570.425774453555, 12852.228866268053, 13151.868481315447, 13206.735865282833, 13269.203847769164, 11270.661880143609, 11677.240979336317, 11924.224925379822, 11926.761464770829, 12039.337836419081, 11180.161487888277, 11305.71735706614, 11324.830127547928, 11498.82751758741, 11556.711082223012, 10159.0, 11226.438678066228, 11715.1799374043, 11738.354390508604, 11954.58158964432, 8066.435349525477, 8153.877691834508, 8338.499690018618, 8343.41596088268, 8546.957265213634, 10743.08683761889, 11330.660080197607, 11783.469743861375, 11822.82265765997, 11894.881051189723], "unit": "score", "name": "jquery.html", "value": 9038.80039459223}, {"lowerIsBetter": false, "replicates": [1341.644464216982, 1498.0487390507028, 1498.6927679825637, 1686.8998097368778, 1831.8259765322289, 8096.7975800604945, 8235.505869647825, 8244.793880153, 8265.91734082659, 8266.380021498382, 8100.797480063002, 8230.91769082309, 8248.505089694607, 8253.298469630088, 8260.91739082609, 2359.929202123939, 2363.728171260301, 2382.118616112032, 2383.118246248882, 2386.3079706884982, 2353.51752890657, 2356.611159158737, 2423.6849209602815, 2441.865697386643, 2444.4377793107597, 2388.450656349041, 2400.3879010852206, 2410.204632471289, 2410.5781488239577, 2412.9276121716375, 2356.587597170497, 2368.0764501844296, 2387.462820865309, 2387.7134743830766, 2408.9518209635708, 2413.6500207469994, 2442.46265821519, 2456.9877150614134, 2457.3856535866034, 2460.126655037454, 8320.542370169638, 8366.916330836735, 8371.539565323905, 8372.246497815226, 8378.622961966665, 5084.288199652052, 5231.372235331784, 5232.319798426181, 5239.738013099368, 5245.160774276135, 3446.2590543033116, 3477.2176260341475, 3514.3674138655033, 3518.700910422617, 3525.312564050011, 1192.1654841610907, 1205.475618106118, 1232.12519111431, 1258.6349958512021, 1260.0549587809144, 12085.516579336816, 12135.757284854342, 12148.271103733716, 12158.452869620889, 12159.696007599792, 4587.587117159472, 4748.358971538867, 4766.356541866873, 4837.6613637045775, 4840.515948405202, 10217.693469195936, 10219.0, 10222.080012798735, 10242.0, 10248.692539223835, 5235.0, 5252.395974462909, 5274.050670879278, 5284.841454756363, 5291.656042357312, 4143.150654115899, 4662.580367766849, 4792.065547218329, 4801.5438533339275, 4846.5638092571835, 4003.3994900764537, 4041.7170798044444, 4057.776822274803, 4061.1674606705556, 4092.652124569445, 1304.7651422743807, 1305.536534530228, 1315.8552559218479, 1318.7098838255567, 1324.1591589340646, 961.2022021721954, 1110.5835311758092, 1161.5702190189684, 1270.6124631987332, 1386.4107754204422, 7653.387728981668, 7729.4202934779, 7784.688612455551, 7788.299053085137, 7805.102413222552, 1143.0626885953604, 1148.3683973814536, 1152.6599653102355, 1154.284343706907, 1193.397334346167, 6161.568690191643, 6183.690815459299, 6214.8135555933395, 6236.656983865841, 6300.968495157586, 9947.900520994843, 10501.264911456125, 10637.840432393521, 10638.680839574825, 10665.146788256921, 10022.749431264278, 10442.373457592568, 10446.529906154241, 10446.582136714598, 10495.265331426726, 8015.639296231567, 8114.188581141957, 8190.262876341158, 8194.180581941759, 8197.180281971756, 7823.530588164728, 7838.098618658927, 7864.252895974873, 7871.960640196762, 7969.442139050211, 9081.409708368936, 9280.907190928005, 9293.791807065309, 9299.67451139207, 9506.762330941781, 9397.154256116983, 9445.574949127169, 9487.620495180392, 9679.564419600994, 9681.031896810262, 7192.42460603161, 7272.41820654357, 7284.162321332902, 7298.087739032621, 7309.853802924018, 8024.558649274346, 8177.4684645497855, 8205.384596155192, 8229.711960081368, 8238.423310368456, 6177.96911015442, 7378.29906158914, 7510.62446877643, 7584.810379740551, 7601.543907365576, 7166.677499512431, 7189.0, 7237.855242895007, 7251.673674684546, 7296.160941491584, 7514.736984205527, 7557.244275572399, 7569.6593653284635, 7575.356094732009, 7575.583342916192, 6272.466840318624, 6280.497560195265, 6282.057691346335, 6292.937070629235, 6294.905576416266, 6748.966255168692, 7051.823704407431, 7056.294370562902, 7063.152421709222, 7065.258147894397], "unit": "score", "name": "mootools.html", "value": 4858.079544829677}, {"lowerIsBetter": false, "replicates": [339.1149100846791, 340.94715319125544, 349.81110200491736, 350.5600471408382, 351.546505008539, 5891.587588868775, 5945.9702701486485, 5949.5537834662355, 5980.581359304851, 5981.192539007233, 5880.617759845607, 5882.941170588293, 5886.234789477373, 5886.999999999989, 5908.320543137541, 4345.6523478121835, 4423.845165419211, 4494.280915053592, 4517.322401639747, 4547.454305483347, 4504.8198072077075, 4515.480719717241, 4530.411046563942, 4533.523979982104, 4536.5236650151755, 4469.329600559926, 4473.686841921067, 4480.417545719069, 4481.955180448186, 4497.123061003105, 4329.783510824446, 4374.5188029316905, 4438.778061096932, 4440.689151759379, 4468.8882777930485, 3919.3729003359326, 3924.50943632046, 3928.3321835287784, 3929.960700392988, 3934.4688467056867, 5668.234788303609, 5680.6591604503865, 5684.090545512699, 5684.317881854204, 5685.744141513642, 5261.184516399964, 5264.763085661154, 5266.526012658841, 5267.710275934822, 5270.156774915995, 6227.688615569204, 6235.282942461629, 6237.594556353823, 6239.937600623981, 6240.656763877985, 4337.479502459693, 4400.647948164139, 4404.427424434803, 4459.175052615245, 4465.129299786543, 6428.742850285983, 6497.642629655367, 6530.804075877683, 6556.18047744032, 6573.112629794964, 4642.141203877293, 4648.790804413809, 4649.604783593365, 4649.907001859944, 4652.232381657056, 4706.741129237925, 4707.95292047082, 4707.987782626683, 4709.058188362341, 4709.670323077352, 5341.946580534222, 5346.732663366816, 5350.608841701108, 5355.491228333302, 5392.649477783932, 6160.691965401712, 6264.906026409608, 6331.810045698637, 6333.398327158912, 6333.46165575922, 1636.3618188906337, 1641.7619445180383, 1659.3694396129395, 1659.402615058578, 1662.9251683674263, 1057.2070946789909, 1107.5791199344199, 1126.6311431610632, 1135.3585224348217, 1156.5200441816553, 5991.2510936132985, 5991.5206783457215, 5993.0710739835395, 5993.250843644457, 5995.910061349084, 6418.390252926058, 6432.839179020562, 6434.0, 6434.806955791334, 6438.356164383524, 5997.730102145414, 6022.18700475439, 6024.548158888101, 6025.849353766103, 6026.186464827192, 3434.227298857787, 3461.2385275239913, 3467.133216695826, 3467.4452087665854, 3468.9132771680406, 6521.608703477807, 6676.0987266718375, 6683.866322673616, 6684.63234522106, 6688.7324507019175, 6560.803175904731, 6576.572522786004, 6578.013298005338, 6588.209414870151, 6593.505487088488, 6648.16897887764, 6650.667466626746, 6655.633940133339, 6659.933400666028, 6661.367170118831, 6353.237611486466, 6371.203599550056, 6388.872222555616, 6394.680265986775, 6421.422072013541, 6135.8466038347615, 6306.65313407767, 6318.62088274705, 6321.33625969285, 6348.492120630246, 6630.701618427086, 6648.468122550088, 6670.099536562696, 6673.432758215606, 6733.023711561698, 4614.2617181250835, 4617.238155704271, 4618.907621847611, 4623.0522742836965, 4639.86080417588, 6350.872982540416, 6355.90466142999, 6357.110004599453, 6369.426751592379, 6377.1390862233, 6123.540734444845, 6256.5620406572925, 6262.46769024638, 6268.655223962726, 6269.341719119427, 6194.256689197326, 6199.876002479835, 6203.069539569101, 6204.038374052029, 6206.751729930752, 6068.180795592715, 6104.847378815565, 6107.9083813741945, 6109.236345456818, 6112.205413296243, 6241.282252541016, 6243.438090571689, 6251.468625166912, 6258.311585725475, 6260.655663938527, 5947.791827286024, 6025.548083893638, 6050.576459647782, 6086.056661217518, 6097.115918191748], "unit": "score", "name": "prototype.html", "value": 4749.299631594057}, {"lowerIsBetter": false, "replicates": [764.1708746010578, 800.3557136505111, 811.703728139229, 816.0778320497838, 882.911708829117, 13335.333233338342, 13467.393967271471, 13481.730365392687, 13537.864621353783, 13546.593602191937, 11776.116791240649, 12754.68113297168, 12795.616131516046, 12839.807402888964, 12858.678533036678, 815.2051749544191, 822.7449490657885, 828.3704384667666, 828.9668413263462, 829.2495291760966, 816.4529765057425, 819.4960099538771, 820.995895020524, 821.0, 821.1747194069951, 854.0733304364771, 859.6260626627405, 860.2043110123142, 861.2722249698994, 863.5768473447997, 856.8200677857658, 860.6127242740791, 860.8794768732382, 861.2894362151251, 861.4960248254747, 626.580191271849, 628.0265588338103, 628.8050704281642, 629.361198383641, 629.7134803664368, 13102.213867168, 13112.803307950388, 13157.342132893316, 13174.736505269937, 13177.670558236025, 11888.762224755457, 11911.463984120648, 11989.64031079069, 12014.939925300405, 12032.0, 10340.638077667321, 10541.894581054168, 10549.367037977669, 10589.523471443727, 10754.19343549229, 3708.5735140458924, 3719.814009299524, 3742.251549690073, 3776.3957766757185, 4479.574440428187, 53585.46414535844, 55759.44240557583, 55780.72109639466, 58134.12798808063, 58578.0, 10796.568137274578, 10895.0, 10945.4527273636, 11064.502097405637, 11107.222494425312, 17146.142692865305, 19537.706934395996, 19742.90128549348, 19759.506012349808, 19784.90107549453, 8019.35845132388, 8029.357651387875, 8157.0, 8243.546604936786, 8586.31309495239, 4393.846215382447, 4427.295491235897, 4454.198244316054, 4455.6212721918355, 4552.521985191507, 3305.3719793239206, 3341.3818443588016, 3349.279904820475, 3360.1599600099976, 3365.9326813463595, 621.8445388652837, 651.0852252585125, 651.7425616881305, 652.5693042591867, 666.2804171494774, 734.2217249715212, 741.8590467811099, 773.2306355176635, 784.5724080376094, 805.2873207211543, 8675.739727808175, 9249.398789078823, 9797.16724078447, 9821.459819709842, 9882.11061004513, 737.4395459450856, 741.7552207771422, 742.4542960923717, 752.236479972828, 787.1813314153331, 4583.495815460296, 4638.2115040443205, 4655.0, 4680.531946805292, 4682.929756053662, 59395.0, 59894.70052649796, 59947.700261498416, 60121.0, 60291.0, 54562.727186363816, 54838.177427338625, 55379.72310138423, 55747.44252557504, 56016.43983560112, 39969.60030399717, 49925.001499969796, 50044.49955500471, 50922.49077509252, 50995.980080398185, 9668.419894806335, 9680.95159524226, 9693.515324233618, 9697.709068727949, 9756.902430975599, 37608.811955940044, 37632.43551346677, 38128.618713813616, 38790.0, 39388.803055984536, 43692.0, 45066.549334506235, 47880.521194789, 48312.0, 50427.0, 11044.171687123337, 11128.554857805597, 11554.884451155382, 11681.88318116808, 11744.94127529357, 13226.281439031834, 13235.735285294048, 13262.867371326549, 13719.176849389069, 13950.720985580028, 11942.0, 12204.694882628006, 12244.204126731735, 12467.189632673848, 12841.871581284067, 12158.392080395768, 12559.43482543306, 12720.6819829505, 12767.680807979503, 13045.0, 12631.178973366701, 12667.30329831868, 12686.936565317113, 12742.554010609585, 12820.423080961193, 10416.0, 10424.0, 10494.947525262325, 10525.36847789135, 10617.89382106169, 10873.184511161853, 10883.12934965185, 10898.618548351087, 11003.064739497233, 11098.778024439627], "unit": "score", "name": "yui.html", "value": 6737.256723614283}], "name": "dromaeo_css", "value": 7251.455253872213}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 110.0, 109.0, 109.0, 98.0, 108.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [151.0, 125.0, 154.0, 161.0, 125.0, 156.0, 150.0, 124.0, 178.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 160.0, 160.0, 163.0, 160.0, 160.0, 163.0, 159.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 106.0, 94.0, 75.0, 74.0, 73.0, 119.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 153.0, 92.0, 93.0, 93.0, 138.0, 92.0, 92.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 54.0, 55.0, 54.0, 55.0, 55.0, 63.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 59.3}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 78.0, 78.0, 77.0, 77.0, 77.0, 76.0, 78.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 77.1}, {"lowerIsBetter": true, "replicates": [117.0, 112.0, 106.0, 115.0, 118.0, 118.0, 118.0, 111.0, 125.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.4}, {"lowerIsBetter": true, "replicates": [145.0, 137.0, 144.0, 140.0, 143.0, 131.0, 141.0, 146.0, 141.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.7}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 64.0, 63.0, 63.0, 65.0, 65.0, 65.0, 62.0, 61.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.9}], "name": "kraken", "value": 1476.2}]} 19:31:43 INFO - Return code: 0 19:31:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:31:43 ERROR - # TBPL SUCCESS # 19:31:43 INFO - Running post-action listener: _resource_record_post_action 19:31:43 INFO - Running post-run listener: _resource_record_post_run 19:31:44 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535060480; Read time: 8; Write time: 1146560 19:31:44 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 242356224; Read time: 0; Write time: 673220 19:31:44 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292704256; Read time: 8; Write time: 473340 19:31:44 INFO - Running post-run listener: _upload_blobber_files 19:31:44 INFO - Blob upload gear active. 19:31:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:31:44 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 19:31:44 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'] 19:31:44 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 19:31:44 INFO - (blobuploader) - INFO - Open directory for files ... 19:31:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:31:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:31:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:45 INFO - (blobuploader) - INFO - Done attempting. 19:31:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:31:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:31:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:46 INFO - (blobuploader) - INFO - Done attempting. 19:31:46 INFO - (blobuploader) - INFO - Iteration through files over. 19:31:46 INFO - Return code: 0 19:31:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:31:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:31:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/783b74b7ba7131e9aa2059e8c87e2104399ec5f56d2502aa97bc538bb27842a7110b0652edda3c617170ef00a1e6aab26a29918fca3e148175435a2e0b46160a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c21b3ddbc796a631825f3004027873fcc6d9995233a34c45364a6c74e60245b5e3f6ec272cdc936e53b10aceed4c4feaa2cf6c42697abb55c5316dcb1aaf5558"} 19:31:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:31:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:31:46 INFO - Contents: 19:31:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/783b74b7ba7131e9aa2059e8c87e2104399ec5f56d2502aa97bc538bb27842a7110b0652edda3c617170ef00a1e6aab26a29918fca3e148175435a2e0b46160a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c21b3ddbc796a631825f3004027873fcc6d9995233a34c45364a6c74e60245b5e3f6ec272cdc936e53b10aceed4c4feaa2cf6c42697abb55c5316dcb1aaf5558"} 19:31:46 INFO - Running post-run listener: copy_logs_to_upload_dir 19:31:46 INFO - Copying logs to upload dir... 19:31:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:31:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.830103 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-16 19:31:46.376862) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 19:31:46.384235) ========= 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=8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788 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/783b74b7ba7131e9aa2059e8c87e2104399ec5f56d2502aa97bc538bb27842a7110b0652edda3c617170ef00a1e6aab26a29918fca3e148175435a2e0b46160a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c21b3ddbc796a631825f3004027873fcc6d9995233a34c45364a6c74e60245b5e3f6ec272cdc936e53b10aceed4c4feaa2cf6c42697abb55c5316dcb1aaf5558"} build_url:https://queue.taskcluster.net/v1/task/V9fpQke2QcaiWQHVUZZSUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/V9fpQke2QcaiWQHVUZZSUQ/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/783b74b7ba7131e9aa2059e8c87e2104399ec5f56d2502aa97bc538bb27842a7110b0652edda3c617170ef00a1e6aab26a29918fca3e148175435a2e0b46160a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c21b3ddbc796a631825f3004027873fcc6d9995233a34c45364a6c74e60245b5e3f6ec272cdc936e53b10aceed4c4feaa2cf6c42697abb55c5316dcb1aaf5558"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 19:31:46.408164) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 19:31:46.411514) ========= 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=8783db0840cc980e80bb0bd400000236-1458179253.847396-1548709788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 19:31:46.490095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 19:31:46.490429) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 19:31:46.490725) ========= ========= Total master_lag: 0.31 =========