builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1458018867.59 results: success (0) buildid: 20160314193028 builduid: 64f01eab029b410f80dab125ec09dbb7 revision: d6ee82b9a74155b6bfd544166f036fc572ae8c56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.594936) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.595411) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.595698) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006249 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.617957) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.618262) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.640678) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.641058) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004154 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.688295) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.688598) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.688965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.689246) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-14 22:14:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-03-14 22:14:28 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.877681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.878010) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.029125 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.927777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:27.928137) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d6ee82b9a74155b6bfd544166f036fc572ae8c56 --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 d6ee82b9a74155b6bfd544166f036fc572ae8c56 --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=7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-14 22:14:28,218 truncating revision to first 12 chars 2016-03-14 22:14:28,218 Setting DEBUG logging. 2016-03-14 22:14:28,218 attempt 1/10 2016-03-14 22:14:28,218 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d6ee82b9a741?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 22:14:28,483 unpacking tar archive at: mozilla-central-d6ee82b9a741/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547888 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:28.488746) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:28.492129) ========= echo d6ee82b9a74155b6bfd544166f036fc572ae8c56 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd6ee82b9a74155b6bfd544166f036fc572ae8c56'] 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=7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d6ee82b9a74155b6bfd544166f036fc572ae8c56 program finished with exit code 0 elapsedTime=0.004184 script_repo_revision: 'd6ee82b9a74155b6bfd544166f036fc572ae8c56' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:28.540456) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:28.540749) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 22:14:28.550580) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-14 22:14:28.550868) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:14:28 INFO - MultiFileLogger online at 20160314 22:14:28 in /builds/slave/test-pgo 22:14:28 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 22:14:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:14:28 INFO - {'append_to_log': False, 22:14:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:14:28 INFO - 'blob_upload_branch': 'Firefox', 22:14:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:14:28 INFO - 'branch': 'Firefox', 22:14:28 INFO - 'buildbot_json_path': 'buildprops.json', 22:14:28 INFO - 'config_files': ('talos/linux_config.py',), 22:14:28 INFO - 'default_actions': ('clobber', 22:14:28 INFO - 'read-buildbot-config', 22:14:28 INFO - 'download-and-extract', 22:14:28 INFO - 'populate-webroot', 22:14:28 INFO - 'create-virtualenv', 22:14:28 INFO - 'install', 22:14:28 INFO - 'run-tests'), 22:14:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:14:28 INFO - 'download_minidump_stackwalk': True, 22:14:28 INFO - 'download_symbols': 'ondemand', 22:14:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:14:28 INFO - 'tooltool.py': '/tools/tooltool.py', 22:14:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:14:28 INFO - '/tools/misc-python/virtualenv.py')}, 22:14:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:14:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:14:28 INFO - 'installer_path': 'installer.exe', 22:14:28 INFO - 'log_level': 'info', 22:14:28 INFO - 'log_name': 'talos', 22:14:28 INFO - 'log_to_console': True, 22:14:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:14:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:14:28 INFO - 'opt_config_files': (), 22:14:28 INFO - 'pip_index': False, 22:14:28 INFO - 'sps_profile': False, 22:14:28 INFO - 'sps_profile_interval': 0, 22:14:28 INFO - 'suite': 'dromaeojs', 22:14:28 INFO - 'system_bits': '32', 22:14:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:14:28 INFO - 'title': 'talos-linux64-ix-005', 22:14:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:14:28 INFO - 'use_talos_json': True, 22:14:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:14:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:14:28 INFO - 'work_dir': 'build'} 22:14:28 INFO - ##### 22:14:28 INFO - ##### Running clobber step. 22:14:28 INFO - ##### 22:14:28 INFO - Running pre-action listener: _resource_record_pre_action 22:14:28 INFO - Running main action method: clobber 22:14:28 INFO - rmtree: /builds/slave/test-pgo/build 22:14:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:14:30 INFO - Running post-action listener: _resource_record_post_action 22:14:30 INFO - ##### 22:14:30 INFO - ##### Running read-buildbot-config step. 22:14:30 INFO - ##### 22:14:30 INFO - Running pre-action listener: _resource_record_pre_action 22:14:30 INFO - Running main action method: read_buildbot_config 22:14:30 INFO - Using buildbot properties: 22:14:30 INFO - { 22:14:30 INFO - "project": "", 22:14:30 INFO - "product": "firefox", 22:14:30 INFO - "script_repo_revision": "production", 22:14:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:14:30 INFO - "repository": "", 22:14:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:14:30 INFO - "buildid": "20160314193028", 22:14:30 INFO - "pgo_build": "True", 22:14:30 INFO - "basedir": "/builds/slave/test-pgo", 22:14:30 INFO - "buildnumber": 375, 22:14:30 INFO - "slavename": "talos-linux64-ix-005", 22:14:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:14:30 INFO - "platform": "ubuntu64_hw", 22:14:30 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:14:30 INFO - "branch": "mozilla-central", 22:14:30 INFO - "repo_path": "mozilla-central", 22:14:30 INFO - "revision": "d6ee82b9a74155b6bfd544166f036fc572ae8c56", 22:14:30 INFO - "stage_platform": "linux64-pgo", 22:14:30 INFO - "builduid": "64f01eab029b410f80dab125ec09dbb7", 22:14:30 INFO - "slavebuilddir": "test" 22:14:30 INFO - } 22:14:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:14:30 INFO - Running post-action listener: _resource_record_post_action 22:14:30 INFO - ##### 22:14:30 INFO - ##### Running download-and-extract step. 22:14:30 INFO - ##### 22:14:30 INFO - Running pre-action listener: _resource_record_pre_action 22:14:30 INFO - Running main action method: download_and_extract 22:14:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:30 INFO - https://queue.taskcluster.net/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:14:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:14:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:14:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/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 22:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/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 22:14:30 INFO - Downloaded 1361 bytes. 22:14:30 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:14:30 INFO - Using the following test package requirements: 22:14:30 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:14:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:14:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:14:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:30 INFO - u'jsshell-linux-x86_64.zip'], 22:14:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:14:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:14:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:14:30 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:14:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:14:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:14:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:30 INFO - https://queue.taskcluster.net/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:14:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:14:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:14:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/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 22:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/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 22:14:32 INFO - Downloaded 23560632 bytes. 22:14:32 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'] 22:14:32 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 22:14:34 INFO - Return code: 0 22:14:34 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 22:14: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')]} 22:14:34 INFO - https://queue.taskcluster.net/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:14:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:14:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:14:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/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 22:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/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 22:14:35 INFO - Downloaded 23560632 bytes. 22:14:35 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'] 22:14:35 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 22:14:37 INFO - Return code: 0 22:14: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')]} 22:14:37 INFO - https://queue.taskcluster.net/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:14:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:14:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:14:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/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 22:14:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/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 22:14:37 INFO - Downloaded 10845263 bytes. 22:14:37 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'] 22:14:37 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 22:14:38 INFO - Return code: 0 22:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:38 INFO - https://queue.taskcluster.net/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/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 22:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TG5WtENlRYGQ_lGd9Tldgw/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 22:14:42 INFO - Downloaded 57667068 bytes. 22:14:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:14:42 INFO - mkdir: /builds/slave/test-pgo/properties 22:14:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:14:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:14:42 INFO - Contents: 22:14:42 INFO - build_url:https://queue.taskcluster.net/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:14:43 INFO - Running post-action listener: _resource_record_post_action 22:14:43 INFO - Running post-action listener: set_extra_try_arguments 22:14:43 INFO - ##### 22:14:43 INFO - ##### Running populate-webroot step. 22:14:43 INFO - ##### 22:14:43 INFO - Running pre-action listener: _resource_record_pre_action 22:14:43 INFO - Running main action method: populate_webroot 22:14:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:14:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:14:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:14:43 INFO - '--tppagecycles', 22:14:43 INFO - '7'], 22:14:43 INFO - 'tests': ['tsvgm']}}, 22:14:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:14:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:14:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:14:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:14:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:14:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:14:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:14:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:43 INFO - 'talos_options': ['--e10s'], 22:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:14:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:43 INFO - 'tests': ['damp', 'tps']}, 22:14:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:43 INFO - 'talos_options': ['--e10s'], 22:14:43 INFO - 'tests': ['damp', 'tps']}, 22:14:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:14:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:14:43 INFO - 'other': {'tests': ['a11yr', 22:14:43 INFO - 'ts_paint', 22:14:43 INFO - 'tpaint', 22:14:43 INFO - 'sessionrestore', 22:14:43 INFO - 'sessionrestore_no_auto_restore', 22:14:43 INFO - 'tabpaint']}, 22:14:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:14:43 INFO - 'tests': ['a11yr', 22:14:43 INFO - 'ts_paint', 22:14:43 INFO - 'tpaint', 22:14:43 INFO - 'sessionrestore', 22:14:43 INFO - 'sessionrestore_no_auto_restore', 22:14:43 INFO - 'tabpaint']}, 22:14:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:14:43 INFO - 'tests': ['a11yr', 22:14:43 INFO - 'ts_paint', 22:14:43 INFO - 'tpaint', 22:14:43 INFO - 'sessionrestore', 22:14:43 INFO - 'sessionrestore_no_auto_restore', 22:14:43 INFO - 'tabpaint']}, 22:14:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:14:43 INFO - 'tests': ['a11yr', 22:14:43 INFO - 'ts_paint', 22:14:43 INFO - 'tpaint', 22:14:43 INFO - 'sessionrestore', 22:14:43 INFO - 'sessionrestore_no_auto_restore', 22:14:43 INFO - 'tabpaint']}, 22:14:43 INFO - 'other_l64': {'tests': ['a11yr', 22:14:43 INFO - 'ts_paint', 22:14:43 INFO - 'tpaint', 22:14:43 INFO - 'sessionrestore', 22:14:43 INFO - 'sessionrestore_no_auto_restore', 22:14:43 INFO - 'tabpaint']}, 22:14:43 INFO - 'other_nol64': {'tests': ['a11yr', 22:14:43 INFO - 'ts_paint', 22:14:43 INFO - 'tpaint', 22:14:43 INFO - 'sessionrestore', 22:14:43 INFO - 'sessionrestore_no_auto_restore', 22:14:43 INFO - 'tabpaint']}, 22:14:43 INFO - 'svgr': {'tests': ['tsvgx', 22:14:43 INFO - 'tsvgr_opacity', 22:14:43 INFO - 'tart', 22:14:43 INFO - 'tscrollx', 22:14:43 INFO - 'cart']}, 22:14:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:14:43 INFO - 'tests': ['tsvgx', 22:14:43 INFO - 'tsvgr_opacity', 22:14:43 INFO - 'tart', 22:14:43 INFO - 'tscrollx', 22:14:43 INFO - 'cart']}, 22:14:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:43 INFO - 'tests': ['tp5o']}, 22:14:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:43 INFO - 'talos_options': ['--e10s'], 22:14:43 INFO - 'tests': ['tp5o']}, 22:14:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:43 INFO - 'talos_options': ['--xperf_path', 22:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:14:43 INFO - 'tests': ['tp5n']}, 22:14:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:43 INFO - 'talos_options': ['--e10s', 22:14:43 INFO - '--xperf_path', 22:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:14:43 INFO - 'tests': ['tp5n']}}, 22:14:43 INFO - 'talos.zip': {'path': '', 22:14:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:14:43 INFO - Running post-action listener: _resource_record_post_action 22:14:43 INFO - ##### 22:14:43 INFO - ##### Running create-virtualenv step. 22:14:43 INFO - ##### 22:14:43 INFO - Running pre-action listener: _resource_record_pre_action 22:14:43 INFO - Running main action method: create_virtualenv 22:14:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:14:43 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 22:14:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:14:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:14:43 INFO - Using real prefix '/usr' 22:14:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:14:43 INFO - Installing distribute.............................................................................................................................................................................................done. 22:14:45 INFO - Installing pip.................done. 22:14:45 INFO - Return code: 0 22:14:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:45 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 0x7f552680af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29146d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a3920>, '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 0x29a4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a4cb0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', '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 22:14:45 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 22:14:45 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 22:14:45 INFO - Using env: {'DISPLAY': ':0', 22:14:45 INFO - 'HOME': '/home/cltbld', 22:14:45 INFO - 'LANG': 'en_US.UTF-8', 22:14:45 INFO - 'LANGUAGE': 'en_US:en', 22:14:45 INFO - 'LOGNAME': 'cltbld', 22:14:45 INFO - 'MAIL': '/var/mail/cltbld', 22:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:45 INFO - 'MOZ_NO_REMOTE': '1', 22:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:45 INFO - 'NO_EM_RESTART': '1', 22:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:14:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:14:45 INFO - 'SHELL': '/bin/bash', 22:14:45 INFO - 'SHLVL': '1', 22:14:45 INFO - 'TERM': 'linux', 22:14:45 INFO - 'TMOUT': '86400', 22:14:45 INFO - 'USER': 'cltbld', 22:14:45 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', 22:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:45 INFO - '_': '/tools/buildbot/bin/python'} 22:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:46 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 22:14:46 INFO - Cleaning up... 22:14:46 INFO - Return code: 0 22:14:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:14:46 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')]} 22:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:46 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')]} 22:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:46 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 0x7f552680af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29146d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a3920>, '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 0x29a4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a4cb0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', '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 22:14:46 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 22:14:46 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 22:14:46 INFO - Using env: {'DISPLAY': ':0', 22:14:46 INFO - 'HOME': '/home/cltbld', 22:14:46 INFO - 'LANG': 'en_US.UTF-8', 22:14:46 INFO - 'LANGUAGE': 'en_US:en', 22:14:46 INFO - 'LOGNAME': 'cltbld', 22:14:46 INFO - 'MAIL': '/var/mail/cltbld', 22:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:46 INFO - 'MOZ_NO_REMOTE': '1', 22:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:46 INFO - 'NO_EM_RESTART': '1', 22:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:14:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:14:46 INFO - 'SHELL': '/bin/bash', 22:14:46 INFO - 'SHLVL': '1', 22:14:46 INFO - 'TERM': 'linux', 22:14:46 INFO - 'TMOUT': '86400', 22:14:46 INFO - 'USER': 'cltbld', 22:14:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', 22:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:46 INFO - '_': '/tools/buildbot/bin/python'} 22:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:46 INFO - Downloading/unpacking psutil>=0.7.1 22:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:14:48 INFO - Installing collected packages: psutil 22:14:48 INFO - Running setup.py install for psutil 22:14:48 INFO - building 'psutil._psutil_linux' extension 22:14:48 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 22:14:48 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 22:14:48 INFO - building 'psutil._psutil_posix' extension 22:14:48 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 22:14:48 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 22:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:14:48 INFO - Successfully installed psutil 22:14:48 INFO - Cleaning up... 22:14:49 INFO - Return code: 0 22:14:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f552680af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29146d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a3920>, '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 0x29a4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a4cb0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', '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 22:14:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:14:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:14:49 INFO - Using env: {'DISPLAY': ':0', 22:14:49 INFO - 'HOME': '/home/cltbld', 22:14:49 INFO - 'LANG': 'en_US.UTF-8', 22:14:49 INFO - 'LANGUAGE': 'en_US:en', 22:14:49 INFO - 'LOGNAME': 'cltbld', 22:14:49 INFO - 'MAIL': '/var/mail/cltbld', 22:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:49 INFO - 'MOZ_NO_REMOTE': '1', 22:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:49 INFO - 'NO_EM_RESTART': '1', 22:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:14:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:14:49 INFO - 'SHELL': '/bin/bash', 22:14:49 INFO - 'SHLVL': '1', 22:14:49 INFO - 'TERM': 'linux', 22:14:49 INFO - 'TMOUT': '86400', 22:14:49 INFO - 'USER': 'cltbld', 22:14:49 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', 22:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:49 INFO - '_': '/tools/buildbot/bin/python'} 22:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:14: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 22:14: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 22:14: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 22:14: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 22:14: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 22:14: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 22:14:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:14:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:14:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:14:51 INFO - Installing collected packages: mozsystemmonitor 22:14:51 INFO - Running setup.py install for mozsystemmonitor 22:14:51 INFO - Successfully installed mozsystemmonitor 22:14:51 INFO - Cleaning up... 22:14:51 INFO - Return code: 0 22:14:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f552680af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29146d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a3920>, '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 0x29a4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a4cb0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', '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 22:14:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:14:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:14:51 INFO - Using env: {'DISPLAY': ':0', 22:14:51 INFO - 'HOME': '/home/cltbld', 22:14:51 INFO - 'LANG': 'en_US.UTF-8', 22:14:51 INFO - 'LANGUAGE': 'en_US:en', 22:14:51 INFO - 'LOGNAME': 'cltbld', 22:14:51 INFO - 'MAIL': '/var/mail/cltbld', 22:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:51 INFO - 'MOZ_NO_REMOTE': '1', 22:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:51 INFO - 'NO_EM_RESTART': '1', 22:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:14:51 INFO - 'PWD': '/builds/slave/test-pgo', 22:14:51 INFO - 'SHELL': '/bin/bash', 22:14:51 INFO - 'SHLVL': '1', 22:14:51 INFO - 'TERM': 'linux', 22:14:51 INFO - 'TMOUT': '86400', 22:14:51 INFO - 'USER': 'cltbld', 22:14:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', 22:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:51 INFO - '_': '/tools/buildbot/bin/python'} 22:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:51 INFO - Downloading/unpacking blobuploader==1.2.4 22:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:53 INFO - Downloading blobuploader-1.2.4.tar.gz 22:14:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:14:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:14:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:53 INFO - Downloading docopt-0.6.1.tar.gz 22:14:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:14:54 INFO - Installing collected packages: blobuploader, requests, docopt 22:14:54 INFO - Running setup.py install for blobuploader 22:14:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:14:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:14:54 INFO - Running setup.py install for requests 22:14:54 INFO - Running setup.py install for docopt 22:14:54 INFO - Successfully installed blobuploader requests docopt 22:14:54 INFO - Cleaning up... 22:14:54 INFO - Return code: 0 22:14:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:54 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 0x7f552680af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29146d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a3920>, '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 0x29a4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a4cb0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', '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 22:14:54 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 22:14:54 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 22:14:54 INFO - Using env: {'DISPLAY': ':0', 22:14:54 INFO - 'HOME': '/home/cltbld', 22:14:54 INFO - 'LANG': 'en_US.UTF-8', 22:14:54 INFO - 'LANGUAGE': 'en_US:en', 22:14:54 INFO - 'LOGNAME': 'cltbld', 22:14:54 INFO - 'MAIL': '/var/mail/cltbld', 22:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:54 INFO - 'MOZ_NO_REMOTE': '1', 22:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:54 INFO - 'NO_EM_RESTART': '1', 22:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:14:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:14:54 INFO - 'SHELL': '/bin/bash', 22:14:54 INFO - 'SHLVL': '1', 22:14:54 INFO - 'TERM': 'linux', 22:14:54 INFO - 'TMOUT': '86400', 22:14:54 INFO - 'USER': 'cltbld', 22:14:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', 22:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:54 INFO - '_': '/tools/buildbot/bin/python'} 22:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:14:54 INFO - Running setup.py (path:/tmp/pip-WdWJAe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:14:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:14:54 INFO - Running setup.py (path:/tmp/pip-SSiL66-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:14:55 INFO - Running setup.py (path:/tmp/pip-9Ifx1z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:14:55 INFO - Running setup.py (path:/tmp/pip-b1wGgn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:14:55 INFO - Running setup.py (path:/tmp/pip-CMyJZn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:14:55 INFO - Running setup.py (path:/tmp/pip-0_3aNj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:14:55 INFO - Running setup.py (path:/tmp/pip-5Mb9Z9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:14:55 INFO - Running setup.py (path:/tmp/pip-ZR3Kym-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:14:55 INFO - Running setup.py (path:/tmp/pip-LYYwc9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:14:55 INFO - Running setup.py (path:/tmp/pip-IotsSm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:14:55 INFO - Running setup.py (path:/tmp/pip-mgt6oQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:14:55 INFO - Running setup.py (path:/tmp/pip-rjDm5c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:14:55 INFO - Running setup.py (path:/tmp/pip-dJXf49-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:14:55 INFO - Running setup.py (path:/tmp/pip-ZYE9PH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:14:55 INFO - Running setup.py (path:/tmp/pip-r9LYLr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:14:55 INFO - Running setup.py (path:/tmp/pip-Y1Kskm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:14:56 INFO - Running setup.py (path:/tmp/pip-ZNfobX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:14:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:14:56 INFO - Running setup.py install for manifestparser 22:14:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:14:56 INFO - Running setup.py install for mozcrash 22:14:56 INFO - Running setup.py install for mozdebug 22:14:56 INFO - Running setup.py install for mozdevice 22:14:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:14:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:14:56 INFO - Running setup.py install for mozfile 22:14:56 INFO - Running setup.py install for mozhttpd 22:14:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:14:56 INFO - Running setup.py install for mozinfo 22:14:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:14:56 INFO - Running setup.py install for mozInstall 22:14:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:14:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:14:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:14:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:14:56 INFO - Running setup.py install for mozleak 22:14:56 INFO - Running setup.py install for mozlog 22:14:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:14:57 INFO - Running setup.py install for moznetwork 22:14:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:14:57 INFO - Running setup.py install for mozprocess 22:14:57 INFO - Running setup.py install for mozprofile 22:14:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:14:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:14:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:14:57 INFO - Running setup.py install for mozrunner 22:14:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:14:57 INFO - Running setup.py install for mozscreenshot 22:14:57 INFO - Running setup.py install for moztest 22:14:57 INFO - Running setup.py install for mozversion 22:14:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:14:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:14:57 INFO - Cleaning up... 22:14:57 INFO - Return code: 0 22:14:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:57 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 0x7f552680af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29146d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a3920>, '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 0x29a4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a4cb0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', '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 22:14:57 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 22:14:57 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 22:14:57 INFO - Using env: {'DISPLAY': ':0', 22:14:57 INFO - 'HOME': '/home/cltbld', 22:14:57 INFO - 'LANG': 'en_US.UTF-8', 22:14:57 INFO - 'LANGUAGE': 'en_US:en', 22:14:57 INFO - 'LOGNAME': 'cltbld', 22:14:57 INFO - 'MAIL': '/var/mail/cltbld', 22:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:57 INFO - 'MOZ_NO_REMOTE': '1', 22:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:57 INFO - 'NO_EM_RESTART': '1', 22:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:14:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:14:57 INFO - 'SHELL': '/bin/bash', 22:14:57 INFO - 'SHLVL': '1', 22:14:57 INFO - 'TERM': 'linux', 22:14:57 INFO - 'TMOUT': '86400', 22:14:57 INFO - 'USER': 'cltbld', 22:14:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', 22:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:57 INFO - '_': '/tools/buildbot/bin/python'} 22:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:14:58 INFO - Running setup.py (path:/tmp/pip-wJciDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:14:58 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)) 22:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:14:58 INFO - Running setup.py (path:/tmp/pip-ifqIH_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:14:58 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)) 22:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:14:58 INFO - Running setup.py (path:/tmp/pip-7MKaiB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:14:58 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)) 22:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:14:58 INFO - Running setup.py (path:/tmp/pip-4H7J6M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:14:58 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)) 22:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:14:58 INFO - Running setup.py (path:/tmp/pip-d5OLJV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:14:58 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)) 22:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:14:58 INFO - Running setup.py (path:/tmp/pip-3t1fJR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:14:58 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)) 22:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:14:58 INFO - Running setup.py (path:/tmp/pip-ujn7mg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:14:58 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)) 22:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:14:58 INFO - Running setup.py (path:/tmp/pip-sdfgFy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:14:58 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)) 22:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:14:58 INFO - Running setup.py (path:/tmp/pip-7_CG5R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:14:58 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)) 22:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:14:58 INFO - Running setup.py (path:/tmp/pip-6X0xy4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:14:58 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)) 22:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:14:58 INFO - Running setup.py (path:/tmp/pip-z7KMYY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:14:58 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)) 22:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:14:58 INFO - Running setup.py (path:/tmp/pip-Gf0LG_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:14:58 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)) 22:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:14:58 INFO - Running setup.py (path:/tmp/pip-WHoUuh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:14:59 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)) 22:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:14:59 INFO - Running setup.py (path:/tmp/pip-Enp8fo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:14:59 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)) 22:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:14:59 INFO - Running setup.py (path:/tmp/pip-tI6glf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:14:59 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)) 22:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:14:59 INFO - Running setup.py (path:/tmp/pip-sHauOp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:14:59 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)) 22:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:14:59 INFO - Running setup.py (path:/tmp/pip-0_VoFE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:14:59 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)) 22:14:59 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)) 22:14:59 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)) 22:14:59 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)) 22:14:59 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)) 22:14:59 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)) 22:14:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:01 INFO - Downloading blessings-1.6.tar.gz 22:15:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:15:01 INFO - Installing collected packages: blessings 22:15:01 INFO - Running setup.py install for blessings 22:15:01 INFO - Successfully installed blessings 22:15:01 INFO - Cleaning up... 22:15:01 INFO - Return code: 0 22:15:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:15:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:15:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:15:01 INFO - Reading from file tmpfile_stdout 22:15:01 INFO - Current package versions: 22:15:01 INFO - argparse == 1.2.1 22:15:01 INFO - blessings == 1.6 22:15:01 INFO - blobuploader == 1.2.4 22:15:01 INFO - docopt == 0.6.1 22:15:01 INFO - manifestparser == 1.1 22:15:01 INFO - mozInstall == 1.12 22:15:01 INFO - mozcrash == 0.17 22:15:01 INFO - mozdebug == 0.1 22:15:01 INFO - mozdevice == 0.48 22:15:01 INFO - mozfile == 1.2 22:15:01 INFO - mozhttpd == 0.7 22:15:01 INFO - mozinfo == 0.9 22:15:01 INFO - mozleak == 0.1 22:15:01 INFO - mozlog == 3.1 22:15:01 INFO - moznetwork == 0.27 22:15:01 INFO - mozprocess == 0.22 22:15:01 INFO - mozprofile == 0.28 22:15:01 INFO - mozrunner == 6.11 22:15:01 INFO - mozscreenshot == 0.1 22:15:01 INFO - mozsystemmonitor == 0.0 22:15:01 INFO - moztest == 0.7 22:15:01 INFO - mozversion == 1.4 22:15:01 INFO - psutil == 3.1.1 22:15:01 INFO - requests == 1.2.3 22:15:01 INFO - wsgiref == 0.1.2 22:15:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:15:01 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')]} 22:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:01 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')]} 22:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:01 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 0x7f552680af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29146d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a3920>, '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 0x29a4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a4cb0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', '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 22:15:01 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 22:15:01 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 22:15:01 INFO - Using env: {'DISPLAY': ':0', 22:15:01 INFO - 'HOME': '/home/cltbld', 22:15:01 INFO - 'LANG': 'en_US.UTF-8', 22:15:01 INFO - 'LANGUAGE': 'en_US:en', 22:15:01 INFO - 'LOGNAME': 'cltbld', 22:15:01 INFO - 'MAIL': '/var/mail/cltbld', 22:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:01 INFO - 'MOZ_NO_REMOTE': '1', 22:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:01 INFO - 'NO_EM_RESTART': '1', 22:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:15:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:15:01 INFO - 'SHELL': '/bin/bash', 22:15:01 INFO - 'SHLVL': '1', 22:15:01 INFO - 'TERM': 'linux', 22:15:01 INFO - 'TMOUT': '86400', 22:15:01 INFO - 'USER': 'cltbld', 22:15:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', 22:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:01 INFO - '_': '/tools/buildbot/bin/python'} 22:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:01 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)) 22:15:01 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)) 22:15:01 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)) 22:15:01 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)) 22:15:01 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)) 22:15:01 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)) 22:15:01 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)) 22:15:01 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)) 22:15:01 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)) 22:15:01 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)) 22:15:01 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)) 22:15:01 INFO - Cleaning up... 22:15:01 INFO - Return code: 0 22:15:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:15:01 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')]} 22:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:01 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')]} 22:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:01 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 0x7f552680af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29146d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a3920>, '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 0x29a4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a4cb0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', '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 22:15:01 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 22:15:01 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 22:15:01 INFO - Using env: {'DISPLAY': ':0', 22:15:01 INFO - 'HOME': '/home/cltbld', 22:15:01 INFO - 'LANG': 'en_US.UTF-8', 22:15:01 INFO - 'LANGUAGE': 'en_US:en', 22:15:01 INFO - 'LOGNAME': 'cltbld', 22:15:01 INFO - 'MAIL': '/var/mail/cltbld', 22:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:01 INFO - 'MOZ_NO_REMOTE': '1', 22:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:01 INFO - 'NO_EM_RESTART': '1', 22:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:15:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:15:01 INFO - 'SHELL': '/bin/bash', 22:15:01 INFO - 'SHLVL': '1', 22:15:01 INFO - 'TERM': 'linux', 22:15:01 INFO - 'TMOUT': '86400', 22:15:01 INFO - 'USER': 'cltbld', 22:15:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', 22:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:01 INFO - '_': '/tools/buildbot/bin/python'} 22:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:02 INFO - Downloading/unpacking jsonschema 22:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:15:03 INFO - Downloading/unpacking functools32 (from jsonschema) 22:15:03 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 22:15:03 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 22:15:03 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 22:15:03 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 22:15:03 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 22:15:03 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 22:15:04 INFO - Downloading functools32-3.2.3-2.tar.gz 22:15:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:15:04 INFO - warning: no files found matching '*.txt' 22:15:04 INFO - no previously-included directories found matching 'build' 22:15:04 INFO - no previously-included directories found matching 'dist' 22:15:04 INFO - no previously-included directories found matching '.git*' 22:15:04 INFO - Installing collected packages: jsonschema, functools32 22:15:04 INFO - Running setup.py install for functools32 22:15:04 INFO - warning: no files found matching '*.txt' 22:15:04 INFO - no previously-included directories found matching 'build' 22:15:04 INFO - no previously-included directories found matching 'dist' 22:15:04 INFO - no previously-included directories found matching '.git*' 22:15:04 INFO - Successfully installed jsonschema functools32 22:15:04 INFO - Cleaning up... 22:15:04 INFO - Return code: 0 22:15:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:15:04 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')]} 22:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:04 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')]} 22:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:04 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 0x7f552680af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29146d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a3920>, '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 0x29a4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a4cb0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', '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 22:15:04 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 22:15:04 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 22:15:04 INFO - Using env: {'DISPLAY': ':0', 22:15:04 INFO - 'HOME': '/home/cltbld', 22:15:04 INFO - 'LANG': 'en_US.UTF-8', 22:15:04 INFO - 'LANGUAGE': 'en_US:en', 22:15:04 INFO - 'LOGNAME': 'cltbld', 22:15:04 INFO - 'MAIL': '/var/mail/cltbld', 22:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:04 INFO - 'MOZ_NO_REMOTE': '1', 22:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:04 INFO - 'NO_EM_RESTART': '1', 22:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:15:04 INFO - 'PWD': '/builds/slave/test-pgo', 22:15:04 INFO - 'SHELL': '/bin/bash', 22:15:04 INFO - 'SHLVL': '1', 22:15:04 INFO - 'TERM': 'linux', 22:15:04 INFO - 'TMOUT': '86400', 22:15:04 INFO - 'USER': 'cltbld', 22:15:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', 22:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:04 INFO - '_': '/tools/buildbot/bin/python'} 22:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:04 INFO - Downloading/unpacking flake8 22:15:04 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 22:15:04 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 22:15:04 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 22:15:04 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 22:15:04 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 22:15:04 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 22:15:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:15:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:15:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:15:07 INFO - no previously-included directories found matching 'docs/_build' 22:15:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:15:07 INFO - Running setup.py install for pep8 22:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:15:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:15:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:15:07 INFO - no previously-included directories found matching 'docs/_build' 22:15:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:15:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:15:07 INFO - Cleaning up... 22:15:07 INFO - Return code: 0 22:15:07 INFO - Running post-action listener: _resource_record_post_action 22:15:07 INFO - Running post-action listener: _start_resource_monitoring 22:15:07 INFO - Starting resource monitoring. 22:15:07 INFO - ##### 22:15:07 INFO - ##### Running install step. 22:15:07 INFO - ##### 22:15:07 INFO - Running pre-action listener: _resource_record_pre_action 22:15:07 INFO - Running main action method: install 22:15:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:15:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:15:07 INFO - Reading from file tmpfile_stdout 22:15:07 INFO - Detecting whether we're running mozinstall >=1.0... 22:15:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:15:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:15:07 INFO - Reading from file tmpfile_stdout 22:15:07 INFO - Output received: 22:15:07 INFO - Usage: mozinstall [options] installer 22:15:07 INFO - Options: 22:15:07 INFO - -h, --help show this help message and exit 22:15:07 INFO - -d DEST, --destination=DEST 22:15:07 INFO - Directory to install application into. [default: 22:15:07 INFO - "/builds/slave/test-pgo"] 22:15:07 INFO - --app=APP Application being installed. [default: firefox] 22:15:07 INFO - mkdir: /builds/slave/test-pgo/build/application 22:15:07 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'] 22:15:07 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 22:15:24 INFO - Reading from file tmpfile_stdout 22:15:24 INFO - Output received: 22:15:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:15:24 INFO - Running post-action listener: _resource_record_post_action 22:15:24 INFO - ##### 22:15:24 INFO - ##### Running run-tests step. 22:15:24 INFO - ##### 22:15:24 INFO - Running pre-action listener: _resource_record_pre_action 22:15:24 INFO - Running main action method: run_tests 22:15:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:15:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:15:24 INFO - Python 2.7.3 22:15:24 INFO - Return code: 0 22:15:24 INFO - grabbing minidump binary from tooltool 22:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:24 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 0x29a3920>, '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 0x29a4820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a4cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:15:24 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 22:15:24 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 22:15:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:15:24 INFO - Return code: 0 22:15:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:15:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:15:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:15:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:15:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:15:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:15:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:15:25 INFO - Return code: 0 22:15:25 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/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 22:15:25 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/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 22:15:25 INFO - Using env: {'DISPLAY': ':0', 22:15:25 INFO - 'HOME': '/home/cltbld', 22:15:25 INFO - 'LANG': 'en_US.UTF-8', 22:15:25 INFO - 'LANGUAGE': 'en_US:en', 22:15:25 INFO - 'LOGNAME': 'cltbld', 22:15:25 INFO - 'MAIL': '/var/mail/cltbld', 22:15:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:15:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:25 INFO - 'MOZ_NO_REMOTE': '1', 22:15:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:25 INFO - 'NO_EM_RESTART': '1', 22:15:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:15:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:15:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:15:25 INFO - 'SHELL': '/bin/bash', 22:15:25 INFO - 'SHLVL': '1', 22:15:25 INFO - 'TERM': 'linux', 22:15:25 INFO - 'TMOUT': '86400', 22:15:25 INFO - 'USER': 'cltbld', 22:15:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564', 22:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:25 INFO - '_': '/tools/buildbot/bin/python'} 22:15:25 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/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 22:15:25 INFO - mozversion application_buildid: 20160314193028 22:15:25 INFO - mozversion application_changeset: d6ee82b9a74155b6bfd544166f036fc572ae8c56 22:15:25 INFO - mozversion application_display_name: Nightly 22:15:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:15:25 INFO - mozversion application_name: Firefox 22:15:25 INFO - mozversion application_remotingname: firefox 22:15:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:15:25 INFO - mozversion application_vendor: Mozilla 22:15:25 INFO - mozversion application_version: 48.0a1 22:15:25 INFO - mozversion platform_buildid: 20160314193028 22:15:25 INFO - mozversion platform_changeset: d6ee82b9a74155b6bfd544166f036fc572ae8c56 22:15:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:15:25 INFO - mozversion platform_version: 48.0a1 22:15:25 INFO - using testdate: 1458018925 22:15:25 INFO - actual date: 1458018925 22:15:25 INFO - starting webserver on 'localhost:50564' 22:15:25 INFO - SUITE-START | Running 2 tests 22:15:25 INFO - TEST-START | dromaeo_css 22:15:25 INFO - operating with platform_type : linux_ 22:15:25 INFO - Initialising browser for dromaeo_css test... 22:15:25 INFO - TEST-INFO | started process 21169 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkhYwBp/profile http://localhost:50564/getInfo.html) 22:15:29 INFO - PROCESS | 21169 | __metrics Screen width/height:1600/1200 22:15:29 INFO - PROCESS | 21169 | colorDepth:24 22:15:29 INFO - PROCESS | 21169 | Browser inner width/height: 1024/697 22:15:29 INFO - PROCESS | 21169 | __metrics 22:15:30 ERROR - PROCESS | 21169 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:15:30 INFO - TEST-INFO | 21169: exit 0 22:15:30 INFO - Browser initialized. 22:15:30 INFO - Running cycle 1/1 for dromaeo_css test... 22:15:30 INFO - TEST-INFO | started process 21265 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkhYwBp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:15:42 INFO - PROCESS | 21265 | RSS: Main: 150945792 22:15:42 INFO - PROCESS | 21265 | 22:16:33 INFO - PROCESS | 21265 | 1458018993320 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] 22:18:40 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:50564/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50564/tests/dromaeo/cssquery-ext.html) 22:18:42 INFO - PROCESS | 21265 | RSS: Main: 266121216 22:18:42 INFO - PROCESS | 21265 | 22:21:44 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:50564/tests/dromaeo/cssquery-ext.html (next: http://localhost:50564/tests/dromaeo/cssquery-jquery.html) 22:21:44 INFO - PROCESS | 21265 | RSS: Main: 245903360 22:21:44 INFO - PROCESS | 21265 | 22:24:46 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:50564/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50564/tests/dromaeo/cssquery-mootools.html) 22:24:47 INFO - PROCESS | 21265 | RSS: Main: 245956608 22:24:47 INFO - PROCESS | 21265 | 22:27:49 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:50564/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50564/tests/dromaeo/cssquery-prototype.html) 22:27:49 INFO - PROCESS | 21265 | RSS: Main: 227303424 22:27:49 INFO - PROCESS | 21265 | 22:30:52 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:50564/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50564/tests/dromaeo/cssquery-yui.html) 22:30:52 INFO - PROCESS | 21265 | RSS: Main: 225349632 22:30:52 INFO - PROCESS | 21265 | 22:33:55 INFO - PROCESS | 21265 | Cycle 1(1): loaded http://localhost:50564/tests/dromaeo/cssquery-yui.html (next: http://localhost:50564/tests/dromaeo/cssquery-dojo.html) 22:33:55 INFO - PROCESS | 21265 | RSS: Main: 275177472 22:33:55 INFO - PROCESS | 21265 | 22:33:55 INFO - PROCESS | 21265 | __start_tp_report 22:33:55 INFO - PROCESS | 21265 | _x_x_mozilla_page_load 22:33:55 INFO - PROCESS | 21265 | _x_x_mozilla_page_load_details 22:33:55 INFO - PROCESS | 21265 | |i|pagename|runs| 22:33:55 INFO - PROCESS | 21265 | |0;dojo.html;3065.4788685923395;3092.6907309269063;3132.5771020912184;3139.4035133324664;3150.921226969325;5262.552683021938;5319.468053194679;5339.252504649343;5354.170103633938;5380.838574842756;5357;5370.865728356793;5377.784888604451;5390.21841832934;5397.217403476494;4774.069056533977;4834.4923783002805;4902.8038878444995;4914;4952.108620448318;4823.5176482351835;4829.4446138693975;4876.487968763282;4879.926801097987;4901.901961960759;4797.664163508556;4804.399450068759;4812.711237325754;4829.1790395632825;4834.444038935532;4783.378160839104;4795.232762757942;4802.951970480285;4829.7102173869325;4871.732054736988;4743.928841067353;4788.281757736333;4809;4816.710997340136;4818.132736107499;5155.149400348938;5191.377034755816;5192.584593232532;5214.504622060898;5216.113260745682;5625.774969001235;5628.746706398181;5630.408807075239;5632.464915832989;5679.261695979538;5804.680742559158;5805.448482394166;5811.27359080115;5849.064149736022;5851.297844258716;5337.759800808934;5375.5162035417;5390.73046347685;5391.514763671288;5394.703291318976;5771.740271687784;5835.35811060783;5839.182514447981;5912.940870591325;5921.881562368814;5656.349519805192;5657.377688454267;5660.943390566124;5668.688222147739;5717.771289148471;5712.171735098471;5722.513586345124;5732.828015159552;5747.281589801275;5750.856228594235;5539.224508568804;5658.490735833795;5694.857628559236;5710.71446427677;5713.028785106542;5758.90580789657;5759.395263497272;5764;5764.279465066867;5787.826365209051;4356.3683265926265;4357.782110894506;4374.606285434326;4374.759388233614;4415.27148020573;3788;3833.597472265372;3870.651641352292;3910.2961466936226;3916.784576848244;5405.8107966221;5409.24270602116;5419.403865574784;5420.07858664028;5421.186821976735;5757.193992841006;5782.595218334676;5784.942150578525;5824.912626310609;5834.124881267844;5282.656627319288;5362.436944120889;5381.9461805382225;5440.319960004999;5449.100898351728;4785.712857228577;4793.089313030513;4796.640251981045;4812.302216178635;4845.830395936126;5824.388439213822;5892.469677729025;5892.6759028253;5896.7936122235515;5898.557608179318;5681.119426488818;5747.827565173052;5774.105013722879;5785.623934444247;5792.913106303325;5912.674802885883;5921;5921.644701317935;5931.703414829328;5946.316173640087;5580.832575022756;5608.887822243614;5642.689652069175;5654.491095801398;5662.518685911744;5692.686902220252;5701.971490142523;5706.429357064427;5711.942880571141;5751.3673495916255;5388;5563.944360556343;5564.19319198722;5565.30433695788;5572.721363931706;5516.696581688046;5535.482583092157;5540.916886246629;5545.500904918576;5587.55299576041;5473.425290344616;5475.808346707846;5484.780608775604;5487.176923461353;5534.91697624544;5544.22380866687;5596.300462442195;5596.664200147841;5609.803656872153;5614.129809879475;5395.055865223649;5476.452354764491;5494.148406996922;5511.614187007031;5562.9721851392105 22:33:55 INFO - PROCESS | 21265 | |1;ext.html;562.2830890614468;563.0877977676165;563.9904570818236;585.9677717725523;599.9820005399839;30730.38539229217;31211.219719507022;37990.240195196115;39021.41467877984;39034.4144837827;41389.37915931264;41722.79138604303;41725.37411938823;41765.79117104418;41826.79086604563;8521.616527256288;8727.04002559718;8735.868961965576;8736.21374076333;8745.300375969908;8405.285550728195;8584.141585841397;8591.957040214791;8598;8600.397972141953;8844.336674749387;8952.507612081334;8957.238634716057;8957.95521022394;8959.462432254053;8723.25852302555;8811.60347784348;8821.691240806605;8830.86753698695;8833.11668833118;8797.560121993874;8922.86615700765;8945.821083578292;8947.150020748019;8948.955255223747;40778;41250.38124428136;41259.381109283386;41270.58729412698;41275;3369.9831500842583;3750.7562008469636;3766.077311058808;3829.5213098362706;4022.939655905164;31648.683513165033;32184.839075804706;32636.836815816005;32639.51040734391;32743.6725632743;4200.432941552882;4279.358096285551;4309.956900430987;4332.67504937131;4385.342198670193;321696;322065;322189;322669;322875.9999999977;59135.704321478115;59272;59675.701621491615;59685.70157149187;59743;55830.44169558334;63317.68341158265;63693;63693.36306636874;63755.36244637587;16361.509154725378;16623.91688041552;16716;16726.24731887068;16735.832641673427;12328.383580820922;12390.504379824886;12400.503979840885;12416.689582760504;12417.31704756229;17122.14389280531;19372;19393.843129858105;19410.5147371314;20083.598328033357;7164.570125792469;7283.927160728431;7452.552846829208;7565.356944659656;7608.277213664693;1027.8612387327764;1053.710229686827;1080.713610893114;1111.1388673777888;1121.6747143328507;29672.258193545335;29894.85052574723;29928.551071733942;30316.5452518208;30418.54372184419;1184.8933595976403;1199.7780410624061;1209.0629761934572;1218.8635538919498;1297.3124244150615;16861.237191049135;16871.91564042172;16918.492445226664;16938.576535586708;17128.914355428144;425765;428092;428777;429309;429703;55614.44385556092;56582;56826.43173568294;57049.429505704415;57056;1367.4803574641574;1381.2265131526378;1393.958181254564;1403.3754979034231;1405.156905856478;30101.434797950362;31552.684473154975;31704.841475792473;31769.77611567168;32256.193595160308;49690;49956.750216248685;50016.249756254416;50111.49888501068;50125;393604;394108;394326;394834;395223;29600;35247.82376088103;35763.284734304645;36150.457743133346;36269.455958161176;41071.17857642771;42182.578174219096;42332;42756.1448771029;42808.5719142817;37609.247815042996;38037.61962380341;38556.03609909775;38730;38951;37348.81325593355;38222.617773821905;38626.80686596549;38895.41656875092;39394;38979.2204155921;39438.408423873094;39575;40077.398839018024;40113.598864010986;33814;34383.828080859435;34538.30923381468;35399.46900796542;35502.20720202843;26576.8671156643;26594;26680.59979100354;27023.59464607993;27120.1863944082 22:33:55 INFO - PROCESS | 21265 | |2;jquery.html;359.4643980469101;370.268719279423;375.57747534024213;383.8044491409261;387.3956627660851;17309;18136.637267254664;19706.408807735756;19990.800091999077;20076.498087547818;18258.634827303445;18361.173747181376;19232.903835480804;19233.23067077315;19248.807511924875;5547.11246200608;5715.228444160048;5718.056520674084;5721.856953576153;5757.568182386317;4143.958560414402;5632.239647647556;5902.763889444417;6234.625922444668;6257.843553911166;6190.3500132486115;6196.411340922605;6202.255729312466;6214.192155019841;6221.284552276478;6044.516438684895;6114.541409394291;6192.566520343577;6192.8451788705415;6192.969035154841;3717.070732316921;5286.709230992294;5450.29146210994;5492.6268432891775;5496.0931446311315;21526.354209373745;21853.235136770294;22116.778832211632;22190.112395504162;22382.664260036112;2676.625272461857;2720.2111387697546;2758.3242105684035;2764.5991331257055;3084.2135255509925;13658.726825463535;13785.655358616015;13892.16647001183;13893.930530347283;13985.930070349685;1919.4145785535407;1926.3450426854797;1946.834519065881;1951.0829909942304;1954.3159894037115;72326.63836680783;72846.271537285;74064.62967685181;74257.25742742557;74408.69891263593;10240.590376385011;10456;10592.523336449878;10629.149668026539;10836.0789332906;13651;13662.726745465035;13798.862011379959;13821;13828.170309781446;7790.5325680459355;8001.239882211181;8001.719939802079;8077.676892924217;8116.228958248957;7755.650995705094;7802.726904558427;7898.842023159505;7915.891775151484;7923.564203968837;6326.2724786649205;6440.967795160994;6446.290908000116;6477.190351206099;6506.3493650634555;1709;1774.9378771742927;1800.7478952946599;1836.5985080126843;1847.5473508990383;989.6585677941099;1023.1814548361281;1027.8466612446912;1077.5420446310286;1150.4592841364545;18254.908725456287;18296.045513245546;18303.633927321644;18676.906615466836;18970.525736856413;1033.679559336608;1059.2902755154066;1068.6580294305902;1087.9456027198607;1118.59730497021;10759.892401076046;11051.557937682563;11054.502547385388;11059.281146725438;11068.612598559012;508372;521361;525807;530854;538921;75022;75131;75294.62352688202;75444;76270.61864690752;1052.884182739898;1066.157735389034;1092.6721983404946;1121.7268400365645;1125.2460851229696;16646.417375391804;16777.664446710754;16845.66308673795;16860.831391686417;16884.493465196065;36173.63826361808;36184.63815361813;36764.63235367612;37114.62885371112;37569.43645845369;49512.75243623759;50258.497415026846;50366.49633503618;50402.2439663398;50471.24293135532;8319.376046796635;8325.292350150305;8344.541050242295;8382.958085209535;8476.449030812977;11807.055435565306;12484.12611117213;12500.687482813002;12673.429695663901;12786.936065319614;10227.59089636436;11137.888621113685;11637.359945202756;11700.590479333183;11897.40512974365;10708.678739637824;11001.394923279297;11141;11212.943935280598;11563.88436115628;10328.431936243278;10696;10976.835347469634;11483;11859;7577.507462014952;7714.652840622073;7772.572508512086;7918.960405197937;7954.363650908029;10417.427041512487;10574.2598018138;10687.091597214323;10847;10955.34267943926 22:33:55 INFO - PROCESS | 21265 | |3;mootools.html;1340.5576159867244;1514.8939574229805;1518.309169327956;1722.5349155727954;1875.0437276988732;7839.960800195998;8041.19588041197;8057.113717491078;8059.798505037377;8065.233802788733;7877.724279650213;8084;8094.878576821337;8106.878396824038;8107.310878575328;2105.663093904968;2348.659444380564;2392.892319845607;2403.098837935774;2420.6732091167733;2382.9880850595723;2388.5700573896693;2392.067093833398;2392.1627430399394;2393.44950661348;2295.6097463431256;2359.929202123939;2362.6337917622795;2362.9054837806466;2363.1847012780563;2352.5882970480184;2363.314638754759;2421.87890605469;2422.8909699063584;2424.2121310574134;2349.6475528670667;2378.9524209515885;2384.6899903012495;2391.270662447953;2394.31761947844;8223.671053157866;8274.172582741678;8276.917230827736;8282.668693252263;8288.751337459886;5151.304573882516;5218.373795144569;5229.5293423591675;5248.685078895279;5268.762905669254;3258.7393008559256;3273.852676629557;3351.6815902489225;3397.371486275047;3403.4724617684296;1087.445402844555;1114.2116506490522;1121.6354684727496;1159.1074872348245;1186.9406529673481;11584.884151158549;11641;11644.359560224184;11663;11673.766524669543;4635.887387027089;4766.308885211694;4799.904001920012;4809.44691360498;4809.615230781529;9722.222222222346;9727.07592778685;9733.805323893483;9744.951275243578;9755.658551950648;4761.761911904391;5292.153255479182;5297.841064768063;5303.549198318186;5306.97346513265;4657.4876763555985;4725.10223057618;4740.478547359788;4763.499832517536;4769;4009.979950100231;4061.1268577256033;4062.3297155969526;4090.427340172378;4091.7135800494275;1296.293520031585;1300.63582196985;1307.3267267357319;1309.0967232609469;1312.875276848698;1397.3711829676686;1422.502124256502;1451.6153219396867;1461.035716427153;1462.8756555692673;7960.044794624682;8057.395695322874;8071.515709057476;8102.230288122619;8121.959390203129;492.1043700465119;495.23238979581504;496.8633625752947;498.2750098606591;508.16660676490585;6261.186045814106;6272.8118156455375;6272.843178920472;6278.215223097113;6308.27454842699;9313.48775817323;9500.904990950141;9542.141207291377;9630.662926797528;9660;9283.39657922233;9492.335536512515;9505.66730164441;9521.381110227812;9549.236061115094;7746.070471543451;7921.247481489249;7932.841343173104;8006.519608823489;8007.439479236397;7844.980152580128;7872.2914937653595;7969.442139050211;7989.680412783424;8006.879896801436;8833.33749968742;9156.130167634064;9244.768880777765;9245.352825302434;9350.67272645454;9368.57841397125;9427.387219830689;9445.669401570913;9449.102335278138;9552.90447095548;6738.191417029988;7110.431165506644;7235.855282894207;7521.210272921265;7627.046619172604;7882.132965373919;7891.131975482807;7905;7917.960410198142;7928.246816552418;6843.486738494533;6984.231734509099;7001.334873187039;7079.610621415872;7091.042709234187;6875.346842049998;6890.655467226518;6920.861582768417;6921.377076063179;6955.478339124485;7429.851402972018;7486.588237646982;7695.6921723130445;7696.422768292512;7736.8452630948195;6724.697388617426;6732.225794033749;6747.190337159573;6767.120274364301;6791.049253104668;7058.329458701415;7063.611501367474;7136.6788494518905;7149.356557909813;7162.856742865218 22:33:55 INFO - PROCESS | 21265 | |4;prototype.html;348.8866118511484;349.69227080169446;351.169484169938;355.4934218738301;359.1864427072681;5932.525397968163;5980.850478738033;5990.4309090636425;5995.910061349078;6002.849928751783;5872.148538461921;5969.761209551623;5978.820635380935;6002;6012.128241404994;4428.1807865544815;4512.826665067089;4553.453585569736;4558.2251017327135;4640.698354606957;4622.39908811854;4641.9535804641855;4652.209124448835;4659.370984917026;4660.207764679995;4599.2871104978785;4609.9308510372375;4610.608098311647;4622.745748983804;4624.514425985273;4373.737575745449;4486.910261794746;4543.954560454386;4607.14767767964;4617.399738034034;4067.3085575452246;4069.2878746219294;4074.124063326399;4074.368472886678;4080.306347920831;5735.541156707453;5736.512396446307;5742.511886489653;5745.138229265602;5747.971260143714;5388.622796404254;5394.083005889008;5397.568194544427;5404.675719456806;5414.756335964852;6347.936520634827;6355.428011478989;6356.491480681534;6357.682115894233;6371.139896114011;4297.140571885604;4444.533324000966;4451.532589078165;4453.398791163217;4548.454185497729;6573.539852210347;6613.173353330833;6645.136132302818;6654.168228971379;6661.467082633426;4530.433695788027;4540.160070386989;4540.455145382509;4542.091581683677;4545.250033744462;4580.358749775034;4593.012502312019;4601.4248218972625;4601.930971035437;4608.147492713859;5293.788248470095;5303.946960530346;5308.469153084738;5312.814051508179;5324.5740340772645;6271.763274674088;6331.145295385064;6394.200724909387;6401.743930242738;6440;1583.6120150562956;1586.952391428259;1591.912444815523;1594.4499147793993;1599.1844159478517;1025.3950169400089;1056.8626078609732;1075.3601607043952;1082.377632861108;1098.1708809848512;6075.088736689444;6086.3000754913755;6090.847728806815;6091.329953705177;6092.664903430354;6507.577007494498;6516.0877477153235;6533.967330163318;6534.542582019213;6540.2805691373915;6084.361142080106;6089.238845144357;6090.36051214625;6093.146959425684;6097.054956481752;3477.982610086984;3508.754387192872;3514.876979305712;3516.771409858351;3519.3137338218803;6615.239247486505;6730.293319201512;6875.3812156906115;6879.484038697117;6879.828004299832;6757.8648427031185;6775.864482710318;6776.186857577122;6785;6792.626405547742;6829.795106146824;6852.760153394607;6854.8004099282425;6858.348456896587;6860.5197636164985;6614.90077648826;6634.867302653824;6635.270120286861;6644.468442524683;6644.468442524683;6309.085182648582;6471.708773105127;6539.247986481425;6554.868902621825;6556.18047744032;6859.622720750406;6872.175338959357;6873;6873.931260687529;6876.793696189123;4520.32195170727;4569.657275704269;4570.223062079388;4570.7943142558;4576.336431217522;6625.17185351831;6634.303398143318;6639.037339585637;6646.169228846395;6650;6347.206599175103;6400.9039864403;6464.321246269262;6475.708593113227;6478.70845811949;6383.0744542042075;6399.456046236122;6404.967975160094;6409.839754006187;6422.486201103807;6292.874142517033;6307.400796924285;6314.810555683337;6320.683965801783;6323.968380158254;6440.935590644033;6444.871102578016;6447.9355206447335;6449.6130232186215;6456.7740129095255;5999.91000135007;6097.634141951497;6133.570650054453;6298.527610429144;6306.65313407767 22:33:55 INFO - PROCESS | 21265 | |5;yui.html;779.4388040610762;819.9016118065829;864.3258258558327;878.88820641888;898.5282726568553;12829;12899.54851580195;13016.544420945269;13043.673908152301;13072.281024543647;13214.07501474897;13228.801567976465;13384.866151338483;13390.464381424756;13442.050902619114;697.5396238482602;709.2234003765868;844.8943882014748;856.1353033436212;857.1214505132242;856.8372009318241;862.1507814802414;862.2067697718114;862.6764963138822;862.8619420892659;877.6664867350398;878.8286284174588;880.2210044110976;880.6169316347377;881.1276835932413;733.4938892164416;872.8559787635032;876.7150676030316;877.3156937588691;893.758685155011;653.5621133840339;654.1202083198091;654.8722999015193;655.1450357283791;655.9344065593402;13554.728905421836;13648.93175534116;13650.453981840814;13663.658408539766;13687.041907066508;12662.176958497668;12874.356282185854;13078.476860925552;13315.40080696371;13351.265680387673;10849.349039057603;10878.72803179919;11043.392613406259;11126.61056863014;11169.776604467947;3835.9424608630893;3861.1891502784447;3861.7296789224765;3891.5913829047827;4472.127935052666;54357;54473.45526544763;54493.72753136209;54684;54731;10850.67447976562;11103.111751059896;11294.60468883585;11308.943455282835;11330.886691133148;20627;20850.374488765363;20864.687029694567;20901.059452324684;20908.79091209099;8074.757757267292;8259.628316725762;8439.198276163756;8659.956700216459;8706.912930870736;4642.5821676048645;4702.31816386622;4950.579200767975;4964.453910069889;5007.298978143063;3523.806190659487;3539.3983022886173;3547.3614749345365;3555.982220088883;3565.857365705395;583.4457265597699;644.5005121031238;674.1472037872096;678.1556961582861;697.6372286411038;627.1658693937053;643.8969764837603;684.4114061906756;697.4350775871459;701.2987012987013;9100.499472529074;9233.169014788567;9301.860472092923;9365.765855853659;9377.1091746284;729.6862349189793;743.8363560016787;747.3012733094574;778.3189709004621;783.134636226961;4566.1552612766745;4735.431748190239;4802.087603355351;4887.828925987645;4957.281194226817;61564;62486.375136248964;62588;71273.64363178254;71629.64185179041;52604;53091;55616.72191639016;61170.38829611647;61451.38548614546;51690.22464663033;53206.73396632992;53764;53797.46202538003;53993.730031349594;9271.629134834531;9369.06309369085;9501;9530.857037144588;9567.9043209567;37503;38395.6160438392;38554.80722596369;39079.804600976815;41419;50188.247176291654;50495.74752126363;51947.74026129845;52134.21798673099;52632.210516841515;12239.32683702405;12329.691757706129;12353.258804471761;12564.183328083645;12606.873931260938;13281.734365312446;13578.25319607431;13698.38357273945;13917.095388799695;14153.504627337994;12013.75972480528;12456.626301210978;12557.744225577735;12711.80932286035;13105;12345.753084938431;12414.937925310316;12466;12504.312262825631;12833.358332083546;12376.257424554555;12381.690457738629;12474.126811123135;12619.873801262238;13412.195268283935;10909.945450272699;10920.726981825517;11044.779104417707;11059;11367.431628418712;10577.62978295756;10626.468676565986;10665.200109991936;10725;10754 22:33:55 INFO - PROCESS | 21265 | __end_tp_report 22:33:55 INFO - PROCESS | 21265 | __start_cc_report 22:33:55 INFO - PROCESS | 21265 | _x_x_mozilla_cycle_collect,840 22:33:55 INFO - PROCESS | 21265 | __end_cc_report 22:33:55 INFO - PROCESS | 21265 | __startTimestamp1458020035505__endTimestamp 22:33:55 INFO - PROCESS | 21265 | 22:33:55 INFO - PROCESS | 21265 | ------- Summary: start ------- 22:33:55 INFO - PROCESS | 21265 | Number of tests: 6 22:33:55 INFO - PROCESS | 21265 | 22:33:55 INFO - PROCESS | 21265 | [#0] dojo.html Cycles:165 Average:5300.44 Median:5494.15 stddev:610.39 (11.1%) stddev-sans-first:586.54 22:33:55 INFO - PROCESS | 21265 | Values: 3065.5 3092.7 3132.6 3139.4 3150.9 5262.6 5319.5 5339.3 5354.2 5380.8 5357.0 5370.9 5377.8 5390.2 5397.2 4774.1 4834.5 4902.8 4914.0 4952.1 4823.5 4829.4 4876.5 4879.9 4901.9 4797.7 4804.4 4812.7 4829.2 4834.4 4783.4 4795.2 4803.0 4829.7 4871.7 4743.9 4788.3 4809.0 4816.7 4818.1 5155.1 5191.4 5192.6 5214.5 5216.1 5625.8 5628.7 5630.4 5632.5 5679.3 5804.7 5805.4 5811.3 5849.1 5851.3 5337.8 5375.5 5390.7 5391.5 5394.7 5771.7 5835.4 5839.2 5912.9 5921.9 5656.3 5657.4 5660.9 5668.7 5717.8 5712.2 5722.5 5732.8 5747.3 5750.9 5539.2 5658.5 5694.9 5710.7 5713.0 5758.9 5759.4 5764.0 5764.3 5787.8 4356.4 4357.8 4374.6 4374.8 4415.3 3788.0 3833.6 3870.7 3910.3 3916.8 5405.8 5409.2 5419.4 5420.1 5421.2 5757.2 5782.6 5784.9 5824.9 5834.1 5282.7 5362.4 5381.9 5440.3 5449.1 4785.7 4793.1 4796.6 4812.3 4845.8 5824.4 5892.5 5892.7 5896.8 5898.6 5681.1 5747.8 5774.1 5785.6 5792.9 5912.7 5921.0 5921.6 5931.7 5946.3 5580.8 5608.9 5642.7 5654.5 5662.5 5692.7 5702.0 5706.4 5711.9 5751.4 5388.0 5563.9 5564.2 5565.3 5572.7 5516.7 5535.5 5540.9 5545.5 5587.6 5473.4 5475.8 5484.8 5487.2 5534.9 5544.2 5596.3 5596.7 5609.8 5614.1 5395.1 5476.5 5494.1 5511.6 5563.0 22:33:55 INFO - PROCESS | 21265 | 22:33:55 INFO - PROCESS | 21265 | [#1] ext.html Cycles:180 Average:54697.37 Median:216751.00 stddev:101244.84 (46.7%) stddev-sans-first:101447.27 22:33:55 INFO - PROCESS | 21265 | Values: 562.3 563.1 564.0 586.0 600.0 30730.4 31211.2 37990.2 39021.4 39034.4 41389.4 41722.8 41725.4 41765.8 41826.8 8521.6 8727.0 8735.9 8736.2 8745.3 8405.3 8584.1 8592.0 8598.0 8600.4 8844.3 8952.5 8957.2 8958.0 8959.5 8723.3 8811.6 8821.7 8830.9 8833.1 8797.6 8922.9 8945.8 8947.2 8949.0 40778.0 41250.4 41259.4 41270.6 41275.0 3370.0 3750.8 3766.1 3829.5 4022.9 31648.7 32184.8 32636.8 32639.5 32743.7 4200.4 4279.4 4310.0 4332.7 4385.3 321696.0 322065.0 322189.0 322669.0 322876.0 59135.7 59272.0 59675.7 59685.7 59743.0 55830.4 63317.7 63693.0 63693.4 63755.4 16361.5 16623.9 16716.0 16726.2 16735.8 12328.4 12390.5 12400.5 12416.7 12417.3 17122.1 19372.0 19393.8 19410.5 20083.6 7164.6 7283.9 7452.6 7565.4 7608.3 1027.9 1053.7 1080.7 1111.1 1121.7 29672.3 29894.9 29928.6 30316.5 30418.5 1184.9 1199.8 1209.1 1218.9 1297.3 16861.2 16871.9 16918.5 16938.6 17128.9 425765.0 428092.0 428777.0 429309.0 429703.0 55614.4 56582.0 56826.4 57049.4 57056.0 1367.5 1381.2 1394.0 1403.4 1405.2 30101.4 31552.7 31704.8 31769.8 32256.2 49690.0 49956.8 50016.2 50111.5 50125.0 393604.0 394108.0 394326.0 394834.0 395223.0 29600.0 35247.8 35763.3 36150.5 36269.5 41071.2 42182.6 42332.0 42756.1 42808.6 37609.2 38037.6 38556.0 38730.0 38951.0 37348.8 38222.6 38626.8 38895.4 39394.0 38979.2 39438.4 39575.0 40077.4 40113.6 33814.0 34383.8 34538.3 35399.5 35502.2 26576.9 26594.0 26680.6 27023.6 27120.2 22:33:55 INFO - PROCESS | 21265 | 22:33:55 INFO - PROCESS | 21265 | [#2] jquery.html Cycles:180 Average:28872.88 Median:21985.01 stddev:85927.73 (390.8%) stddev-sans-first:86142.11 22:33:55 INFO - PROCESS | 21265 | Values: 359.5 370.3 375.6 383.8 387.4 17309.0 18136.6 19706.4 19990.8 20076.5 18258.6 18361.2 19232.9 19233.2 19248.8 5547.1 5715.2 5718.1 5721.9 5757.6 4144.0 5632.2 5902.8 6234.6 6257.8 6190.4 6196.4 6202.3 6214.2 6221.3 6044.5 6114.5 6192.6 6192.8 6193.0 3717.1 5286.7 5450.3 5492.6 5496.1 21526.4 21853.2 22116.8 22190.1 22382.7 2676.6 2720.2 2758.3 2764.6 3084.2 13658.7 13785.7 13892.2 13893.9 13985.9 1919.4 1926.3 1946.8 1951.1 1954.3 72326.6 72846.3 74064.6 74257.3 74408.7 10240.6 10456.0 10592.5 10629.1 10836.1 13651.0 13662.7 13798.9 13821.0 13828.2 7790.5 8001.2 8001.7 8077.7 8116.2 7755.7 7802.7 7898.8 7915.9 7923.6 6326.3 6441.0 6446.3 6477.2 6506.3 1709.0 1774.9 1800.7 1836.6 1847.5 989.7 1023.2 1027.8 1077.5 1150.5 18254.9 18296.0 18303.6 18676.9 18970.5 1033.7 1059.3 1068.7 1087.9 1118.6 10759.9 11051.6 11054.5 11059.3 11068.6 508372.0 521361.0 525807.0 530854.0 538921.0 75022.0 75131.0 75294.6 75444.0 76270.6 1052.9 1066.2 1092.7 1121.7 1125.2 16646.4 16777.7 16845.7 16860.8 16884.5 36173.6 36184.6 36764.6 37114.6 37569.4 49512.8 50258.5 50366.5 50402.2 50471.2 8319.4 8325.3 8344.5 8383.0 8476.4 11807.1 12484.1 12500.7 12673.4 12786.9 10227.6 11137.9 11637.4 11700.6 11897.4 10708.7 11001.4 11141.0 11212.9 11563.9 10328.4 10696.0 10976.8 11483.0 11859.0 7577.5 7714.7 7772.6 7919.0 7954.4 10417.4 10574.3 10687.1 10847.0 10955.3 22:33:55 INFO - PROCESS | 21265 | 22:33:55 INFO - PROCESS | 21265 | [#3] mootools.html Cycles:180 Average:5811.14 Median:6728.46 stddev:3013.90 (44.8%) stddev-sans-first:3003.62 22:33:55 INFO - PROCESS | 21265 | Values: 1340.6 1514.9 1518.3 1722.5 1875.0 7840.0 8041.2 8057.1 8059.8 8065.2 7877.7 8084.0 8094.9 8106.9 8107.3 2105.7 2348.7 2392.9 2403.1 2420.7 2383.0 2388.6 2392.1 2392.2 2393.4 2295.6 2359.9 2362.6 2362.9 2363.2 2352.6 2363.3 2421.9 2422.9 2424.2 2349.6 2379.0 2384.7 2391.3 2394.3 8223.7 8274.2 8276.9 8282.7 8288.8 5151.3 5218.4 5229.5 5248.7 5268.8 3258.7 3273.9 3351.7 3397.4 3403.5 1087.4 1114.2 1121.6 1159.1 1186.9 11584.9 11641.0 11644.4 11663.0 11673.8 4635.9 4766.3 4799.9 4809.4 4809.6 9722.2 9727.1 9733.8 9745.0 9755.7 4761.8 5292.2 5297.8 5303.5 5307.0 4657.5 4725.1 4740.5 4763.5 4769.0 4010.0 4061.1 4062.3 4090.4 4091.7 1296.3 1300.6 1307.3 1309.1 1312.9 1397.4 1422.5 1451.6 1461.0 1462.9 7960.0 8057.4 8071.5 8102.2 8122.0 492.1 495.2 496.9 498.3 508.2 6261.2 6272.8 6272.8 6278.2 6308.3 9313.5 9500.9 9542.1 9630.7 9660.0 9283.4 9492.3 9505.7 9521.4 9549.2 7746.1 7921.2 7932.8 8006.5 8007.4 7845.0 7872.3 7969.4 7989.7 8006.9 8833.3 9156.1 9244.8 9245.4 9350.7 9368.6 9427.4 9445.7 9449.1 9552.9 6738.2 7110.4 7235.9 7521.2 7627.0 7882.1 7891.1 7905.0 7918.0 7928.2 6843.5 6984.2 7001.3 7079.6 7091.0 6875.3 6890.7 6920.9 6921.4 6955.5 7429.9 7486.6 7695.7 7696.4 7736.8 6724.7 6732.2 6747.2 6767.1 6791.0 7058.3 7063.6 7136.7 7149.4 7162.9 22:33:55 INFO - PROCESS | 21265 | 22:33:55 INFO - PROCESS | 21265 | [#4] prototype.html Cycles:180 Average:5342.56 Median:6043.61 stddev:1612.29 (26.7%) stddev-sans-first:1572.64 22:33:55 INFO - PROCESS | 21265 | Values: 348.9 349.7 351.2 355.5 359.2 5932.5 5980.9 5990.4 5995.9 6002.8 5872.1 5969.8 5978.8 6002.0 6012.1 4428.2 4512.8 4553.5 4558.2 4640.7 4622.4 4642.0 4652.2 4659.4 4660.2 4599.3 4609.9 4610.6 4622.7 4624.5 4373.7 4486.9 4544.0 4607.1 4617.4 4067.3 4069.3 4074.1 4074.4 4080.3 5735.5 5736.5 5742.5 5745.1 5748.0 5388.6 5394.1 5397.6 5404.7 5414.8 6347.9 6355.4 6356.5 6357.7 6371.1 4297.1 4444.5 4451.5 4453.4 4548.5 6573.5 6613.2 6645.1 6654.2 6661.5 4530.4 4540.2 4540.5 4542.1 4545.3 4580.4 4593.0 4601.4 4601.9 4608.1 5293.8 5303.9 5308.5 5312.8 5324.6 6271.8 6331.1 6394.2 6401.7 6440.0 1583.6 1587.0 1591.9 1594.4 1599.2 1025.4 1056.9 1075.4 1082.4 1098.2 6075.1 6086.3 6090.8 6091.3 6092.7 6507.6 6516.1 6534.0 6534.5 6540.3 6084.4 6089.2 6090.4 6093.1 6097.1 3478.0 3508.8 3514.9 3516.8 3519.3 6615.2 6730.3 6875.4 6879.5 6879.8 6757.9 6775.9 6776.2 6785.0 6792.6 6829.8 6852.8 6854.8 6858.3 6860.5 6614.9 6634.9 6635.3 6644.5 6644.5 6309.1 6471.7 6539.2 6554.9 6556.2 6859.6 6872.2 6873.0 6873.9 6876.8 4520.3 4569.7 4570.2 4570.8 4576.3 6625.2 6634.3 6639.0 6646.2 6650.0 6347.2 6400.9 6464.3 6475.7 6478.7 6383.1 6399.5 6405.0 6409.8 6422.5 6292.9 6307.4 6314.8 6320.7 6324.0 6440.9 6444.9 6447.9 6449.6 6456.8 5999.9 6097.6 6133.6 6298.5 6306.7 22:33:55 INFO - PROCESS | 21265 | 22:33:55 INFO - PROCESS | 21265 | [#5] yui.html Cycles:180 Average:15387.01 Median:4919.20 stddev:18180.83 (369.6%) stddev-sans-first:18198.73 22:33:55 INFO - PROCESS | 21265 | Values: 779.4 819.9 864.3 878.9 898.5 12829.0 12899.5 13016.5 13043.7 13072.3 13214.1 13228.8 13384.9 13390.5 13442.1 697.5 709.2 844.9 856.1 857.1 856.8 862.2 862.2 862.7 862.9 877.7 878.8 880.2 880.6 881.1 733.5 872.9 876.7 877.3 893.8 653.6 654.1 654.9 655.1 655.9 13554.7 13648.9 13650.5 13663.7 13687.0 12662.2 12874.4 13078.5 13315.4 13351.3 10849.3 10878.7 11043.4 11126.6 11169.8 3835.9 3861.2 3861.7 3891.6 4472.1 54357.0 54473.5 54493.7 54684.0 54731.0 10850.7 11103.1 11294.6 11308.9 11330.9 20627.0 20850.4 20864.7 20901.1 20908.8 8074.8 8259.6 8439.2 8660.0 8706.9 4642.6 4702.3 4950.6 4964.5 5007.3 3523.8 3539.4 3547.4 3556.0 3565.9 583.4 644.5 674.1 678.2 697.6 627.2 643.9 684.4 697.4 701.3 9100.5 9233.2 9301.9 9365.8 9377.1 729.7 743.8 747.3 778.3 783.1 4566.2 4735.4 4802.1 4887.8 4957.3 61564.0 62486.4 62588.0 71273.6 71629.6 52604.0 53091.0 55616.7 61170.4 61451.4 51690.2 53206.7 53764.0 53797.5 53993.7 9271.6 9369.1 9501.0 9530.9 9567.9 37503.0 38395.6 38554.8 39079.8 41419.0 50188.2 50495.7 51947.7 52134.2 52632.2 12239.3 12329.7 12353.3 12564.2 12606.9 13281.7 13578.3 13698.4 13917.1 14153.5 12013.8 12456.6 12557.7 12711.8 13105.0 12345.8 12414.9 12466.0 12504.3 12833.4 12376.3 12381.7 12474.1 12619.9 13412.2 10909.9 10920.7 11044.8 11059.0 11367.4 10577.6 10626.5 10665.2 10725.0 10754.0 22:33:55 INFO - PROCESS | 21265 | -------- Summary: end -------- 22:33:55 INFO - PROCESS | 21265 | 22:33:56 INFO - TEST-INFO | 21265: exit 0 22:33:56 INFO - TEST-OK | dromaeo_css | took 1110843ms 22:33:56 INFO - TEST-START | kraken 22:33:56 INFO - operating with platform_type : linux_ 22:33:56 INFO - Initialising browser for kraken test... 22:33:56 INFO - TEST-INFO | started process 21447 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvlOowW/profile http://localhost:50564/getInfo.html) 22:34:00 INFO - PROCESS | 21447 | __metrics Screen width/height:1600/1200 22:34:00 INFO - PROCESS | 21447 | colorDepth:24 22:34:00 INFO - PROCESS | 21447 | Browser inner width/height: 1024/697 22:34:00 INFO - PROCESS | 21447 | __metrics 22:34:00 ERROR - PROCESS | 21447 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:34:00 INFO - PROCESS | 21447 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:34:01 INFO - TEST-INFO | 21447: exit 0 22:34:01 INFO - Browser initialized. 22:34:01 INFO - Running cycle 1/1 for kraken test... 22:34:01 INFO - TEST-INFO | started process 21529 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvlOowW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:34:13 INFO - PROCESS | 21529 | RSS: Main: 153001984 22:34:13 INFO - PROCESS | 21529 | 22:34:15 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50564/tests/kraken/driver.html?testName=audio-beat-detection) 22:34:16 INFO - PROCESS | 21529 | RSS: Main: 193220608 22:34:16 INFO - PROCESS | 21529 | 22:34:19 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50564/tests/kraken/driver.html?testName=audio-dft) 22:34:19 INFO - PROCESS | 21529 | RSS: Main: 183001088 22:34:19 INFO - PROCESS | 21529 | 22:34:25 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50564/tests/kraken/driver.html?testName=audio-fft) 22:34:25 INFO - PROCESS | 21529 | RSS: Main: 170921984 22:34:25 INFO - PROCESS | 21529 | 22:34:27 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50564/tests/kraken/driver.html?testName=audio-oscillator) 22:34:28 INFO - PROCESS | 21529 | RSS: Main: 173641728 22:34:28 INFO - PROCESS | 21529 | 22:34:30 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50564/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:34:30 INFO - PROCESS | 21529 | RSS: Main: 173314048 22:34:30 INFO - PROCESS | 21529 | 22:34:34 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50564/tests/kraken/driver.html?testName=imaging-darkroom) 22:34:34 INFO - PROCESS | 21529 | RSS: Main: 175190016 22:34:34 INFO - PROCESS | 21529 | 22:34:38 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50564/tests/kraken/driver.html?testName=imaging-desaturate) 22:34:39 INFO - PROCESS | 21529 | RSS: Main: 173895680 22:34:39 INFO - PROCESS | 21529 | 22:34:41 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50564/tests/kraken/driver.html?testName=json-parse-financial) 22:34:42 INFO - PROCESS | 21529 | RSS: Main: 174612480 22:34:42 INFO - PROCESS | 21529 | 22:34:43 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50564/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:34:44 INFO - PROCESS | 21529 | RSS: Main: 188694528 22:34:44 INFO - PROCESS | 21529 | 22:34:46 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:34:46 INFO - PROCESS | 21529 | RSS: Main: 182910976 22:34:46 INFO - PROCESS | 21529 | 22:34:48 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:34:49 INFO - PROCESS | 21529 | RSS: Main: 193302528 22:34:49 INFO - PROCESS | 21529 | 22:34:51 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:34:52 INFO - PROCESS | 21529 | RSS: Main: 198963200 22:34:52 INFO - PROCESS | 21529 | 22:34:54 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:34:55 INFO - PROCESS | 21529 | RSS: Main: 199159808 22:34:55 INFO - PROCESS | 21529 | 22:34:56 INFO - PROCESS | 21529 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50564/tests/kraken/driver.html?testName=ai-astar) 22:34:57 INFO - PROCESS | 21529 | RSS: Main: 259600384 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | __start_tp_report 22:34:57 INFO - PROCESS | 21529 | _x_x_mozilla_page_load 22:34:57 INFO - PROCESS | 21529 | _x_x_mozilla_page_load_details 22:34:57 INFO - PROCESS | 21529 | |i|pagename|runs| 22:34:57 INFO - PROCESS | 21529 | |0;ai-astar;108;108;103;109;111;111;98;108;110;109 22:34:57 INFO - PROCESS | 21529 | |1;audio-beat-detection;156;131;152;167;124;152;151;126;173;128 22:34:57 INFO - PROCESS | 21529 | |2;audio-dft;378;377;380;378;377;378;378;375;375;378 22:34:57 INFO - PROCESS | 21529 | |3;audio-fft;74;74;73;150;75;75;73;72;159;72 22:34:57 INFO - PROCESS | 21529 | |4;audio-oscillator;92;93;137;92;92;93;142;92;94;142 22:34:57 INFO - PROCESS | 21529 | |5;imaging-gaussian-blur;125;116;117;116;117;117;116;117;117;117 22:34:57 INFO - PROCESS | 21529 | |6;imaging-darkroom;193;192;194;194;192;193;193;193;192;192 22:34:57 INFO - PROCESS | 21529 | |7;imaging-desaturate;95;95;95;95;96;96;96;95;95;96 22:34:57 INFO - PROCESS | 21529 | |8;json-parse-financial;57;55;55;56;55;55;58;61;56;57 22:34:57 INFO - PROCESS | 21529 | |9;json-stringify-tinderbox;59;60;59;60;60;60;59;60;60;60 22:34:57 INFO - PROCESS | 21529 | |10;stanford-crypto-aes;78;78;80;81;79;78;78;77;89;83 22:34:57 INFO - PROCESS | 21529 | |11;stanford-crypto-ccm;115;108;115;108;108;109;112;108;118;107 22:34:57 INFO - PROCESS | 21529 | |12;stanford-crypto-pbkdf2;138;146;136;135;135;147;135;135;138;135 22:34:57 INFO - PROCESS | 21529 | |13;stanford-crypto-sha256-iterative;64;66;63;62;63;63;62;63;61;62 22:34:57 INFO - PROCESS | 21529 | __end_tp_report 22:34:57 INFO - PROCESS | 21529 | __start_cc_report 22:34:57 INFO - PROCESS | 21529 | _x_x_mozilla_cycle_collect,1030 22:34:57 INFO - PROCESS | 21529 | __end_cc_report 22:34:57 INFO - PROCESS | 21529 | __startTimestamp1458020097250__endTimestamp 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | ------- Summary: start ------- 22:34:57 INFO - PROCESS | 21529 | Number of tests: 14 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#0] ai-astar Cycles:10 Average:107.50 Median:109.50 stddev:4.03 (3.7%) stddev-sans-first:4.28 22:34:57 INFO - PROCESS | 21529 | Values: 108.0 108.0 103.0 109.0 111.0 111.0 98.0 108.0 110.0 109.0 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:152.00 stddev:17.64 (11.6%) stddev-sans-first:18.33 22:34:57 INFO - PROCESS | 21529 | Values: 156.0 131.0 152.0 167.0 124.0 152.0 151.0 126.0 173.0 128.0 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#2] audio-dft Cycles:10 Average:377.40 Median:378.00 stddev:1.51 (0.4%) stddev-sans-first:1.58 22:34:57 INFO - PROCESS | 21529 | Values: 378.0 377.0 380.0 378.0 377.0 378.0 378.0 375.0 375.0 378.0 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#3] audio-fft Cycles:10 Average:89.70 Median:73.50 stddev:34.23 (46.6%) stddev-sans-first:35.84 22:34:57 INFO - PROCESS | 21529 | Values: 74.0 74.0 73.0 150.0 75.0 75.0 73.0 72.0 159.0 72.0 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#4] audio-oscillator Cycles:10 Average:106.90 Median:92.00 stddev:23.12 (25.1%) stddev-sans-first:23.89 22:34:57 INFO - PROCESS | 21529 | Values: 92.0 93.0 137.0 92.0 92.0 93.0 142.0 92.0 94.0 142.0 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:2.68 (2.3%) stddev-sans-first:0.50 22:34:57 INFO - PROCESS | 21529 | Values: 125.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#6] imaging-darkroom Cycles:10 Average:192.80 Median:193.00 stddev:0.79 (0.4%) stddev-sans-first:0.83 22:34:57 INFO - PROCESS | 21529 | Values: 193.0 192.0 194.0 194.0 192.0 193.0 193.0 193.0 192.0 192.0 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:34:57 INFO - PROCESS | 21529 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.50 stddev:1.90 (3.4%) stddev-sans-first:2.01 22:34:57 INFO - PROCESS | 21529 | Values: 57.0 55.0 55.0 56.0 55.0 55.0 58.0 61.0 56.0 57.0 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 22:34:57 INFO - PROCESS | 21529 | Values: 59.0 60.0 59.0 60.0 60.0 60.0 59.0 60.0 60.0 60.0 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.50 stddev:3.60 (4.5%) stddev-sans-first:3.74 22:34:57 INFO - PROCESS | 21529 | Values: 78.0 78.0 80.0 81.0 79.0 78.0 78.0 77.0 89.0 83.0 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#11] stanford-crypto-ccm Cycles:10 Average:110.80 Median:110.50 stddev:3.91 (3.5%) stddev-sans-first:3.84 22:34:57 INFO - PROCESS | 21529 | Values: 115.0 108.0 115.0 108.0 108.0 109.0 112.0 108.0 118.0 107.0 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.00 Median:137.00 stddev:4.64 (3.4%) stddev-sans-first:4.92 22:34:57 INFO - PROCESS | 21529 | Values: 138.0 146.0 136.0 135.0 135.0 147.0 135.0 135.0 138.0 135.0 22:34:57 INFO - PROCESS | 21529 | 22:34:57 INFO - PROCESS | 21529 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.37 (2.2%) stddev-sans-first:1.39 22:34:57 INFO - PROCESS | 21529 | Values: 64.0 66.0 63.0 62.0 63.0 63.0 62.0 63.0 61.0 62.0 22:34:57 INFO - PROCESS | 21529 | -------- Summary: end -------- 22:34:57 INFO - PROCESS | 21529 | 22:34:58 INFO - TEST-INFO | 21529: exit 0 22:34:58 INFO - TEST-OK | kraken | took 62045ms 22:34:58 INFO - SUITE-END | took 1172s 22:34:58 INFO - Completed test suite (00:19:33) 22:34:58 INFO - javascript benchmark 22:34:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3065.4788685923395, 3092.6907309269063, 3132.5771020912184, 3139.4035133324664, 3150.921226969325, 5262.552683021938, 5319.468053194679, 5339.252504649343, 5354.170103633938, 5380.838574842756, 5357.0, 5370.865728356793, 5377.784888604451, 5390.21841832934, 5397.217403476494, 4774.069056533977, 4834.4923783002805, 4902.8038878444995, 4914.0, 4952.108620448318, 4823.5176482351835, 4829.4446138693975, 4876.487968763282, 4879.926801097987, 4901.901961960759, 4797.664163508556, 4804.399450068759, 4812.711237325754, 4829.1790395632825, 4834.444038935532, 4783.378160839104, 4795.232762757942, 4802.951970480285, 4829.7102173869325, 4871.732054736988, 4743.928841067353, 4788.281757736333, 4809.0, 4816.710997340136, 4818.132736107499, 5155.149400348938, 5191.377034755816, 5192.584593232532, 5214.504622060898, 5216.113260745682, 5625.774969001235, 5628.746706398181, 5630.408807075239, 5632.464915832989, 5679.261695979538, 5804.680742559158, 5805.448482394166, 5811.27359080115, 5849.064149736022, 5851.297844258716, 5337.759800808934, 5375.5162035417, 5390.73046347685, 5391.514763671288, 5394.703291318976, 5771.740271687784, 5835.35811060783, 5839.182514447981, 5912.940870591325, 5921.881562368814, 5656.349519805192, 5657.377688454267, 5660.943390566124, 5668.688222147739, 5717.771289148471, 5712.171735098471, 5722.513586345124, 5732.828015159552, 5747.281589801275, 5750.856228594235, 5539.224508568804, 5658.490735833795, 5694.857628559236, 5710.71446427677, 5713.028785106542, 5758.90580789657, 5759.395263497272, 5764.0, 5764.279465066867, 5787.826365209051, 4356.3683265926265, 4357.782110894506, 4374.606285434326, 4374.759388233614, 4415.27148020573, 3788.0, 3833.597472265372, 3870.651641352292, 3910.2961466936226, 3916.784576848244, 5405.8107966221, 5409.24270602116, 5419.403865574784, 5420.07858664028, 5421.186821976735, 5757.193992841006, 5782.595218334676, 5784.942150578525, 5824.912626310609, 5834.124881267844, 5282.656627319288, 5362.436944120889, 5381.9461805382225, 5440.319960004999, 5449.100898351728, 4785.712857228577, 4793.089313030513, 4796.640251981045, 4812.302216178635, 4845.830395936126, 5824.388439213822, 5892.469677729025, 5892.6759028253, 5896.7936122235515, 5898.557608179318, 5681.119426488818, 5747.827565173052, 5774.105013722879, 5785.623934444247, 5792.913106303325, 5912.674802885883, 5921.0, 5921.644701317935, 5931.703414829328, 5946.316173640087, 5580.832575022756, 5608.887822243614, 5642.689652069175, 5654.491095801398, 5662.518685911744, 5692.686902220252, 5701.971490142523, 5706.429357064427, 5711.942880571141, 5751.3673495916255, 5388.0, 5563.944360556343, 5564.19319198722, 5565.30433695788, 5572.721363931706, 5516.696581688046, 5535.482583092157, 5540.916886246629, 5545.500904918576, 5587.55299576041, 5473.425290344616, 5475.808346707846, 5484.780608775604, 5487.176923461353, 5534.91697624544, 5544.22380866687, 5596.300462442195, 5596.664200147841, 5609.803656872153, 5614.129809879475, 5395.055865223649, 5476.452354764491, 5494.148406996922, 5511.614187007031, 5562.9721851392105], "unit": "score", "name": "dojo.html", "value": 5258.8850759637535}, {"lowerIsBetter": false, "replicates": [562.2830890614468, 563.0877977676165, 563.9904570818236, 585.9677717725523, 599.9820005399839, 30730.38539229217, 31211.219719507022, 37990.240195196115, 39021.41467877984, 39034.4144837827, 41389.37915931264, 41722.79138604303, 41725.37411938823, 41765.79117104418, 41826.79086604563, 8521.616527256288, 8727.04002559718, 8735.868961965576, 8736.21374076333, 8745.300375969908, 8405.285550728195, 8584.141585841397, 8591.957040214791, 8598.0, 8600.397972141953, 8844.336674749387, 8952.507612081334, 8957.238634716057, 8957.95521022394, 8959.462432254053, 8723.25852302555, 8811.60347784348, 8821.691240806605, 8830.86753698695, 8833.11668833118, 8797.560121993874, 8922.86615700765, 8945.821083578292, 8947.150020748019, 8948.955255223747, 40778.0, 41250.38124428136, 41259.381109283386, 41270.58729412698, 41275.0, 3369.9831500842583, 3750.7562008469636, 3766.077311058808, 3829.5213098362706, 4022.939655905164, 31648.683513165033, 32184.839075804706, 32636.836815816005, 32639.51040734391, 32743.6725632743, 4200.432941552882, 4279.358096285551, 4309.956900430987, 4332.67504937131, 4385.342198670193, 321696.0, 322065.0, 322189.0, 322669.0, 322875.9999999977, 59135.704321478115, 59272.0, 59675.701621491615, 59685.70157149187, 59743.0, 55830.44169558334, 63317.68341158265, 63693.0, 63693.36306636874, 63755.36244637587, 16361.509154725378, 16623.91688041552, 16716.0, 16726.24731887068, 16735.832641673427, 12328.383580820922, 12390.504379824886, 12400.503979840885, 12416.689582760504, 12417.31704756229, 17122.14389280531, 19372.0, 19393.843129858105, 19410.5147371314, 20083.598328033357, 7164.570125792469, 7283.927160728431, 7452.552846829208, 7565.356944659656, 7608.277213664693, 1027.8612387327764, 1053.710229686827, 1080.713610893114, 1111.1388673777888, 1121.6747143328507, 29672.258193545335, 29894.85052574723, 29928.551071733942, 30316.5452518208, 30418.54372184419, 1184.8933595976403, 1199.7780410624061, 1209.0629761934572, 1218.8635538919498, 1297.3124244150615, 16861.237191049135, 16871.91564042172, 16918.492445226664, 16938.576535586708, 17128.914355428144, 425765.0, 428092.0, 428777.0, 429309.0, 429703.0, 55614.44385556092, 56582.0, 56826.43173568294, 57049.429505704415, 57056.0, 1367.4803574641574, 1381.2265131526378, 1393.958181254564, 1403.3754979034231, 1405.156905856478, 30101.434797950362, 31552.684473154975, 31704.841475792473, 31769.77611567168, 32256.193595160308, 49690.0, 49956.750216248685, 50016.249756254416, 50111.49888501068, 50125.0, 393604.0, 394108.0, 394326.0, 394834.0, 395223.0, 29600.0, 35247.82376088103, 35763.284734304645, 36150.457743133346, 36269.455958161176, 41071.17857642771, 42182.578174219096, 42332.0, 42756.1448771029, 42808.5719142817, 37609.247815042996, 38037.61962380341, 38556.03609909775, 38730.0, 38951.0, 37348.81325593355, 38222.617773821905, 38626.80686596549, 38895.41656875092, 39394.0, 38979.2204155921, 39438.408423873094, 39575.0, 40077.398839018024, 40113.598864010986, 33814.0, 34383.828080859435, 34538.30923381468, 35399.46900796542, 35502.20720202843, 26576.8671156643, 26594.0, 26680.59979100354, 27023.59464607993, 27120.1863944082], "unit": "score", "name": "ext.html", "value": 19662.78787007759}, {"lowerIsBetter": false, "replicates": [359.4643980469101, 370.268719279423, 375.57747534024213, 383.8044491409261, 387.3956627660851, 17309.0, 18136.637267254664, 19706.408807735756, 19990.800091999077, 20076.498087547818, 18258.634827303445, 18361.173747181376, 19232.903835480804, 19233.23067077315, 19248.807511924875, 5547.11246200608, 5715.228444160048, 5718.056520674084, 5721.856953576153, 5757.568182386317, 4143.958560414402, 5632.239647647556, 5902.763889444417, 6234.625922444668, 6257.843553911166, 6190.3500132486115, 6196.411340922605, 6202.255729312466, 6214.192155019841, 6221.284552276478, 6044.516438684895, 6114.541409394291, 6192.566520343577, 6192.8451788705415, 6192.969035154841, 3717.070732316921, 5286.709230992294, 5450.29146210994, 5492.6268432891775, 5496.0931446311315, 21526.354209373745, 21853.235136770294, 22116.778832211632, 22190.112395504162, 22382.664260036112, 2676.625272461857, 2720.2111387697546, 2758.3242105684035, 2764.5991331257055, 3084.2135255509925, 13658.726825463535, 13785.655358616015, 13892.16647001183, 13893.930530347283, 13985.930070349685, 1919.4145785535407, 1926.3450426854797, 1946.834519065881, 1951.0829909942304, 1954.3159894037115, 72326.63836680783, 72846.271537285, 74064.62967685181, 74257.25742742557, 74408.69891263593, 10240.590376385011, 10456.0, 10592.523336449878, 10629.149668026539, 10836.0789332906, 13651.0, 13662.726745465035, 13798.862011379959, 13821.0, 13828.170309781446, 7790.5325680459355, 8001.239882211181, 8001.719939802079, 8077.676892924217, 8116.228958248957, 7755.650995705094, 7802.726904558427, 7898.842023159505, 7915.891775151484, 7923.564203968837, 6326.2724786649205, 6440.967795160994, 6446.290908000116, 6477.190351206099, 6506.3493650634555, 1709.0, 1774.9378771742927, 1800.7478952946599, 1836.5985080126843, 1847.5473508990383, 989.6585677941099, 1023.1814548361281, 1027.8466612446912, 1077.5420446310286, 1150.4592841364545, 18254.908725456287, 18296.045513245546, 18303.633927321644, 18676.906615466836, 18970.525736856413, 1033.679559336608, 1059.2902755154066, 1068.6580294305902, 1087.9456027198607, 1118.59730497021, 10759.892401076046, 11051.557937682563, 11054.502547385388, 11059.281146725438, 11068.612598559012, 508372.0, 521361.0, 525807.0, 530854.0, 538921.0, 75022.0, 75131.0, 75294.62352688202, 75444.0, 76270.61864690752, 1052.884182739898, 1066.157735389034, 1092.6721983404946, 1121.7268400365645, 1125.2460851229696, 16646.417375391804, 16777.664446710754, 16845.66308673795, 16860.831391686417, 16884.493465196065, 36173.63826361808, 36184.63815361813, 36764.63235367612, 37114.62885371112, 37569.43645845369, 49512.75243623759, 50258.497415026846, 50366.49633503618, 50402.2439663398, 50471.24293135532, 8319.376046796635, 8325.292350150305, 8344.541050242295, 8382.958085209535, 8476.449030812977, 11807.055435565306, 12484.12611117213, 12500.687482813002, 12673.429695663901, 12786.936065319614, 10227.59089636436, 11137.888621113685, 11637.359945202756, 11700.590479333183, 11897.40512974365, 10708.678739637824, 11001.394923279297, 11141.0, 11212.943935280598, 11563.88436115628, 10328.431936243278, 10696.0, 10976.835347469634, 11483.0, 11859.0, 7577.507462014952, 7714.652840622073, 7772.572508512086, 7918.960405197937, 7954.363650908029, 10417.427041512487, 10574.2598018138, 10687.091597214323, 10847.0, 10955.34267943926], "unit": "score", "name": "jquery.html", "value": 9147.57103777375}, {"lowerIsBetter": false, "replicates": [1340.5576159867244, 1514.8939574229805, 1518.309169327956, 1722.5349155727954, 1875.0437276988732, 7839.960800195998, 8041.19588041197, 8057.113717491078, 8059.798505037377, 8065.233802788733, 7877.724279650213, 8084.0, 8094.878576821337, 8106.878396824038, 8107.310878575328, 2105.663093904968, 2348.659444380564, 2392.892319845607, 2403.098837935774, 2420.6732091167733, 2382.9880850595723, 2388.5700573896693, 2392.067093833398, 2392.1627430399394, 2393.44950661348, 2295.6097463431256, 2359.929202123939, 2362.6337917622795, 2362.9054837806466, 2363.1847012780563, 2352.5882970480184, 2363.314638754759, 2421.87890605469, 2422.8909699063584, 2424.2121310574134, 2349.6475528670667, 2378.9524209515885, 2384.6899903012495, 2391.270662447953, 2394.31761947844, 8223.671053157866, 8274.172582741678, 8276.917230827736, 8282.668693252263, 8288.751337459886, 5151.304573882516, 5218.373795144569, 5229.5293423591675, 5248.685078895279, 5268.762905669254, 3258.7393008559256, 3273.852676629557, 3351.6815902489225, 3397.371486275047, 3403.4724617684296, 1087.445402844555, 1114.2116506490522, 1121.6354684727496, 1159.1074872348245, 1186.9406529673481, 11584.884151158549, 11641.0, 11644.359560224184, 11663.0, 11673.766524669543, 4635.887387027089, 4766.308885211694, 4799.904001920012, 4809.44691360498, 4809.615230781529, 9722.222222222346, 9727.07592778685, 9733.805323893483, 9744.951275243578, 9755.658551950648, 4761.761911904391, 5292.153255479182, 5297.841064768063, 5303.549198318186, 5306.97346513265, 4657.4876763555985, 4725.10223057618, 4740.478547359788, 4763.499832517536, 4769.0, 4009.979950100231, 4061.1268577256033, 4062.3297155969526, 4090.427340172378, 4091.7135800494275, 1296.293520031585, 1300.63582196985, 1307.3267267357319, 1309.0967232609469, 1312.875276848698, 1397.3711829676686, 1422.502124256502, 1451.6153219396867, 1461.035716427153, 1462.8756555692673, 7960.044794624682, 8057.395695322874, 8071.515709057476, 8102.230288122619, 8121.959390203129, 492.1043700465119, 495.23238979581504, 496.8633625752947, 498.2750098606591, 508.16660676490585, 6261.186045814106, 6272.8118156455375, 6272.843178920472, 6278.215223097113, 6308.27454842699, 9313.48775817323, 9500.904990950141, 9542.141207291377, 9630.662926797528, 9660.0, 9283.39657922233, 9492.335536512515, 9505.66730164441, 9521.381110227812, 9549.236061115094, 7746.070471543451, 7921.247481489249, 7932.841343173104, 8006.519608823489, 8007.439479236397, 7844.980152580128, 7872.2914937653595, 7969.442139050211, 7989.680412783424, 8006.879896801436, 8833.33749968742, 9156.130167634064, 9244.768880777765, 9245.352825302434, 9350.67272645454, 9368.57841397125, 9427.387219830689, 9445.669401570913, 9449.102335278138, 9552.90447095548, 6738.191417029988, 7110.431165506644, 7235.855282894207, 7521.210272921265, 7627.046619172604, 7882.132965373919, 7891.131975482807, 7905.0, 7917.960410198142, 7928.246816552418, 6843.486738494533, 6984.231734509099, 7001.334873187039, 7079.610621415872, 7091.042709234187, 6875.346842049998, 6890.655467226518, 6920.861582768417, 6921.377076063179, 6955.478339124485, 7429.851402972018, 7486.588237646982, 7695.6921723130445, 7696.422768292512, 7736.8452630948195, 6724.697388617426, 6732.225794033749, 6747.190337159573, 6767.120274364301, 6791.049253104668, 7058.329458701415, 7063.611501367474, 7136.6788494518905, 7149.356557909813, 7162.856742865218], "unit": "score", "name": "mootools.html", "value": 4702.833701279183}, {"lowerIsBetter": false, "replicates": [348.8866118511484, 349.69227080169446, 351.169484169938, 355.4934218738301, 359.1864427072681, 5932.525397968163, 5980.850478738033, 5990.4309090636425, 5995.910061349078, 6002.849928751783, 5872.148538461921, 5969.761209551623, 5978.820635380935, 6002.0, 6012.128241404994, 4428.1807865544815, 4512.826665067089, 4553.453585569736, 4558.2251017327135, 4640.698354606957, 4622.39908811854, 4641.9535804641855, 4652.209124448835, 4659.370984917026, 4660.207764679995, 4599.2871104978785, 4609.9308510372375, 4610.608098311647, 4622.745748983804, 4624.514425985273, 4373.737575745449, 4486.910261794746, 4543.954560454386, 4607.14767767964, 4617.399738034034, 4067.3085575452246, 4069.2878746219294, 4074.124063326399, 4074.368472886678, 4080.306347920831, 5735.541156707453, 5736.512396446307, 5742.511886489653, 5745.138229265602, 5747.971260143714, 5388.622796404254, 5394.083005889008, 5397.568194544427, 5404.675719456806, 5414.756335964852, 6347.936520634827, 6355.428011478989, 6356.491480681534, 6357.682115894233, 6371.139896114011, 4297.140571885604, 4444.533324000966, 4451.532589078165, 4453.398791163217, 4548.454185497729, 6573.539852210347, 6613.173353330833, 6645.136132302818, 6654.168228971379, 6661.467082633426, 4530.433695788027, 4540.160070386989, 4540.455145382509, 4542.091581683677, 4545.250033744462, 4580.358749775034, 4593.012502312019, 4601.4248218972625, 4601.930971035437, 4608.147492713859, 5293.788248470095, 5303.946960530346, 5308.469153084738, 5312.814051508179, 5324.5740340772645, 6271.763274674088, 6331.145295385064, 6394.200724909387, 6401.743930242738, 6440.0, 1583.6120150562956, 1586.952391428259, 1591.912444815523, 1594.4499147793993, 1599.1844159478517, 1025.3950169400089, 1056.8626078609732, 1075.3601607043952, 1082.377632861108, 1098.1708809848512, 6075.088736689444, 6086.3000754913755, 6090.847728806815, 6091.329953705177, 6092.664903430354, 6507.577007494498, 6516.0877477153235, 6533.967330163318, 6534.542582019213, 6540.2805691373915, 6084.361142080106, 6089.238845144357, 6090.36051214625, 6093.146959425684, 6097.054956481752, 3477.982610086984, 3508.754387192872, 3514.876979305712, 3516.771409858351, 3519.3137338218803, 6615.239247486505, 6730.293319201512, 6875.3812156906115, 6879.484038697117, 6879.828004299832, 6757.8648427031185, 6775.864482710318, 6776.186857577122, 6785.0, 6792.626405547742, 6829.795106146824, 6852.760153394607, 6854.8004099282425, 6858.348456896587, 6860.5197636164985, 6614.90077648826, 6634.867302653824, 6635.270120286861, 6644.468442524683, 6644.468442524683, 6309.085182648582, 6471.708773105127, 6539.247986481425, 6554.868902621825, 6556.18047744032, 6859.622720750406, 6872.175338959357, 6873.0, 6873.931260687529, 6876.793696189123, 4520.32195170727, 4569.657275704269, 4570.223062079388, 4570.7943142558, 4576.336431217522, 6625.17185351831, 6634.303398143318, 6639.037339585637, 6646.169228846395, 6650.0, 6347.206599175103, 6400.9039864403, 6464.321246269262, 6475.708593113227, 6478.70845811949, 6383.0744542042075, 6399.456046236122, 6404.967975160094, 6409.839754006187, 6422.486201103807, 6292.874142517033, 6307.400796924285, 6314.810555683337, 6320.683965801783, 6323.968380158254, 6440.935590644033, 6444.871102578016, 6447.9355206447335, 6449.6130232186215, 6456.7740129095255, 5999.91000135007, 6097.634141951497, 6133.570650054453, 6298.527610429144, 6306.65313407767], "unit": "score", "name": "prototype.html", "value": 4820.633508752954}, {"lowerIsBetter": false, "replicates": [779.4388040610762, 819.9016118065829, 864.3258258558327, 878.88820641888, 898.5282726568553, 12829.0, 12899.54851580195, 13016.544420945269, 13043.673908152301, 13072.281024543647, 13214.07501474897, 13228.801567976465, 13384.866151338483, 13390.464381424756, 13442.050902619114, 697.5396238482602, 709.2234003765868, 844.8943882014748, 856.1353033436212, 857.1214505132242, 856.8372009318241, 862.1507814802414, 862.2067697718114, 862.6764963138822, 862.8619420892659, 877.6664867350398, 878.8286284174588, 880.2210044110976, 880.6169316347377, 881.1276835932413, 733.4938892164416, 872.8559787635032, 876.7150676030316, 877.3156937588691, 893.758685155011, 653.5621133840339, 654.1202083198091, 654.8722999015193, 655.1450357283791, 655.9344065593402, 13554.728905421836, 13648.93175534116, 13650.453981840814, 13663.658408539766, 13687.041907066508, 12662.176958497668, 12874.356282185854, 13078.476860925552, 13315.40080696371, 13351.265680387673, 10849.349039057603, 10878.72803179919, 11043.392613406259, 11126.61056863014, 11169.776604467947, 3835.9424608630893, 3861.1891502784447, 3861.7296789224765, 3891.5913829047827, 4472.127935052666, 54357.0, 54473.45526544763, 54493.72753136209, 54684.0, 54731.0, 10850.67447976562, 11103.111751059896, 11294.60468883585, 11308.943455282835, 11330.886691133148, 20627.0, 20850.374488765363, 20864.687029694567, 20901.059452324684, 20908.79091209099, 8074.757757267292, 8259.628316725762, 8439.198276163756, 8659.956700216459, 8706.912930870736, 4642.5821676048645, 4702.31816386622, 4950.579200767975, 4964.453910069889, 5007.298978143063, 3523.806190659487, 3539.3983022886173, 3547.3614749345365, 3555.982220088883, 3565.857365705395, 583.4457265597699, 644.5005121031238, 674.1472037872096, 678.1556961582861, 697.6372286411038, 627.1658693937053, 643.8969764837603, 684.4114061906756, 697.4350775871459, 701.2987012987013, 9100.499472529074, 9233.169014788567, 9301.860472092923, 9365.765855853659, 9377.1091746284, 729.6862349189793, 743.8363560016787, 747.3012733094574, 778.3189709004621, 783.134636226961, 4566.1552612766745, 4735.431748190239, 4802.087603355351, 4887.828925987645, 4957.281194226817, 61564.0, 62486.375136248964, 62588.0, 71273.64363178254, 71629.64185179041, 52604.0, 53091.0, 55616.72191639016, 61170.38829611647, 61451.38548614546, 51690.22464663033, 53206.73396632992, 53764.0, 53797.46202538003, 53993.730031349594, 9271.629134834531, 9369.06309369085, 9501.0, 9530.857037144588, 9567.9043209567, 37503.0, 38395.6160438392, 38554.80722596369, 39079.804600976815, 41419.0, 50188.247176291654, 50495.74752126363, 51947.74026129845, 52134.21798673099, 52632.210516841515, 12239.32683702405, 12329.691757706129, 12353.258804471761, 12564.183328083645, 12606.873931260938, 13281.734365312446, 13578.25319607431, 13698.38357273945, 13917.095388799695, 14153.504627337994, 12013.75972480528, 12456.626301210978, 12557.744225577735, 12711.80932286035, 13105.0, 12345.753084938431, 12414.937925310316, 12466.0, 12504.312262825631, 12833.358332083546, 12376.257424554555, 12381.690457738629, 12474.126811123135, 12619.873801262238, 13412.195268283935, 10909.945450272699, 10920.726981825517, 11044.779104417707, 11059.0, 11367.431628418712, 10577.62978295756, 10626.468676565986, 10665.200109991936, 10725.0, 10754.0], "unit": "score", "name": "yui.html", "value": 6902.060579365414}], "name": "dromaeo_css", "value": 7273.12495088055}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 108.0, 103.0, 109.0, 111.0, 111.0, 98.0, 108.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.5}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 152.0, 167.0, 124.0, 152.0, 151.0, 126.0, 173.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [378.0, 377.0, 380.0, 378.0, 377.0, 378.0, 378.0, 375.0, 375.0, 378.0], "unit": "score", "name": "audio-dft", "value": 377.4}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 73.0, 150.0, 75.0, 75.0, 73.0, 72.0, 159.0, 72.0], "unit": "score", "name": "audio-fft", "value": 89.7}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 137.0, 92.0, 92.0, 93.0, 142.0, 92.0, 94.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [125.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [193.0, 192.0, 194.0, 194.0, 192.0, 193.0, 193.0, 193.0, 192.0, 192.0], "unit": "score", "name": "imaging-darkroom", "value": 192.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 56.0, 55.0, 55.0, 58.0, 61.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 59.7}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 80.0, 81.0, 79.0, 78.0, 78.0, 77.0, 89.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.1}, {"lowerIsBetter": true, "replicates": [115.0, 108.0, 115.0, 108.0, 108.0, 109.0, 112.0, 108.0, 118.0, 107.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 110.8}, {"lowerIsBetter": true, "replicates": [138.0, 146.0, 136.0, 135.0, 135.0, 147.0, 135.0, 135.0, 138.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.0}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 63.0, 62.0, 63.0, 63.0, 62.0, 63.0, 61.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.9}], "name": "kraken", "value": 1741.2}]} 22:34:58 INFO - Return code: 0 22:34:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:34:58 ERROR - # TBPL SUCCESS # 22:34:58 INFO - Running post-action listener: _resource_record_post_action 22:34:58 INFO - Running post-run listener: _resource_record_post_run 22:34:59 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 28672; Write bytes: 540205056; Read time: 256; Write time: 655704 22:34:59 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 253923328; Read time: 0; Write time: 395580 22:34:59 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 28672; Write bytes: 286281728; Read time: 256; Write time: 260124 22:34:59 INFO - Running post-run listener: _upload_blobber_files 22:34:59 INFO - Blob upload gear active. 22:34:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:34:59 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 22:34:59 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'] 22:34:59 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 22:35:00 INFO - (blobuploader) - INFO - Open directory for files ... 22:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:00 INFO - (blobuploader) - INFO - Done attempting. 22:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:35:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:01 INFO - (blobuploader) - INFO - Done attempting. 22:35:01 INFO - (blobuploader) - INFO - Iteration through files over. 22:35:01 INFO - Return code: 0 22:35:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:35:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:35:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daf27b29f2134214b65115081e1a083e3804e88909c022abc0af98a50466a4a06efd86af0d02f871a69f884e4acc75e1312325d9527d7dc95dffafe7c783711d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd1667ee4db6f88a304d1a3d3102e4291da30a8160543c04414a479209dc4128b8ce139928e6645b6531031e658ad9f97b517bf3f1e3e71e84c486ef41e850db"} 22:35:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:35:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:35:01 INFO - Contents: 22:35:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/daf27b29f2134214b65115081e1a083e3804e88909c022abc0af98a50466a4a06efd86af0d02f871a69f884e4acc75e1312325d9527d7dc95dffafe7c783711d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd1667ee4db6f88a304d1a3d3102e4291da30a8160543c04414a479209dc4128b8ce139928e6645b6531031e658ad9f97b517bf3f1e3e71e84c486ef41e850db"} 22:35:01 INFO - Running post-run listener: copy_logs_to_upload_dir 22:35:01 INFO - Copying logs to upload dir... 22:35:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:35:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.804208 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-14 22:35:01.370258) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 22:35:01.375669) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564 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/daf27b29f2134214b65115081e1a083e3804e88909c022abc0af98a50466a4a06efd86af0d02f871a69f884e4acc75e1312325d9527d7dc95dffafe7c783711d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd1667ee4db6f88a304d1a3d3102e4291da30a8160543c04414a479209dc4128b8ce139928e6645b6531031e658ad9f97b517bf3f1e3e71e84c486ef41e850db"} build_url:https://queue.taskcluster.net/v1/task/TG5WtENlRYGQ_lGd9Tldgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/TG5WtENlRYGQ_lGd9Tldgw/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/daf27b29f2134214b65115081e1a083e3804e88909c022abc0af98a50466a4a06efd86af0d02f871a69f884e4acc75e1312325d9527d7dc95dffafe7c783711d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd1667ee4db6f88a304d1a3d3102e4291da30a8160543c04414a479209dc4128b8ce139928e6645b6531031e658ad9f97b517bf3f1e3e71e84c486ef41e850db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 22:35:01.404955) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 22:35:01.405582) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458018867.130048-969318564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.005027 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 22:35:01.488884) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 22:35:01.489221) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 22:35:01.489528) ========= ========= Total master_lag: 0.26 =========