builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1458383404.54 results: success (0) buildid: 20160319004052 builduid: 8397bc14f3f844e6a4f27c6548e15089 revision: 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:04.538901) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:04.539381) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:04.539730) ========= 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=8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006391 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:04.601701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:04.602034) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:04.833569) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:04.833902) ========= 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=8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:04.924642) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:04.925058) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:04.925499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:04.926083) ========= 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=8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-19 03:30:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.1M=0.001s 2016-03-19 03:30:05 (20.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153868 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:05.127182) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:05.127601) ========= 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=8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018775 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:05.177875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:05.181309) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 --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=8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-19 03:30:05,469 truncating revision to first 12 chars 2016-03-19 03:30:05,469 Setting DEBUG logging. 2016-03-19 03:30:05,469 attempt 1/10 2016-03-19 03:30:05,469 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6d030cb1d2ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-19 03:30:05,755 unpacking tar archive at: mozilla-aurora-6d030cb1d2ab/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559201 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:05.773485) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:05.773884) ========= echo 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35'] 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=8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 program finished with exit code 0 elapsedTime=0.004813 script_repo_revision: '6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35' ========= master_lag: 0.03 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:05.809520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:05.809939) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-19 03:30:05.850829) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-19 03:30:05.851137) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:06 INFO - MultiFileLogger online at 20160319 03:30:06 in /builds/slave/test-pgo 03:30:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:30:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:30:06 INFO - {'append_to_log': False, 03:30:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:30:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:30:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:30:06 INFO - 'branch': 'Mozilla-Aurora', 03:30:06 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:06 INFO - 'config_files': ('talos/linux_config.py',), 03:30:06 INFO - 'default_actions': ('clobber', 03:30:06 INFO - 'read-buildbot-config', 03:30:06 INFO - 'download-and-extract', 03:30:06 INFO - 'populate-webroot', 03:30:06 INFO - 'create-virtualenv', 03:30:06 INFO - 'install', 03:30:06 INFO - 'run-tests'), 03:30:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:06 INFO - 'download_minidump_stackwalk': True, 03:30:06 INFO - 'download_symbols': 'ondemand', 03:30:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:06 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:06 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:06 INFO - 'installer_path': 'installer.exe', 03:30:06 INFO - 'log_level': 'info', 03:30:06 INFO - 'log_name': 'talos', 03:30:06 INFO - 'log_to_console': True, 03:30:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:06 INFO - 'opt_config_files': (), 03:30:06 INFO - 'pip_index': False, 03:30:06 INFO - 'sps_profile': False, 03:30:06 INFO - 'sps_profile_interval': 0, 03:30:06 INFO - 'suite': 'dromaeojs-e10s', 03:30:06 INFO - 'system_bits': '32', 03:30:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:06 INFO - 'title': 'talos-linux64-ix-001', 03:30:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:06 INFO - 'use_talos_json': True, 03:30:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:30:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:06 INFO - 'work_dir': 'build'} 03:30:06 INFO - ##### 03:30:06 INFO - ##### Running clobber step. 03:30:06 INFO - ##### 03:30:06 INFO - Running pre-action listener: _resource_record_pre_action 03:30:06 INFO - Running main action method: clobber 03:30:06 INFO - rmtree: /builds/slave/test-pgo/build 03:30:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:30:06 INFO - Running post-action listener: _resource_record_post_action 03:30:06 INFO - ##### 03:30:06 INFO - ##### Running read-buildbot-config step. 03:30:06 INFO - ##### 03:30:06 INFO - Running pre-action listener: _resource_record_pre_action 03:30:06 INFO - Running main action method: read_buildbot_config 03:30:06 INFO - Using buildbot properties: 03:30:06 INFO - { 03:30:06 INFO - "project": "", 03:30:06 INFO - "product": "firefox", 03:30:06 INFO - "script_repo_revision": "production", 03:30:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:30:06 INFO - "repository": "", 03:30:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:30:06 INFO - "buildid": "20160319004052", 03:30:06 INFO - "stage_platform": "linux64-pgo", 03:30:06 INFO - "basedir": "/builds/slave/test-pgo", 03:30:06 INFO - "nightly_build": "True", 03:30:06 INFO - "buildnumber": 143, 03:30:06 INFO - "slavename": "talos-linux64-ix-001", 03:30:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:30:06 INFO - "platform": "ubuntu64_hw", 03:30:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:30:06 INFO - "branch": "mozilla-aurora", 03:30:06 INFO - "repo_path": "releases/mozilla-aurora", 03:30:06 INFO - "revision": "6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35", 03:30:06 INFO - "pgo_build": "True", 03:30:06 INFO - "builduid": "8397bc14f3f844e6a4f27c6548e15089", 03:30:06 INFO - "slavebuilddir": "test" 03:30:06 INFO - } 03:30:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:30:06 INFO - Running post-action listener: _resource_record_post_action 03:30:06 INFO - ##### 03:30:06 INFO - ##### Running download-and-extract step. 03:30:06 INFO - ##### 03:30:06 INFO - Running pre-action listener: _resource_record_pre_action 03:30:06 INFO - Running main action method: download_and_extract 03:30:06 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:30:06 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')]} 03:30:06 INFO - https://queue.taskcluster.net/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:30:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:30:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:30:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:30:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:30:10 INFO - Downloaded 1448 bytes. 03:30:10 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:30:10 INFO - Using the following test package requirements: 03:30:10 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:10 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:10 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:10 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:10 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:30:10 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:10 INFO - u'jsshell-linux-x86_64.zip'], 03:30:10 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:10 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:10 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:10 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:10 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:30:10 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:10 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:30:10 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:10 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:10 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:10 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:10 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:10 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:10 INFO - https://queue.taskcluster.net/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:30:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:30:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:30:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:30 INFO - Downloaded 23309666 bytes. 03:30:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:30:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:30:31 INFO - Return code: 0 03:30:31 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:30:31 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')]} 03:30:31 INFO - https://queue.taskcluster.net/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:30:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:30:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:32 INFO - Downloaded 23309666 bytes. 03:30:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:30:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:30:34 INFO - Return code: 0 03:30: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')]} 03:30:34 INFO - https://queue.taskcluster.net/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:30:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:30:35 INFO - Downloaded 10845161 bytes. 03:30:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:30:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 03:30:35 INFO - Return code: 0 03:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:35 INFO - https://queue.taskcluster.net/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:30:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:30:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:30:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:30:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:30:36 INFO - Downloaded 60434018 bytes. 03:30:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:30:36 INFO - mkdir: /builds/slave/test-pgo/properties 03:30:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:30:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:30:36 INFO - Contents: 03:30:36 INFO - build_url:https://queue.taskcluster.net/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:30:37 INFO - Running post-action listener: _resource_record_post_action 03:30:37 INFO - Running post-action listener: set_extra_try_arguments 03:30:37 INFO - ##### 03:30:37 INFO - ##### Running populate-webroot step. 03:30:37 INFO - ##### 03:30:37 INFO - Running pre-action listener: _resource_record_pre_action 03:30:37 INFO - Running main action method: populate_webroot 03:30:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:30:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:30:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:30:37 INFO - '--tppagecycles', 03:30:37 INFO - '7'], 03:30:37 INFO - 'tests': ['tsvgm']}}, 03:30:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:30:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:30:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:30:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:30:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:30:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:30:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:37 INFO - 'talos_options': ['--e10s'], 03:30:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:37 INFO - 'tests': ['damp', 'tps']}, 03:30:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:37 INFO - 'talos_options': ['--e10s'], 03:30:37 INFO - 'tests': ['damp', 'tps']}, 03:30:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:30:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:37 INFO - 'other': {'tests': ['a11yr', 03:30:37 INFO - 'ts_paint', 03:30:37 INFO - 'tpaint', 03:30:37 INFO - 'sessionrestore', 03:30:37 INFO - 'sessionrestore_no_auto_restore', 03:30:37 INFO - 'tabpaint']}, 03:30:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:30:37 INFO - 'tests': ['a11yr', 03:30:37 INFO - 'ts_paint', 03:30:37 INFO - 'tpaint', 03:30:37 INFO - 'sessionrestore', 03:30:37 INFO - 'sessionrestore_no_auto_restore', 03:30:37 INFO - 'tabpaint']}, 03:30:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:30:37 INFO - 'tests': ['a11yr', 03:30:37 INFO - 'ts_paint', 03:30:37 INFO - 'tpaint', 03:30:37 INFO - 'sessionrestore', 03:30:37 INFO - 'sessionrestore_no_auto_restore', 03:30:37 INFO - 'tabpaint']}, 03:30:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:30:37 INFO - 'tests': ['a11yr', 03:30:37 INFO - 'ts_paint', 03:30:37 INFO - 'tpaint', 03:30:37 INFO - 'sessionrestore', 03:30:37 INFO - 'sessionrestore_no_auto_restore', 03:30:37 INFO - 'tabpaint']}, 03:30:37 INFO - 'other_l64': {'tests': ['a11yr', 03:30:37 INFO - 'ts_paint', 03:30:37 INFO - 'tpaint', 03:30:37 INFO - 'sessionrestore', 03:30:37 INFO - 'sessionrestore_no_auto_restore', 03:30:37 INFO - 'tabpaint']}, 03:30:37 INFO - 'other_nol64': {'tests': ['a11yr', 03:30:37 INFO - 'ts_paint', 03:30:37 INFO - 'tpaint', 03:30:37 INFO - 'sessionrestore', 03:30:37 INFO - 'sessionrestore_no_auto_restore', 03:30:37 INFO - 'tabpaint']}, 03:30:37 INFO - 'svgr': {'tests': ['tsvgx', 03:30:37 INFO - 'tsvgr_opacity', 03:30:37 INFO - 'tart', 03:30:37 INFO - 'tscrollx', 03:30:37 INFO - 'cart']}, 03:30:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:30:37 INFO - 'tests': ['tsvgx', 03:30:37 INFO - 'tsvgr_opacity', 03:30:37 INFO - 'tart', 03:30:37 INFO - 'tscrollx', 03:30:37 INFO - 'cart']}, 03:30:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:37 INFO - 'tests': ['tp5o']}, 03:30:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:37 INFO - 'talos_options': ['--e10s'], 03:30:37 INFO - 'tests': ['tp5o']}, 03:30:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:37 INFO - 'talos_options': ['--xperf_path', 03:30:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:37 INFO - 'tests': ['tp5n']}, 03:30:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:37 INFO - 'talos_options': ['--e10s', 03:30:37 INFO - '--xperf_path', 03:30:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:37 INFO - 'tests': ['tp5n']}}, 03:30:37 INFO - 'talos.zip': {'path': '', 03:30:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:30:37 INFO - Running post-action listener: _resource_record_post_action 03:30:37 INFO - ##### 03:30:37 INFO - ##### Running create-virtualenv step. 03:30:37 INFO - ##### 03:30:37 INFO - Running pre-action listener: _resource_record_pre_action 03:30:37 INFO - Running main action method: create_virtualenv 03:30:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:30:37 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 03:30:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:30:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:37 INFO - Using real prefix '/usr' 03:30:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:30:38 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:40 INFO - Installing pip.................done. 03:30:40 INFO - Return code: 0 03:30:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:40 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 0x7f3dca028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60920>, '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 0x2a61820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a61cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', '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 03:30:40 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 03:30:40 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 03:30:40 INFO - Using env: {'DISPLAY': ':0', 03:30:40 INFO - 'HOME': '/home/cltbld', 03:30:40 INFO - 'LANG': 'en_US.UTF-8', 03:30:40 INFO - 'LANGUAGE': 'en_US:en', 03:30:40 INFO - 'LOGNAME': 'cltbld', 03:30:40 INFO - 'MAIL': '/var/mail/cltbld', 03:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:40 INFO - 'MOZ_NO_REMOTE': '1', 03:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:40 INFO - 'NO_EM_RESTART': '1', 03:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:30:40 INFO - 'PWD': '/builds/slave/test-pgo', 03:30:40 INFO - 'SHELL': '/bin/bash', 03:30:40 INFO - 'SHLVL': '1', 03:30:40 INFO - 'TERM': 'linux', 03:30:40 INFO - 'TMOUT': '86400', 03:30:40 INFO - 'USER': 'cltbld', 03:30:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', 03:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:40 INFO - '_': '/tools/buildbot/bin/python'} 03:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:40 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 03:30:40 INFO - Cleaning up... 03:30:40 INFO - Return code: 0 03:30:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:40 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 0x7f3dca028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60920>, '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 0x2a61820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a61cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', '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 03:30:40 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 03:30:40 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 03:30:40 INFO - Using env: {'DISPLAY': ':0', 03:30:40 INFO - 'HOME': '/home/cltbld', 03:30:40 INFO - 'LANG': 'en_US.UTF-8', 03:30:40 INFO - 'LANGUAGE': 'en_US:en', 03:30:40 INFO - 'LOGNAME': 'cltbld', 03:30:40 INFO - 'MAIL': '/var/mail/cltbld', 03:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:40 INFO - 'MOZ_NO_REMOTE': '1', 03:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:40 INFO - 'NO_EM_RESTART': '1', 03:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:30:40 INFO - 'PWD': '/builds/slave/test-pgo', 03:30:40 INFO - 'SHELL': '/bin/bash', 03:30:40 INFO - 'SHLVL': '1', 03:30:40 INFO - 'TERM': 'linux', 03:30:40 INFO - 'TMOUT': '86400', 03:30:40 INFO - 'USER': 'cltbld', 03:30:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', 03:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:40 INFO - '_': '/tools/buildbot/bin/python'} 03:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:40 INFO - Downloading/unpacking psutil>=0.7.1 03:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:42 INFO - Installing collected packages: psutil 03:30:42 INFO - Running setup.py install for psutil 03:30:42 INFO - building 'psutil._psutil_linux' extension 03:30:42 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 03:30:42 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 03:30:42 INFO - building 'psutil._psutil_posix' extension 03:30:42 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 03:30:43 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 03:30:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:43 INFO - Successfully installed psutil 03:30:43 INFO - Cleaning up... 03:30:43 INFO - Return code: 0 03:30:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:43 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 0x7f3dca028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60920>, '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 0x2a61820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a61cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', '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 03:30:43 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 03:30:43 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 03:30:43 INFO - Using env: {'DISPLAY': ':0', 03:30:43 INFO - 'HOME': '/home/cltbld', 03:30:43 INFO - 'LANG': 'en_US.UTF-8', 03:30:43 INFO - 'LANGUAGE': 'en_US:en', 03:30:43 INFO - 'LOGNAME': 'cltbld', 03:30:43 INFO - 'MAIL': '/var/mail/cltbld', 03:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:43 INFO - 'MOZ_NO_REMOTE': '1', 03:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:43 INFO - 'NO_EM_RESTART': '1', 03:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:30:43 INFO - 'PWD': '/builds/slave/test-pgo', 03:30:43 INFO - 'SHELL': '/bin/bash', 03:30:43 INFO - 'SHLVL': '1', 03:30:43 INFO - 'TERM': 'linux', 03:30:43 INFO - 'TMOUT': '86400', 03:30:43 INFO - 'USER': 'cltbld', 03:30:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', 03:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:43 INFO - '_': '/tools/buildbot/bin/python'} 03:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:30:43 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 03:30:43 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 03:30:43 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 03:30:43 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 03:30:43 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 03:30:43 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 03:30:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:30:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:30:45 INFO - Installing collected packages: mozsystemmonitor 03:30:45 INFO - Running setup.py install for mozsystemmonitor 03:30:45 INFO - Successfully installed mozsystemmonitor 03:30:45 INFO - Cleaning up... 03:30:45 INFO - Return code: 0 03:30:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:30: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')]} 03:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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', '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 0x7f3dca028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60920>, '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 0x2a61820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a61cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', '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 03:30: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:30: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 blobuploader==1.2.4 03:30:45 INFO - Using env: {'DISPLAY': ':0', 03:30:45 INFO - 'HOME': '/home/cltbld', 03:30:45 INFO - 'LANG': 'en_US.UTF-8', 03:30:45 INFO - 'LANGUAGE': 'en_US:en', 03:30:45 INFO - 'LOGNAME': 'cltbld', 03:30:45 INFO - 'MAIL': '/var/mail/cltbld', 03:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:45 INFO - 'MOZ_NO_REMOTE': '1', 03:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:45 INFO - 'NO_EM_RESTART': '1', 03:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:30:45 INFO - 'PWD': '/builds/slave/test-pgo', 03:30:45 INFO - 'SHELL': '/bin/bash', 03:30:45 INFO - 'SHLVL': '1', 03:30:45 INFO - 'TERM': 'linux', 03:30:45 INFO - 'TMOUT': '86400', 03:30:45 INFO - 'USER': 'cltbld', 03:30:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', 03:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:45 INFO - '_': '/tools/buildbot/bin/python'} 03:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:47 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:30:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:48 INFO - Downloading docopt-0.6.1.tar.gz 03:30:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:48 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:48 INFO - Running setup.py install for blobuploader 03:30:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:30:48 INFO - Running setup.py install for requests 03:30:48 INFO - Running setup.py install for docopt 03:30:48 INFO - Successfully installed blobuploader requests docopt 03:30:48 INFO - Cleaning up... 03:30:48 INFO - Return code: 0 03:30:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:48 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 0x7f3dca028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60920>, '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 0x2a61820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a61cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', '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 03:30:48 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 03:30:48 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 03:30:48 INFO - Using env: {'DISPLAY': ':0', 03:30:48 INFO - 'HOME': '/home/cltbld', 03:30:48 INFO - 'LANG': 'en_US.UTF-8', 03:30:48 INFO - 'LANGUAGE': 'en_US:en', 03:30:48 INFO - 'LOGNAME': 'cltbld', 03:30:48 INFO - 'MAIL': '/var/mail/cltbld', 03:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:48 INFO - 'MOZ_NO_REMOTE': '1', 03:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:48 INFO - 'NO_EM_RESTART': '1', 03:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:30:48 INFO - 'PWD': '/builds/slave/test-pgo', 03:30:48 INFO - 'SHELL': '/bin/bash', 03:30:48 INFO - 'SHLVL': '1', 03:30:48 INFO - 'TERM': 'linux', 03:30:48 INFO - 'TMOUT': '86400', 03:30:48 INFO - 'USER': 'cltbld', 03:30:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', 03:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:48 INFO - '_': '/tools/buildbot/bin/python'} 03:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:30:49 INFO - Running setup.py (path:/tmp/pip-RLN00Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:30:49 INFO - Running setup.py (path:/tmp/pip-o0DLrH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:30:49 INFO - Running setup.py (path:/tmp/pip-chyvmR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:30:49 INFO - Running setup.py (path:/tmp/pip-Kf0PFM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:30:49 INFO - Running setup.py (path:/tmp/pip-pGWPgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:30:49 INFO - Running setup.py (path:/tmp/pip-UU_0zf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:30:49 INFO - Running setup.py (path:/tmp/pip-xYftBg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:30:49 INFO - Running setup.py (path:/tmp/pip-QgxbRg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:30:49 INFO - Running setup.py (path:/tmp/pip-bH02o1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:30:49 INFO - Running setup.py (path:/tmp/pip-m66ibR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:30:49 INFO - Running setup.py (path:/tmp/pip-l0mEEA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:30:49 INFO - Running setup.py (path:/tmp/pip-afcHBa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:30:49 INFO - Running setup.py (path:/tmp/pip-VMiFBk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:30:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:30:49 INFO - Running setup.py (path:/tmp/pip-k0gh2l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:30:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:30:50 INFO - Running setup.py (path:/tmp/pip-oAKPdO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:30:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:30:50 INFO - Running setup.py (path:/tmp/pip-dByuly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:30:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:30:50 INFO - Running setup.py (path:/tmp/pip-pjepTz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:30:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:50 INFO - Running setup.py install for manifestparser 03:30:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:30:50 INFO - Running setup.py install for mozcrash 03:30:50 INFO - Running setup.py install for mozdebug 03:30:50 INFO - Running setup.py install for mozdevice 03:30:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:30:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:30:50 INFO - Running setup.py install for mozfile 03:30:50 INFO - Running setup.py install for mozhttpd 03:30:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:30:50 INFO - Running setup.py install for mozinfo 03:30:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:30:50 INFO - Running setup.py install for mozInstall 03:30:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:30:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:30:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:30:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:30:51 INFO - Running setup.py install for mozleak 03:30:51 INFO - Running setup.py install for mozlog 03:30:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:30:51 INFO - Running setup.py install for moznetwork 03:30:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:30:51 INFO - Running setup.py install for mozprocess 03:30:51 INFO - Running setup.py install for mozprofile 03:30:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:30:51 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:30:51 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:30:51 INFO - Running setup.py install for mozrunner 03:30:51 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:30:51 INFO - Running setup.py install for mozscreenshot 03:30:51 INFO - Running setup.py install for moztest 03:30:51 INFO - Running setup.py install for mozversion 03:30:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:30:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:52 INFO - Cleaning up... 03:30:52 INFO - Return code: 0 03:30:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:30:52 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')]} 03:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:52 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')]} 03:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:52 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 0x7f3dca028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60920>, '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 0x2a61820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a61cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', '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 03:30:52 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 03:30:52 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 03:30:52 INFO - Using env: {'DISPLAY': ':0', 03:30:52 INFO - 'HOME': '/home/cltbld', 03:30:52 INFO - 'LANG': 'en_US.UTF-8', 03:30:52 INFO - 'LANGUAGE': 'en_US:en', 03:30:52 INFO - 'LOGNAME': 'cltbld', 03:30:52 INFO - 'MAIL': '/var/mail/cltbld', 03:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:52 INFO - 'MOZ_NO_REMOTE': '1', 03:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:52 INFO - 'NO_EM_RESTART': '1', 03:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:30:52 INFO - 'PWD': '/builds/slave/test-pgo', 03:30:52 INFO - 'SHELL': '/bin/bash', 03:30:52 INFO - 'SHLVL': '1', 03:30:52 INFO - 'TERM': 'linux', 03:30:52 INFO - 'TMOUT': '86400', 03:30:52 INFO - 'USER': 'cltbld', 03:30:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', 03:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:52 INFO - '_': '/tools/buildbot/bin/python'} 03:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:30:52 INFO - Running setup.py (path:/tmp/pip-NjLskW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:30:52 INFO - Running setup.py (path:/tmp/pip-Wy7WlR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:30:52 INFO - Running setup.py (path:/tmp/pip-kQpg00-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:30:52 INFO - Running setup.py (path:/tmp/pip-kZRa5J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:30:52 INFO - Running setup.py (path:/tmp/pip-SNEdBn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:30:52 INFO - Running setup.py (path:/tmp/pip-EUHkUO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:30:52 INFO - Running setup.py (path:/tmp/pip-aVQuKD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:30:52 INFO - Running setup.py (path:/tmp/pip-pZYZ_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:30:52 INFO - Running setup.py (path:/tmp/pip-Ar_RgN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:30:52 INFO - Running setup.py (path:/tmp/pip-al7j7w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:30:52 INFO - Running setup.py (path:/tmp/pip-lTArGw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:30:53 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)) 03:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:30:53 INFO - Running setup.py (path:/tmp/pip-KZvhz1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:30:53 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)) 03:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:30:53 INFO - Running setup.py (path:/tmp/pip-kizzZx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:30:53 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)) 03:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:30:53 INFO - Running setup.py (path:/tmp/pip-XVeacf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:30:53 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)) 03:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:30:53 INFO - Running setup.py (path:/tmp/pip-mm6PYX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:30:53 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)) 03:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:30:53 INFO - Running setup.py (path:/tmp/pip-vrFeRN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:30:53 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)) 03:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:30:53 INFO - Running setup.py (path:/tmp/pip-jfcCyb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:30:53 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)) 03:30:53 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)) 03:30:53 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)) 03:30:53 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)) 03:30:53 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)) 03:30:53 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)) 03:30:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:55 INFO - Downloading blessings-1.6.tar.gz 03:30:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:55 INFO - Installing collected packages: blessings 03:30:55 INFO - Running setup.py install for blessings 03:30:55 INFO - Successfully installed blessings 03:30:55 INFO - Cleaning up... 03:30:55 INFO - Return code: 0 03:30:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:30:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:30:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:30:55 INFO - Reading from file tmpfile_stdout 03:30:55 INFO - Current package versions: 03:30:55 INFO - argparse == 1.2.1 03:30:55 INFO - blessings == 1.6 03:30:55 INFO - blobuploader == 1.2.4 03:30:55 INFO - docopt == 0.6.1 03:30:55 INFO - manifestparser == 1.1 03:30:55 INFO - mozInstall == 1.12 03:30:55 INFO - mozcrash == 0.17 03:30:55 INFO - mozdebug == 0.1 03:30:55 INFO - mozdevice == 0.48 03:30:55 INFO - mozfile == 1.2 03:30:55 INFO - mozhttpd == 0.7 03:30:55 INFO - mozinfo == 0.9 03:30:55 INFO - mozleak == 0.1 03:30:55 INFO - mozlog == 3.1 03:30:55 INFO - moznetwork == 0.27 03:30:55 INFO - mozprocess == 0.22 03:30:55 INFO - mozprofile == 0.28 03:30:55 INFO - mozrunner == 6.11 03:30:55 INFO - mozscreenshot == 0.1 03:30:55 INFO - mozsystemmonitor == 0.0 03:30:55 INFO - moztest == 0.7 03:30:55 INFO - mozversion == 1.4 03:30:55 INFO - psutil == 3.1.1 03:30:55 INFO - requests == 1.2.3 03:30:55 INFO - wsgiref == 0.1.2 03:30:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:30:55 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')]} 03:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 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')]} 03:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 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 0x7f3dca028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60920>, '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 0x2a61820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a61cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', '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 03:30:55 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 03:30:55 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 03:30:55 INFO - Using env: {'DISPLAY': ':0', 03:30:55 INFO - 'HOME': '/home/cltbld', 03:30:55 INFO - 'LANG': 'en_US.UTF-8', 03:30:55 INFO - 'LANGUAGE': 'en_US:en', 03:30:55 INFO - 'LOGNAME': 'cltbld', 03:30:55 INFO - 'MAIL': '/var/mail/cltbld', 03:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:55 INFO - 'MOZ_NO_REMOTE': '1', 03:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:55 INFO - 'NO_EM_RESTART': '1', 03:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:30:55 INFO - 'PWD': '/builds/slave/test-pgo', 03:30:55 INFO - 'SHELL': '/bin/bash', 03:30:55 INFO - 'SHLVL': '1', 03:30:55 INFO - 'TERM': 'linux', 03:30:55 INFO - 'TMOUT': '86400', 03:30:55 INFO - 'USER': 'cltbld', 03:30:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', 03:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:55 INFO - '_': '/tools/buildbot/bin/python'} 03:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 INFO - Cleaning up... 03:30:55 INFO - Return code: 0 03:30:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:30:55 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')]} 03:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 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')]} 03:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 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 0x7f3dca028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60920>, '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 0x2a61820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a61cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', '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 03:30:55 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 03:30:55 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 03:30:55 INFO - Using env: {'DISPLAY': ':0', 03:30:55 INFO - 'HOME': '/home/cltbld', 03:30:55 INFO - 'LANG': 'en_US.UTF-8', 03:30:55 INFO - 'LANGUAGE': 'en_US:en', 03:30:55 INFO - 'LOGNAME': 'cltbld', 03:30:55 INFO - 'MAIL': '/var/mail/cltbld', 03:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:55 INFO - 'MOZ_NO_REMOTE': '1', 03:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:55 INFO - 'NO_EM_RESTART': '1', 03:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:30:55 INFO - 'PWD': '/builds/slave/test-pgo', 03:30:55 INFO - 'SHELL': '/bin/bash', 03:30:55 INFO - 'SHLVL': '1', 03:30:55 INFO - 'TERM': 'linux', 03:30:55 INFO - 'TMOUT': '86400', 03:30:55 INFO - 'USER': 'cltbld', 03:30:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', 03:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:55 INFO - '_': '/tools/buildbot/bin/python'} 03:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:56 INFO - Downloading/unpacking jsonschema 03:30:56 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 03:30:56 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 03:30:56 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 03:30:56 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 03:30:56 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 03:30:56 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 03:30:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:58 INFO - Downloading/unpacking functools32 (from jsonschema) 03:30:58 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 03:30:58 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 03:30:58 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 03:30:58 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 03:30:58 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 03:30:58 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 03:30:58 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:58 INFO - warning: no files found matching '*.txt' 03:30:58 INFO - no previously-included directories found matching 'build' 03:30:58 INFO - no previously-included directories found matching 'dist' 03:30:58 INFO - no previously-included directories found matching '.git*' 03:30:58 INFO - Installing collected packages: jsonschema, functools32 03:30:58 INFO - Running setup.py install for functools32 03:30:58 INFO - warning: no files found matching '*.txt' 03:30:58 INFO - no previously-included directories found matching 'build' 03:30:58 INFO - no previously-included directories found matching 'dist' 03:30:58 INFO - no previously-included directories found matching '.git*' 03:30:58 INFO - Successfully installed jsonschema functools32 03:30:58 INFO - Cleaning up... 03:30:58 INFO - Return code: 0 03:30:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:58 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 0x7f3dca028f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60920>, '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 0x2a61820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a61cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', '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 03:30:58 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 03:30:58 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 03:30:58 INFO - Using env: {'DISPLAY': ':0', 03:30:58 INFO - 'HOME': '/home/cltbld', 03:30:58 INFO - 'LANG': 'en_US.UTF-8', 03:30:58 INFO - 'LANGUAGE': 'en_US:en', 03:30:58 INFO - 'LOGNAME': 'cltbld', 03:30:58 INFO - 'MAIL': '/var/mail/cltbld', 03:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:58 INFO - 'MOZ_NO_REMOTE': '1', 03:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:58 INFO - 'NO_EM_RESTART': '1', 03:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:30:58 INFO - 'PWD': '/builds/slave/test-pgo', 03:30:58 INFO - 'SHELL': '/bin/bash', 03:30:58 INFO - 'SHLVL': '1', 03:30:58 INFO - 'TERM': 'linux', 03:30:58 INFO - 'TMOUT': '86400', 03:30:58 INFO - 'USER': 'cltbld', 03:30:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', 03:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:58 INFO - '_': '/tools/buildbot/bin/python'} 03:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:58 INFO - Downloading/unpacking flake8 03:30:58 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 03:30:58 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 03:30:58 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 03:30:58 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 03:30:58 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 03:30:58 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 03:31:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:31:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:31:00 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 03:31:00 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 03:31:00 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 03:31:00 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 03:31:00 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 03:31:00 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 03:31:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:31:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:31:00 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 03:31:00 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 03:31:00 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 03:31:00 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 03:31:00 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 03:31:00 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 03:31:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:31:00 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 03:31:00 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 03:31:00 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 03:31:00 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 03:31:00 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 03:31:00 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 03:31:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:31:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:01 INFO - no previously-included directories found matching 'docs/_build' 03:31:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:31:01 INFO - Running setup.py install for pep8 03:31:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:01 INFO - no previously-included directories found matching 'docs/_build' 03:31:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:31:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:31:01 INFO - Cleaning up... 03:31:01 INFO - Return code: 0 03:31:01 INFO - Running post-action listener: _resource_record_post_action 03:31:01 INFO - Running post-action listener: _start_resource_monitoring 03:31:01 INFO - Starting resource monitoring. 03:31:01 INFO - ##### 03:31:01 INFO - ##### Running install step. 03:31:01 INFO - ##### 03:31:01 INFO - Running pre-action listener: _resource_record_pre_action 03:31:01 INFO - Running main action method: install 03:31:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:31:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:31:01 INFO - Reading from file tmpfile_stdout 03:31:01 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:31:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:31:01 INFO - Reading from file tmpfile_stdout 03:31:01 INFO - Output received: 03:31:01 INFO - Usage: mozinstall [options] installer 03:31:01 INFO - Options: 03:31:01 INFO - -h, --help show this help message and exit 03:31:01 INFO - -d DEST, --destination=DEST 03:31:01 INFO - Directory to install application into. [default: 03:31:01 INFO - "/builds/slave/test-pgo"] 03:31:01 INFO - --app=APP Application being installed. [default: firefox] 03:31:01 INFO - mkdir: /builds/slave/test-pgo/build/application 03:31:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:31:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:31:16 INFO - Reading from file tmpfile_stdout 03:31:16 INFO - Output received: 03:31:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:31:16 INFO - Running post-action listener: _resource_record_post_action 03:31:16 INFO - ##### 03:31:16 INFO - ##### Running run-tests step. 03:31:16 INFO - ##### 03:31:16 INFO - Running pre-action listener: _resource_record_pre_action 03:31:16 INFO - Running main action method: run_tests 03:31:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:31:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:31:16 INFO - Python 2.7.3 03:31:16 INFO - Return code: 0 03:31:16 INFO - grabbing minidump binary from tooltool 03:31:16 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')]} 03:31:16 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 0x2a60920>, '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 0x2a61820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a61cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:31:16 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 03:31:16 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 03:31:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:17 INFO - Return code: 0 03:31:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:31:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:31:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:31:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:31:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:31:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:31:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:31:18 INFO - Return code: 0 03:31:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 03:31:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:31:18 INFO - Using env: {'DISPLAY': ':0', 03:31:18 INFO - 'HOME': '/home/cltbld', 03:31:18 INFO - 'LANG': 'en_US.UTF-8', 03:31:18 INFO - 'LANGUAGE': 'en_US:en', 03:31:18 INFO - 'LOGNAME': 'cltbld', 03:31:18 INFO - 'MAIL': '/var/mail/cltbld', 03:31:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:31:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:18 INFO - 'MOZ_NO_REMOTE': '1', 03:31:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:31:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:18 INFO - 'NO_EM_RESTART': '1', 03:31:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:31:18 INFO - 'PWD': '/builds/slave/test-pgo', 03:31:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:31:18 INFO - 'SHELL': '/bin/bash', 03:31:18 INFO - 'SHLVL': '1', 03:31:18 INFO - 'TERM': 'linux', 03:31:18 INFO - 'TMOUT': '86400', 03:31:18 INFO - 'USER': 'cltbld', 03:31:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924', 03:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:18 INFO - '_': '/tools/buildbot/bin/python'} 03:31:18 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:31:18 INFO - mozversion application_buildid: 20160319004052 03:31:18 INFO - mozversion application_changeset: 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 03:31:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:31:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:18 INFO - mozversion application_name: Firefox 03:31:18 INFO - mozversion application_remotingname: firefox-dev 03:31:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:18 INFO - mozversion application_vendor: Mozilla 03:31:18 INFO - mozversion application_version: 47.0a2 03:31:18 INFO - mozversion platform_buildid: 20160319004052 03:31:18 INFO - mozversion platform_changeset: 6d030cb1d2ab43b99cc2b5b585d9acbdf6fc9e35 03:31:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:18 INFO - mozversion platform_version: 47.0a2 03:31:18 INFO - using testdate: 1458383478 03:31:18 INFO - actual date: 1458383478 03:31:18 INFO - starting webserver on 'localhost:50364' 03:31:18 INFO - SUITE-START | Running 2 tests 03:31:18 INFO - TEST-START | dromaeo_css 03:31:18 INFO - operating with platform_type : linux_ 03:31:18 INFO - Initialising browser for dromaeo_css test... 03:31:18 INFO - TEST-INFO | started process 4891 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDaBZi1/profile http://localhost:50364/getInfo.html) 03:31:21 INFO - PROCESS | 4891 | 03:31:21 INFO - PROCESS | 4891 | (process:4967): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:31:22 INFO - PROCESS | 4891 | __metrics Screen width/height:1600/1200 03:31:22 INFO - PROCESS | 4891 | colorDepth:24 03:31:22 INFO - PROCESS | 4891 | Browser inner width/height: 1024/697 03:31:22 INFO - PROCESS | 4891 | __metrics 03:31:23 ERROR - PROCESS | 4891 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:31:24 INFO - TEST-INFO | 4891: exit 0 03:31:24 INFO - Browser initialized. 03:31:24 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:24 INFO - TEST-INFO | started process 5018 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDaBZi1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:26 INFO - PROCESS | 5018 | 03:31:26 INFO - PROCESS | 5018 | (process:5084): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:31:36 INFO - PROCESS | 5018 | RSS: Main: 154353664 03:31:36 INFO - PROCESS | 5018 | 03:32:25 INFO - PROCESS | 5018 | 1458383545708 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] 03:34:34 INFO - PROCESS | 5018 | Cycle 1(1): loaded http://localhost:50364/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50364/tests/dromaeo/cssquery-ext.html) 03:34:35 INFO - PROCESS | 5018 | RSS: Main: 156442624 03:34:35 INFO - PROCESS | 5018 | 03:37:37 INFO - PROCESS | 5018 | Cycle 1(1): loaded http://localhost:50364/tests/dromaeo/cssquery-ext.html (next: http://localhost:50364/tests/dromaeo/cssquery-jquery.html) 03:37:37 INFO - PROCESS | 5018 | RSS: Main: 156561408 03:37:37 INFO - PROCESS | 5018 | 03:40:39 INFO - PROCESS | 5018 | Cycle 1(1): loaded http://localhost:50364/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50364/tests/dromaeo/cssquery-mootools.html) 03:40:39 INFO - PROCESS | 5018 | RSS: Main: 156422144 03:40:39 INFO - PROCESS | 5018 | 03:43:41 INFO - PROCESS | 5018 | Cycle 1(1): loaded http://localhost:50364/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50364/tests/dromaeo/cssquery-prototype.html) 03:43:42 INFO - PROCESS | 5018 | RSS: Main: 154992640 03:43:42 INFO - PROCESS | 5018 | 03:46:44 INFO - PROCESS | 5018 | Cycle 1(1): loaded http://localhost:50364/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50364/tests/dromaeo/cssquery-yui.html) 03:46:44 INFO - PROCESS | 5018 | RSS: Main: 156659712 03:46:44 INFO - PROCESS | 5018 | 03:49:47 INFO - PROCESS | 5018 | Cycle 1(1): loaded http://localhost:50364/tests/dromaeo/cssquery-yui.html (next: http://localhost:50364/tests/dromaeo/cssquery-dojo.html) 03:49:47 INFO - PROCESS | 5018 | RSS: Main: 158851072 03:49:47 INFO - PROCESS | 5018 | 03:49:47 INFO - PROCESS | 5018 | __start_tp_report 03:49:47 INFO - PROCESS | 5018 | _x_x_mozilla_page_load 03:49:47 INFO - PROCESS | 5018 | _x_x_mozilla_page_load_details 03:49:47 INFO - PROCESS | 5018 | |i|pagename|runs| 03:49:47 INFO - PROCESS | 5018 | |0;dojo.html;3309.4704847224443;3371.730261579073;3378.0203740915103;3403.693667569918;3417.0090673704626;5556.472135147164;5599.580031497633;5621.465960733729;5624.493795558399;5643.266375371201;5590.329160500735;5593.049181639121;5626.634268772527;5629.465200805927;5638.802641907534;5095.7706903189355;5176.0683077046115;5178.378594568657;5212.895742085156;5213.635045546814;4979.7261150636705;5107.897842043157;5227.7908883644795;5245.868853278679;5245.921311180336;5162.586993040548;5176.5858731301405;5237.711925844077;5271.736413179326;5292.36491621006;5182.974085129569;5184.377874655047;5186.273921650972;5186.7147306898105;5225.425203227642;4877.487863774288;5000.249962505617;5016.272640467148;5030.471800460972;5169.302144210521;5421.918671219935;5434.673919564839;5457.699826509541;5458.727063646841;5473.8357849264585;6014.097885317194;6037.9396206038255;6066.373378904193;6068.393160683941;6077.696115194222;6039.184710064173;6113.046074236234;6117.113018612276;6132.268530072373;6139.308154111995;5625.437456254383;5650.208970744099;5659.886802263973;5661.009323368394;5663.207150998864;6015;6113.719560719409;6166.1983942087245;6177.907331390033;6178.783742568989;5940.435658612425;6008.639481631116;6017.157597936292;6022.668753218615;6025.9397406026255;6081.787137450168;6088.995315772936;6094.329623741385;6107.603005804608;6110.144579758838;5893.882122357529;6002.879942401215;6045.425684559959;6052.303985041688;6068.393160683984;5963.254593175853;6005.519558435315;6035.366286539938;6056.273247210363;6057.061155520902;4576.633869290516;4580.7938642761155;4598.770061496912;4611.100835337077;4620.1221767864;4030.6170913763144;4070.3080476319096;4079.8164082616354;4129.215449064668;4165.770882601425;5660.433956604306;5732.082866741302;5767.048437007847;5786.479216870502;5842.444967728059;6115.938840611626;6138.693065346715;6138.846528836815;6139.508839292846;6167.475764559973;5647;5718.857028574235;5839.503642190376;5843.707814609337;5846.561507886926;5060.114479965991;5075.492450754895;5081.110805609003;5081.2378143278065;5102;6319.399657032574;6319.715612797435;6324.873502529924;6338.144350512714;6346.809595712044;5917.230760001173;5977.491913187428;6034.2155519782145;6045.455908968126;6108.11432342299;6296.527760418078;6331.303556608677;6335.588186767845;6339.5562310637815;6343.397377249154;5985.191999080069;6050.152978582913;6051.818445446644;6062.727177277121;6068.029115341524;6008.87982240344;6121.632702037714;6143.72353244114;6146;6170.074488826533;5842.560562219908;5880.059190529495;5928.822135335947;5936.347001829881;5937.435943585352;5721.971390143022;5865.5600829937075;5870.119482077723;5894.322152952465;5923.229980102731;5853.882922341614;5893.174955506318;5894.6757928314355;5921.3782552831335;5952.523798096228;5984.042553191469;5997.070454079625;6007.279126504847;6019.51843852482;6025.397460254115;5657.2928383952;5758.827235182951;5856.180134781049;5865.14955331466;5868.94131058701 03:49:47 INFO - PROCESS | 5018 | |1;ext.html;540.1818674591825;565.8924804287186;595.416491837999;620.6927570852428;627.6391075131801;37403.251934961285;39105.60894391055;39137.217255654905;39275.41086883699;39443;40785;41325;41369.17261654765;41508;41761;8689.652413903452;8828.337874659393;8897.421667591618;8898.955505222497;8903;8627.137286271354;9014;9028.187463128317;9054.139856713602;9104.999999999967;9045.502497362642;9149.313801464883;9194.12655797698;9196.356255062148;9201.033891441402;9071.59177836999;9113.3165012624;9129.908700912973;9145.131212534832;9159;8924.821503569958;9051.366404351698;9057.909420905773;9062.637494500212;9068.365214434993;33251.168720781934;40412.79793601013;40990.59009409927;40998.79500602508;41031.384529232084;3635.763675361093;3730.2539492101687;3775.263823554408;3848.0956975110826;3896.766194028339;28707.856460717772;31623.20941976446;32001.51997720036;32271;32585.348293034243;4133.235351459959;4133.7106402551835;4160.966034144296;4178;4186.958130418688;259847;261655;262128;262737.9999999981;263990.3600963985;46183.30725039127;62806.68596656987;63338;63395.36604633987;63411.68294158592;48702.51297487051;48740.51259487431;48844.267335989985;48951.265731014064;49079;14477.855221447651;14541.854581454261;14559.854401456061;14589.562313130624;14663.706725865422;11995.580154694544;12180.208286461351;12195.634130976085;12196;12205.45075471606;15835.920820396055;15837.762433563506;15868;15910.522684319489;16040.518784436252;6144.631322120687;6308.968455157695;6416.647084410309;6424.261209960914;6428.8071357859335;996.7956568903357;1003.5584342889106;1059.7244716373798;1080.7244152741;1110.5502271580024;30450.54324185139;31009.224769380948;31010.224744381572;31423.685763142534;31548.526772098438;997.0308640435228;1096.276457538021;1180.4569897847086;1213.3629844331797;1273.420593629896;15667.843321566867;15869.920650396674;16253.83746162547;16372.181390930406;16437.09595972233;540392;563826;571057;574381;574677;57912.13131803026;58421;58491;58506;58524.707376462844;1451.5137428961416;1455.3960106555874;1458.8176477940258;1462.2323280277726;1486.472302332678;29412.411751764415;30234.84882575573;31011.68988310088;31824.84087579547;32379;51060.48939510706;51737.741311293204;51791.22313165381;51909.48090519047;51910.22134667908;338259;338630;339602;339809;339960;35147.648523514436;35471.467927980586;47961.280580792016;48504.02991940212;49125.263121053926;44071.55928440674;44640.55359446364;44650.776746117364;45091.54908451005;45141;37835.81082094572;37867.24265514619;38195.618043820316;39356.409653854644;40973.795131024155;40585.59414405818;40957.38563921603;41100.588994109676;41221;42221.788891055345;38933.41599876061;38969.610303896596;39891.40162897617;40091.19817603573;40402;34776;35304.29391412106;35342;35753.64246357503;36033.459498107026;27157.72842271552;27568.448631026866;27691.861540692167;27960.86019569889;28069.43861122807 03:49:47 INFO - PROCESS | 5018 | |2;jquery.html;370.2354637673203;379.60141851056386;379.70193398182425;383.1474968195765;384.8152886614425;17729.202185901635;17800.376986805466;18321.541961450937;18364;18485;15201.84798152018;15589.688206235869;15682.84317156828;15704.450344237954;15779.526614201592;5244.895102097956;5618.353889302721;5633.436656334375;5638.069718496464;5699.173619825123;4222.873313800591;5534.08687566551;5864.824055278348;6144.907826382608;6184.474319682809;6015.458608725214;6078.149059131725;6088.512918966494;6103.115048317991;6108.572399932006;5888.499477544414;6013.36859629737;6032.66820324882;6042.607230530001;6051.939480605226;5316.38861530925;5328.813491527817;5342.038433082043;5351.197320401932;5364.544013758835;21589.568208635897;22253.109875604958;22447.663285050738;22756.089756409725;22764;2167.2739632223224;2220.7224096987875;2388.737238903719;2493.4015836199364;2520.3699075231193;9216.723498295061;9792.06975337349;9916.305858589902;11872.643820685393;13527.729445411134;1953.365156324186;1972.1125493527827;2016.3346095788502;2019.7980201979685;2021.9393418197478;67873.64252714918;69987;71064.28935710629;72206.27793722048;72473;10955.4522273886;10979.615713449992;11080.722981925517;11137.387443690675;11147.721306967229;14829.555113346616;14851.108933464027;14917.328720207617;14918.776218356734;14996.550103496695;7786.338161256356;7798.376129909707;7828.099768526578;7921.168277330912;7961.044674639081;7270.163931147986;7274.418046556263;7533.585652789039;7593.772186834404;7638.809029774189;4501.527339629357;4748.453927798348;4760.738159401197;4837.879053023703;4853.93213493031;1831.2668168683406;1839.6320735852883;1894.8578856585812;1906.5614908571106;1937.6478691862874;950.50098698184;953.3469573342283;1014.4927536231884;1057.8466122412208;1071.8754829671575;17183.226754796066;17400.5649858752;17459.650806984042;17692.823071769373;17825.910870445565;1028.881678606955;1034.6482196053378;1036;1079.9136069114452;1105.9723506912392;9864;10186.592536298465;10194.796104078025;10258.17934565233;10361.585536578452;454122;458673;459549;472717;474570;76381;79601.20398796054;80282.5985870067;80618.19381806107;81765;1045.2421994054403;1064.377339256528;1065.4885654885697;1066.9413182274893;1093.6445655161945;15762.921185394;15794.289256983233;15934.362625495314;16062.19689015568;16251.43119990842;33473.83263083669;35722;35831.46252806158;36286.27427451489;37014.25971480609;46973;47191.76404117957;47209.29186062143;47607.28589071098;48785.75607121942;8114;8279.420440569102;8315.916840831514;8325.167483251626;8363.540005299767;9194.816103678022;11393.601223957121;12184.390780461119;12603;12617.93691031539;10929.344239345664;10988.560457581927;11112.888871111185;11179.496922638338;11669.299842009506;10908.78182436331;10970.451477425937;11188.83216751733;11270.211085223955;11273.71815704614;10495.265331426726;12232.938835305766;12251.754964900474;12264.141510094209;12309.26144431337;8336.666533338599;8401.495910245405;8563.571821409028;8598.097199793932;8857.689980850639;8955.462672239426;10962.98956167001;11851.703707407383;11896.76206475883;12000.939995299968 03:49:47 INFO - PROCESS | 5018 | |3;mootools.html;1622.302409963716;1643.7945256842897;1889.168765743073;1926.8362189213917;1974.4076776966906;8246.463979841306;8259.463134896236;8436.662533498653;8513.574321283942;8540.91459085409;8200.630971606277;8275.586220688972;8287.502749835014;8292.668293268262;8297;2477.4178068154015;2483.776460118589;2498.088197807805;2501.2996361018945;2507.9373015674664;2418.51629674065;2420.7216170140396;2462.91379801707;2464.0759715106833;2469.76537228963;2378.21518898763;2398.340456374502;2470.1354525915967;2471.9876400617973;2479.801615870726;2471.308033750544;2473.5300292944285;2488.1167185649106;2505.386180385817;2509.761572650595;2438.0613463816558;2443.3525115844313;2449.8285120041605;2455.2756936703713;2466.962995555068;8239.670413183465;8275.337972962148;8288.336933045402;8306.293965012981;8343.874841877378;5111.386633603991;5235.057689615867;5249.895002099936;5277.234800953878;5282.788688452457;3161.1780936956325;3177.586913701204;3227.080282119585;3337.2991671748964;3377.1894745261206;1005.9949700251525;2027.2904483430682;2062.979370206294;2095.434232757162;2105.494681276498;11651.592194273244;11815.645530634009;11816.05471562273;11832.349220792852;11859.229150105215;4411.713238639478;4503.009337945647;4542.068875880436;4544.454665440168;4556.453225612948;9478.33651644392;9531;9548.045195480536;9555;9559.139677429064;4999.925001124986;5035.093683137071;5058.418281897555;5067.8986420271385;5078.771455284521;4430.800613972379;4583.381243532081;4620.630349572093;4629.236176030917;4644.210484217691;3789.2800367930004;3823.2353529293696;3861.613838616116;3878.7478813877005;3884.5532763731967;1142.4630423700846;1181.2262967756133;1181.468339247342;1183.1185766603935;1185.6265276437894;1428.4072110074203;1457.890658200639;1466.7799830025367;1489.7244009858211;1498.19846382185;8283.461574997606;8315.210055044761;8317.875231871527;8340.708075217339;8352.12302708219;511.74645827982;516.1122868665964;519.6310619460226;522.9032628963578;523.6439221329456;6386.489080873519;6387.489000879918;6439.935600643934;6461.547691661539;6490.448311893448;9969.950150249348;10288.125509331641;10326.586936522604;10412.5834966602;10476.266661333633;9912.801743965225;10182.541785619665;10195.694129176136;10265.230107741949;10280.742981425525;8041.195880412029;8073.475224110414;8085.676572937016;8125.268725814587;8130.75607731769;7701.845963080819;7773.067231932205;7800.063992320957;7891.565963872042;7939.28546430824;8870.802441670292;9071.138241867013;9073.364864459425;9209.263258939403;9209.815803683754;9350.438973661601;9453.054694530767;9480.383775054599;9484.05159484046;9519.857202142111;7022.578645281095;7125.857482850418;7327.2672732726305;7504.362129218859;7515.924840751522;8066.072401673648;8137.389695772959;8144.348452123934;8166.183381662024;8212.507249565046;7260.745873894389;7414.962925185555;7436.479446438698;7461.701531938662;7477.4391920605085;7322.816929576803;7341.77974660761;7395.112586489656;7398.852022959618;7450.813729656802;7718.073831140299;7775.650095745592;7799.844003120019;7803.102643195878;7842;6715;6730.663466826737;6747.527673062838;6837;6853.588784672936;7055.2591977841585;7140.285971402818;7141.357277845019;7156.677949492181;7214.2064372917885 03:49:47 INFO - PROCESS | 5018 | |4;prototype.html;318.22829638127536;330.36404920527985;330.4349562248555;338.6478062814673;339.1774945756541;6434;6438.163038804954;6448.64532450715;6450.483961283097;6491.8377040574005;6335.904961425582;6345.143405640237;6354.14219080424;6367.33143019982;6389.297177310504;4654.790534425959;4774.665773395864;4801.2798080287885;4809.975950120244;4854.126257273698;4786.83246086387;4809.735464549449;4825.131476334276;4825.638077144228;4833.3958255218095;4718.952810471886;4751.14479393709;4761.333413322138;4762.071396077767;4773;4765.8570242892765;4769.451513075988;4773.785179666923;4777.163996300634;4788.545088216614;4123.731957422788;4123.97938010308;4129.050318426779;4132.359484279911;4133.731307465036;6001.811792579578;6073.969630151865;6099.69501524922;6103.206583144207;6138.84652883677;5492.258545096401;5560.833175004756;5562.3047119110115;5572.944270557283;5577.860553486195;6688.665566721645;6710.7315707371645;6737.124173857416;6740.224874139439;6745.494087943423;4500.707454015478;4524.864254072383;4527.773611319454;4532.954670453286;4536.888462326718;6995.825104372431;7003.754868579626;7009.579425234502;7039.507234493536;7094.68073936674;4579.816807327669;4674.11191873543;4675.111728771522;4679.415073115861;4688;4725.432948046187;4751.073540659608;4753.453352864396;4761.857144285677;4763.904721905612;5490.56075513958;5499.285092937893;5511.173324001432;5513.751881165357;5514.255575497256;6758.493113016445;6817.659117044128;6818.4886133540185;6834.077399550997;6838.863222735517;1629.6903588318182;1677.5973766296001;1681.1510187355307;1681.4955513345947;1682.066453118531;1072.3244356055634;1080.4813689429118;1089.1341383600056;1096.2874131814226;1112.821948488238;6568.86862262752;6604.933950660528;6605.504587155982;6607.504437167232;6673.866522669519;6982.895256571155;7009.12385951756;7017.122859642544;7017.438604911595;7045.436365090781;6359.491240700733;6449.484041276686;6642.169728783902;6642.568233064835;6664.333566643297;3760.511133552621;3781.7920014399474;3811.7141214408475;3815.198808250243;3830.8467661293794;7330.120385553661;7367.079115110611;7409;7424.962875185697;7441.702331906771;7229.89155162673;7314.634268286564;7316.853662926712;7319;7319.670614822346;7144.8928266076055;7318.377937875233;7433.182349941502;7445.143808461988;7450.329470347587;7101.7159313628945;7120.501564890408;7123.287671233043;7140.214576396696;7157.069580954442;6992.965035174791;7002.964985175042;7010.123734533184;7014.579125252501;7017;7353.8161545961775;7356.96321518389;7372.373348265243;7384.187739348775;7388.335049845325;4503.5946764790015;4577.496475387638;4614.146382919036;4621.168189725881;4645.326427668037;7042.978768078702;7045.11936007999;7066.681999309941;7069.893951590833;7110.928890711027;6843.931560684329;6892.827679308058;6899.413549848118;6906.896396554156;6910.343517366044;6876.759313424006;6885.586864788129;6892.931070689229;6898.309914071085;6908.723651053901;6573.211214654081;6731.831704207434;6785.898211526733;6820.420264277592;6820.624865632438;6906.447484201352;6909.7581584644295;6913.481488888253;6948.33990770876;6953.860922781415;6722.9663851680425;6742.86514269702;6757.898631520629;6768.187817461936;6779.932200678128 03:49:47 INFO - PROCESS | 5018 | |5;yui.html;803.9477433966791;875.3916028360288;890.363390176024;898.5462341517533;899.8290324838279;13946.163230206195;14214.78677819831;14247;14283.571492855219;14296.428142874272;13518.594442166726;13534;13597.728045439086;13608.795868061963;13627.523036693718;763.7861398808343;900.3877363392891;914.1589737441553;917.8898532176148;920.0983036624112;897.7935074932769;902.1474706402453;907.2696479334134;910.6129894794719;916.0884919505102;951.6098399656142;951.9619215231417;954.4607296877277;955.3360414511917;962.2927148545813;932.0306880843914;941.23759754599;941.9529023548829;945.3571571331491;948.5873644964428;710.5097482736895;711.9252478489735;713.750187434399;713.83938613812;716.187127610161;13795.10331828438;13884.652883677887;13913.443462261497;13921.721565568732;13942.093763905314;12609.873901260962;12710.491580336868;12898.935505322506;13003.934980325037;13329;10388.428636424993;10440.530176142016;10614.257002009863;10710.250282480229;10809.189310801721;3472.9581125662453;3501.422265326218;3524.1718196223865;3537.345591065661;3564.1267889367273;50670.7466462669;50742.49257507452;50771.74614126905;51696.22455663168;53439.19841202424;9726.95136524327;9778;9802.65690700822;9804.950975245078;9810.11708946184;17653.205605747517;17689.823101769074;17706.20322085509;17720.734188987175;17785.199666014803;7566.24337566239;7648.42636802242;7662.233776622294;7717.382609391235;7779.649915753805;3903.434002069684;3995.700322475826;4129.91740165195;4182.1008483176265;4210.989362553027;3263.608366995928;3277.311764529428;3293.4236508610898;3308.503724441353;3308.9172770680443;621.4158690830695;622.5766478794372;631.0660222870086;634.014108061968;635.0474288567149;703.736098962889;708.8334241453255;709.7622296530617;715.1704023332909;726.6766289001343;8573.09982451846;8662.436941598777;8769.517676527725;8772.736817895346;8867.423617464845;654.8952167653152;736.5507040705165;747.1818358896999;758.3857075768645;767.7850201943464;4212.473440819897;4411.470623525198;4527.61515271199;4529.909401811945;4601.148787474328;62141.378586214465;63273.683631581545;63435.048474272924;63546;63609;55165.44834551684;55800.16299755507;56368.718156408955;56769.336139621446;56956.86086278334;48502.5149748498;49119.50880491149;49736.0052798942;49917.25124123141;51430.48569514257;8767.167119123673;8818.42853644275;8871.600777964877;9036.45781253127;9157.175854173156;36265.456018159224;36757.26485470329;37188.81405592955;37337;37650.246995060494;44308.556914430446;44550.3317450232;47445.288320674525;49009.50990490049;49166.75416623037;11440.94279528597;11636.76726465449;11682.591109311134;11754.23597466162;11763.176577639482;11410.201285909907;11655.417229138679;11831.11266654987;11851.762964740828;11923.880761192624;11651.30092194471;11757.412129393326;11848.881511185122;11989.880101198876;12082.637520874388;11823.467943942715;11929.28424294545;11937.940310298392;12177.269363838199;12301.692457688272;10993.560257589606;11052.11583073336;11192.83210751823;11647;11852.822207667065;9249.853926018995;9421.340506164777;9553.713388598353;9609.279304052365;10065;9698.224142068477;9880.752981175528;10008.14930730896;10091.7477063074;10118.595256189965 03:49:47 INFO - PROCESS | 5018 | __end_tp_report 03:49:47 INFO - PROCESS | 5018 | __start_cc_report 03:49:47 INFO - PROCESS | 5018 | _x_x_mozilla_cycle_collect,344 03:49:47 INFO - PROCESS | 5018 | __end_cc_report 03:49:47 INFO - PROCESS | 5018 | __startTimestamp1458384587299__endTimestamp 03:49:47 INFO - PROCESS | 5018 | 03:49:47 INFO - PROCESS | 5018 | ------- Summary: start ------- 03:49:47 INFO - PROCESS | 5018 | Number of tests: 6 03:49:47 INFO - PROCESS | 5018 | 03:49:47 INFO - PROCESS | 5018 | [#0] dojo.html Cycles:165 Average:5626.18 Median:5865.56 stddev:643.69 (11.0%) stddev-sans-first:619.48 03:49:47 INFO - PROCESS | 5018 | Values: 3309.5 3371.7 3378.0 3403.7 3417.0 5556.5 5599.6 5621.5 5624.5 5643.3 5590.3 5593.0 5626.6 5629.5 5638.8 5095.8 5176.1 5178.4 5212.9 5213.6 4979.7 5107.9 5227.8 5245.9 5245.9 5162.6 5176.6 5237.7 5271.7 5292.4 5183.0 5184.4 5186.3 5186.7 5225.4 4877.5 5000.2 5016.3 5030.5 5169.3 5421.9 5434.7 5457.7 5458.7 5473.8 6014.1 6037.9 6066.4 6068.4 6077.7 6039.2 6113.0 6117.1 6132.3 6139.3 5625.4 5650.2 5659.9 5661.0 5663.2 6015.0 6113.7 6166.2 6177.9 6178.8 5940.4 6008.6 6017.2 6022.7 6025.9 6081.8 6089.0 6094.3 6107.6 6110.1 5893.9 6002.9 6045.4 6052.3 6068.4 5963.3 6005.5 6035.4 6056.3 6057.1 4576.6 4580.8 4598.8 4611.1 4620.1 4030.6 4070.3 4079.8 4129.2 4165.8 5660.4 5732.1 5767.0 5786.5 5842.4 6115.9 6138.7 6138.8 6139.5 6167.5 5647.0 5718.9 5839.5 5843.7 5846.6 5060.1 5075.5 5081.1 5081.2 5102.0 6319.4 6319.7 6324.9 6338.1 6346.8 5917.2 5977.5 6034.2 6045.5 6108.1 6296.5 6331.3 6335.6 6339.6 6343.4 5985.2 6050.2 6051.8 6062.7 6068.0 6008.9 6121.6 6143.7 6146.0 6170.1 5842.6 5880.1 5928.8 5936.3 5937.4 5722.0 5865.6 5870.1 5894.3 5923.2 5853.9 5893.2 5894.7 5921.4 5952.5 5984.0 5997.1 6007.3 6019.5 6025.4 5657.3 5758.8 5856.2 5865.1 5868.9 03:49:47 INFO - PROCESS | 5018 | 03:49:47 INFO - PROCESS | 5018 | [#1] ext.html Cycles:180 Average:55311.22 Median:40499.20 stddev:108923.27 (269.0%) stddev-sans-first:109151.20 03:49:47 INFO - PROCESS | 5018 | Values: 540.2 565.9 595.4 620.7 627.6 37403.3 39105.6 39137.2 39275.4 39443.0 40785.0 41325.0 41369.2 41508.0 41761.0 8689.7 8828.3 8897.4 8899.0 8903.0 8627.1 9014.0 9028.2 9054.1 9105.0 9045.5 9149.3 9194.1 9196.4 9201.0 9071.6 9113.3 9129.9 9145.1 9159.0 8924.8 9051.4 9057.9 9062.6 9068.4 33251.2 40412.8 40990.6 40998.8 41031.4 3635.8 3730.3 3775.3 3848.1 3896.8 28707.9 31623.2 32001.5 32271.0 32585.3 4133.2 4133.7 4161.0 4178.0 4187.0 259847.0 261655.0 262128.0 262738.0 263990.4 46183.3 62806.7 63338.0 63395.4 63411.7 48702.5 48740.5 48844.3 48951.3 49079.0 14477.9 14541.9 14559.9 14589.6 14663.7 11995.6 12180.2 12195.6 12196.0 12205.5 15835.9 15837.8 15868.0 15910.5 16040.5 6144.6 6309.0 6416.6 6424.3 6428.8 996.8 1003.6 1059.7 1080.7 1110.6 30450.5 31009.2 31010.2 31423.7 31548.5 997.0 1096.3 1180.5 1213.4 1273.4 15667.8 15869.9 16253.8 16372.2 16437.1 540392.0 563826.0 571057.0 574381.0 574677.0 57912.1 58421.0 58491.0 58506.0 58524.7 1451.5 1455.4 1458.8 1462.2 1486.5 29412.4 30234.8 31011.7 31824.8 32379.0 51060.5 51737.7 51791.2 51909.5 51910.2 338259.0 338630.0 339602.0 339809.0 339960.0 35147.6 35471.5 47961.3 48504.0 49125.3 44071.6 44640.6 44650.8 45091.5 45141.0 37835.8 37867.2 38195.6 39356.4 40973.8 40585.6 40957.4 41100.6 41221.0 42221.8 38933.4 38969.6 39891.4 40091.2 40402.0 34776.0 35304.3 35342.0 35753.6 36033.5 27157.7 27568.4 27691.9 27960.9 28069.4 03:49:47 INFO - PROCESS | 5018 | 03:49:47 INFO - PROCESS | 5018 | [#2] jquery.html Cycles:180 Average:26842.51 Median:2506.89 stddev:76145.40 (3037.4%) stddev-sans-first:76333.06 03:49:47 INFO - PROCESS | 5018 | Values: 370.2 379.6 379.7 383.1 384.8 17729.2 17800.4 18321.5 18364.0 18485.0 15201.8 15589.7 15682.8 15704.5 15779.5 5244.9 5618.4 5633.4 5638.1 5699.2 4222.9 5534.1 5864.8 6144.9 6184.5 6015.5 6078.1 6088.5 6103.1 6108.6 5888.5 6013.4 6032.7 6042.6 6051.9 5316.4 5328.8 5342.0 5351.2 5364.5 21589.6 22253.1 22447.7 22756.1 22764.0 2167.3 2220.7 2388.7 2493.4 2520.4 9216.7 9792.1 9916.3 11872.6 13527.7 1953.4 1972.1 2016.3 2019.8 2021.9 67873.6 69987.0 71064.3 72206.3 72473.0 10955.5 10979.6 11080.7 11137.4 11147.7 14829.6 14851.1 14917.3 14918.8 14996.6 7786.3 7798.4 7828.1 7921.2 7961.0 7270.2 7274.4 7533.6 7593.8 7638.8 4501.5 4748.5 4760.7 4837.9 4853.9 1831.3 1839.6 1894.9 1906.6 1937.6 950.5 953.3 1014.5 1057.8 1071.9 17183.2 17400.6 17459.7 17692.8 17825.9 1028.9 1034.6 1036.0 1079.9 1106.0 9864.0 10186.6 10194.8 10258.2 10361.6 454122.0 458673.0 459549.0 472717.0 474570.0 76381.0 79601.2 80282.6 80618.2 81765.0 1045.2 1064.4 1065.5 1066.9 1093.6 15762.9 15794.3 15934.4 16062.2 16251.4 33473.8 35722.0 35831.5 36286.3 37014.3 46973.0 47191.8 47209.3 47607.3 48785.8 8114.0 8279.4 8315.9 8325.2 8363.5 9194.8 11393.6 12184.4 12603.0 12617.9 10929.3 10988.6 11112.9 11179.5 11669.3 10908.8 10970.5 11188.8 11270.2 11273.7 10495.3 12232.9 12251.8 12264.1 12309.3 8336.7 8401.5 8563.6 8598.1 8857.7 8955.5 10963.0 11851.7 11896.8 12000.9 03:49:47 INFO - PROCESS | 5018 | 03:49:47 INFO - PROCESS | 5018 | [#3] mootools.html Cycles:180 Average:5931.56 Median:5263.56 stddev:3069.32 (58.3%) stddev-sans-first:3060.84 03:49:47 INFO - PROCESS | 5018 | Values: 1622.3 1643.8 1889.2 1926.8 1974.4 8246.5 8259.5 8436.7 8513.6 8540.9 8200.6 8275.6 8287.5 8292.7 8297.0 2477.4 2483.8 2498.1 2501.3 2507.9 2418.5 2420.7 2462.9 2464.1 2469.8 2378.2 2398.3 2470.1 2472.0 2479.8 2471.3 2473.5 2488.1 2505.4 2509.8 2438.1 2443.4 2449.8 2455.3 2467.0 8239.7 8275.3 8288.3 8306.3 8343.9 5111.4 5235.1 5249.9 5277.2 5282.8 3161.2 3177.6 3227.1 3337.3 3377.2 1006.0 2027.3 2063.0 2095.4 2105.5 11651.6 11815.6 11816.1 11832.3 11859.2 4411.7 4503.0 4542.1 4544.5 4556.5 9478.3 9531.0 9548.0 9555.0 9559.1 4999.9 5035.1 5058.4 5067.9 5078.8 4430.8 4583.4 4620.6 4629.2 4644.2 3789.3 3823.2 3861.6 3878.7 3884.6 1142.5 1181.2 1181.5 1183.1 1185.6 1428.4 1457.9 1466.8 1489.7 1498.2 8283.5 8315.2 8317.9 8340.7 8352.1 511.7 516.1 519.6 522.9 523.6 6386.5 6387.5 6439.9 6461.5 6490.4 9970.0 10288.1 10326.6 10412.6 10476.3 9912.8 10182.5 10195.7 10265.2 10280.7 8041.2 8073.5 8085.7 8125.3 8130.8 7701.8 7773.1 7800.1 7891.6 7939.3 8870.8 9071.1 9073.4 9209.3 9209.8 9350.4 9453.1 9480.4 9484.1 9519.9 7022.6 7125.9 7327.3 7504.4 7515.9 8066.1 8137.4 8144.3 8166.2 8212.5 7260.7 7415.0 7436.5 7461.7 7477.4 7322.8 7341.8 7395.1 7398.9 7450.8 7718.1 7775.7 7799.8 7803.1 7842.0 6715.0 6730.7 6747.5 6837.0 6853.6 7055.3 7140.3 7141.4 7156.7 7214.2 03:49:47 INFO - PROCESS | 5018 | 03:49:47 INFO - PROCESS | 5018 | [#4] prototype.html Cycles:180 Average:5672.42 Median:6471.16 stddev:1769.45 (27.3%) stddev-sans-first:1728.17 03:49:47 INFO - PROCESS | 5018 | Values: 318.2 330.4 330.4 338.6 339.2 6434.0 6438.2 6448.6 6450.5 6491.8 6335.9 6345.1 6354.1 6367.3 6389.3 4654.8 4774.7 4801.3 4810.0 4854.1 4786.8 4809.7 4825.1 4825.6 4833.4 4719.0 4751.1 4761.3 4762.1 4773.0 4765.9 4769.5 4773.8 4777.2 4788.5 4123.7 4124.0 4129.1 4132.4 4133.7 6001.8 6074.0 6099.7 6103.2 6138.8 5492.3 5560.8 5562.3 5572.9 5577.9 6688.7 6710.7 6737.1 6740.2 6745.5 4500.7 4524.9 4527.8 4533.0 4536.9 6995.8 7003.8 7009.6 7039.5 7094.7 4579.8 4674.1 4675.1 4679.4 4688.0 4725.4 4751.1 4753.5 4761.9 4763.9 5490.6 5499.3 5511.2 5513.8 5514.3 6758.5 6817.7 6818.5 6834.1 6838.9 1629.7 1677.6 1681.2 1681.5 1682.1 1072.3 1080.5 1089.1 1096.3 1112.8 6568.9 6604.9 6605.5 6607.5 6673.9 6982.9 7009.1 7017.1 7017.4 7045.4 6359.5 6449.5 6642.2 6642.6 6664.3 3760.5 3781.8 3811.7 3815.2 3830.8 7330.1 7367.1 7409.0 7425.0 7441.7 7229.9 7314.6 7316.9 7319.0 7319.7 7144.9 7318.4 7433.2 7445.1 7450.3 7101.7 7120.5 7123.3 7140.2 7157.1 6993.0 7003.0 7010.1 7014.6 7017.0 7353.8 7357.0 7372.4 7384.2 7388.3 4503.6 4577.5 4614.1 4621.2 4645.3 7043.0 7045.1 7066.7 7069.9 7110.9 6843.9 6892.8 6899.4 6906.9 6910.3 6876.8 6885.6 6892.9 6898.3 6908.7 6573.2 6731.8 6785.9 6820.4 6820.6 6906.4 6909.8 6913.5 6948.3 6953.9 6723.0 6742.9 6757.9 6768.2 6779.9 03:49:47 INFO - PROCESS | 5018 | 03:49:47 INFO - PROCESS | 5018 | [#5] yui.html Cycles:180 Average:14539.72 Median:49451.38 stddev:17265.87 (34.9%) stddev-sans-first:17283.49 03:49:47 INFO - PROCESS | 5018 | Values: 803.9 875.4 890.4 898.5 899.8 13946.2 14214.8 14247.0 14283.6 14296.4 13518.6 13534.0 13597.7 13608.8 13627.5 763.8 900.4 914.2 917.9 920.1 897.8 902.1 907.3 910.6 916.1 951.6 952.0 954.5 955.3 962.3 932.0 941.2 942.0 945.4 948.6 710.5 711.9 713.8 713.8 716.2 13795.1 13884.7 13913.4 13921.7 13942.1 12609.9 12710.5 12898.9 13003.9 13329.0 10388.4 10440.5 10614.3 10710.3 10809.2 3473.0 3501.4 3524.2 3537.3 3564.1 50670.7 50742.5 50771.7 51696.2 53439.2 9727.0 9778.0 9802.7 9805.0 9810.1 17653.2 17689.8 17706.2 17720.7 17785.2 7566.2 7648.4 7662.2 7717.4 7779.6 3903.4 3995.7 4129.9 4182.1 4211.0 3263.6 3277.3 3293.4 3308.5 3308.9 621.4 622.6 631.1 634.0 635.0 703.7 708.8 709.8 715.2 726.7 8573.1 8662.4 8769.5 8772.7 8867.4 654.9 736.6 747.2 758.4 767.8 4212.5 4411.5 4527.6 4529.9 4601.1 62141.4 63273.7 63435.0 63546.0 63609.0 55165.4 55800.2 56368.7 56769.3 56956.9 48502.5 49119.5 49736.0 49917.3 51430.5 8767.2 8818.4 8871.6 9036.5 9157.2 36265.5 36757.3 37188.8 37337.0 37650.2 44308.6 44550.3 47445.3 49009.5 49166.8 11440.9 11636.8 11682.6 11754.2 11763.2 11410.2 11655.4 11831.1 11851.8 11923.9 11651.3 11757.4 11848.9 11989.9 12082.6 11823.5 11929.3 11937.9 12177.3 12301.7 10993.6 11052.1 11192.8 11647.0 11852.8 9249.9 9421.3 9553.7 9609.3 10065.0 9698.2 9880.8 10008.1 10091.7 10118.6 03:49:47 INFO - PROCESS | 5018 | -------- Summary: end -------- 03:49:47 INFO - PROCESS | 5018 | 03:49:47 INFO - TEST-INFO | 5018: exit 0 03:49:48 INFO - TEST-OK | dromaeo_css | took 1109782ms 03:49:48 INFO - TEST-START | kraken 03:49:48 INFO - operating with platform_type : linux_ 03:49:48 INFO - Initialising browser for kraken test... 03:49:48 INFO - TEST-INFO | started process 5264 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcSL2_e/profile http://localhost:50364/getInfo.html) 03:49:51 INFO - PROCESS | 5264 | 03:49:51 INFO - PROCESS | 5264 | (process:5337): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:49:52 INFO - PROCESS | 5264 | __metrics Screen width/height:1600/1200 03:49:52 INFO - PROCESS | 5264 | colorDepth:24 03:49:52 INFO - PROCESS | 5264 | Browser inner width/height: 1024/697 03:49:52 INFO - PROCESS | 5264 | __metrics 03:49:53 ERROR - PROCESS | 5264 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:49:54 INFO - TEST-INFO | 5264: exit 0 03:49:54 INFO - Browser initialized. 03:49:54 INFO - Running cycle 1/1 for kraken test... 03:49:54 INFO - TEST-INFO | started process 5388 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcSL2_e/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:55 INFO - PROCESS | 5388 | 03:49:55 INFO - PROCESS | 5388 | (process:5458): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:50:05 INFO - PROCESS | 5388 | RSS: Main: 154472448 03:50:05 INFO - PROCESS | 5388 | 03:50:08 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50364/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:09 INFO - PROCESS | 5388 | RSS: Main: 159219712 03:50:09 INFO - PROCESS | 5388 | 03:50:11 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50364/tests/kraken/driver.html?testName=audio-dft) 03:50:12 INFO - PROCESS | 5388 | RSS: Main: 158220288 03:50:12 INFO - PROCESS | 5388 | 03:50:15 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50364/tests/kraken/driver.html?testName=audio-fft) 03:50:15 INFO - PROCESS | 5388 | RSS: Main: 158658560 03:50:15 INFO - PROCESS | 5388 | 03:50:17 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50364/tests/kraken/driver.html?testName=audio-oscillator) 03:50:18 INFO - PROCESS | 5388 | RSS: Main: 157917184 03:50:18 INFO - PROCESS | 5388 | 03:50:20 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50364/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:21 INFO - PROCESS | 5388 | RSS: Main: 157999104 03:50:21 INFO - PROCESS | 5388 | 03:50:24 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50364/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:24 INFO - PROCESS | 5388 | RSS: Main: 157814784 03:50:24 INFO - PROCESS | 5388 | 03:50:28 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50364/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:28 INFO - PROCESS | 5388 | RSS: Main: 158859264 03:50:28 INFO - PROCESS | 5388 | 03:50:31 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50364/tests/kraken/driver.html?testName=json-parse-financial) 03:50:32 INFO - PROCESS | 5388 | RSS: Main: 157999104 03:50:32 INFO - PROCESS | 5388 | 03:50:33 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50364/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:34 INFO - PROCESS | 5388 | RSS: Main: 159465472 03:50:34 INFO - PROCESS | 5388 | 03:50:36 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:36 INFO - PROCESS | 5388 | RSS: Main: 157298688 03:50:36 INFO - PROCESS | 5388 | 03:50:38 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:39 INFO - PROCESS | 5388 | RSS: Main: 158474240 03:50:39 INFO - PROCESS | 5388 | 03:50:41 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:42 INFO - PROCESS | 5388 | RSS: Main: 158863360 03:50:42 INFO - PROCESS | 5388 | 03:50:44 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:45 INFO - PROCESS | 5388 | RSS: Main: 158629888 03:50:45 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50364/tests/kraken/driver.html?testName=ai-astar) 03:50:47 INFO - PROCESS | 5388 | RSS: Main: 160022528 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | __start_tp_report 03:50:47 INFO - PROCESS | 5388 | _x_x_mozilla_page_load 03:50:47 INFO - PROCESS | 5388 | _x_x_mozilla_page_load_details 03:50:47 INFO - PROCESS | 5388 | |i|pagename|runs| 03:50:47 INFO - PROCESS | 5388 | |0;ai-astar;111;104;111;109;111;122;110;110;111;109 03:50:47 INFO - PROCESS | 5388 | |1;audio-beat-detection;153;132;149;164;132;152;162;126;169;134 03:50:47 INFO - PROCESS | 5388 | |2;audio-dft;161;162;162;168;160;163;162;161;164;162 03:50:47 INFO - PROCESS | 5388 | |3;audio-fft;75;73;76;158;74;75;74;74;157;76 03:50:47 INFO - PROCESS | 5388 | |4;audio-oscillator;93;94;144;93;94;94;146;93;94;143 03:50:47 INFO - PROCESS | 5388 | |5;imaging-gaussian-blur;118;117;117;117;116;117;118;118;118;117 03:50:47 INFO - PROCESS | 5388 | |6;imaging-darkroom;147;146;146;146;147;149;146;148;147;146 03:50:47 INFO - PROCESS | 5388 | |7;imaging-desaturate;96;97;98;96;98;96;96;97;96;96 03:50:47 INFO - PROCESS | 5388 | |8;json-parse-financial;55;56;64;56;57;56;60;63;55;64 03:50:47 INFO - PROCESS | 5388 | |9;json-stringify-tinderbox;65;65;67;67;65;65;65;66;65;66 03:50:47 INFO - PROCESS | 5388 | |10;stanford-crypto-aes;78;78;80;82;77;86;79;78;79;80 03:50:47 INFO - PROCESS | 5388 | |11;stanford-crypto-ccm;111;116;117;119;127;116;122;115;116;117 03:50:47 INFO - PROCESS | 5388 | |12;stanford-crypto-pbkdf2;159;146;153;144;147;138;147;161;150;134 03:50:47 INFO - PROCESS | 5388 | |13;stanford-crypto-sha256-iterative;66;70;67;66;65;64;66;66;67;65 03:50:47 INFO - PROCESS | 5388 | __end_tp_report 03:50:47 INFO - PROCESS | 5388 | __start_cc_report 03:50:47 INFO - PROCESS | 5388 | _x_x_mozilla_cycle_collect,850 03:50:47 INFO - PROCESS | 5388 | __end_cc_report 03:50:47 INFO - PROCESS | 5388 | __startTimestamp1458384647499__endTimestamp 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | ------- Summary: start ------- 03:50:47 INFO - PROCESS | 5388 | Number of tests: 14 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:4.47 (4.0%) stddev-sans-first:4.74 03:50:47 INFO - PROCESS | 5388 | Values: 111.0 104.0 111.0 109.0 111.0 122.0 110.0 110.0 111.0 109.0 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:152.50 stddev:15.36 (10.1%) stddev-sans-first:16.15 03:50:47 INFO - PROCESS | 5388 | Values: 153.0 132.0 149.0 164.0 132.0 152.0 162.0 126.0 169.0 134.0 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:2.22 (1.4%) stddev-sans-first:2.29 03:50:47 INFO - PROCESS | 5388 | Values: 161.0 162.0 162.0 168.0 160.0 163.0 162.0 161.0 164.0 162.0 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#3] audio-fft Cycles:10 Average:91.20 Median:74.50 stddev:34.96 (46.9%) stddev-sans-first:36.58 03:50:47 INFO - PROCESS | 5388 | Values: 75.0 73.0 76.0 158.0 74.0 75.0 74.0 74.0 157.0 76.0 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:93.50 stddev:24.53 (26.2%) stddev-sans-first:25.35 03:50:47 INFO - PROCESS | 5388 | Values: 93.0 94.0 144.0 93.0 94.0 94.0 146.0 93.0 94.0 143.0 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 03:50:47 INFO - PROCESS | 5388 | Values: 118.0 117.0 117.0 117.0 116.0 117.0 118.0 118.0 118.0 117.0 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 03:50:47 INFO - PROCESS | 5388 | Values: 147.0 146.0 146.0 146.0 147.0 149.0 146.0 148.0 147.0 146.0 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 03:50:47 INFO - PROCESS | 5388 | Values: 96.0 97.0 98.0 96.0 98.0 96.0 96.0 97.0 96.0 96.0 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.50 stddev:3.78 (6.5%) stddev-sans-first:3.77 03:50:47 INFO - PROCESS | 5388 | Values: 55.0 56.0 64.0 56.0 57.0 56.0 60.0 63.0 55.0 64.0 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 03:50:47 INFO - PROCESS | 5388 | Values: 65.0 65.0 67.0 67.0 65.0 65.0 65.0 66.0 65.0 66.0 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:2.63 (3.3%) stddev-sans-first:2.71 03:50:47 INFO - PROCESS | 5388 | Values: 78.0 78.0 80.0 82.0 77.0 86.0 79.0 78.0 79.0 80.0 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:117.00 stddev:4.33 (3.7%) stddev-sans-first:3.87 03:50:47 INFO - PROCESS | 5388 | Values: 111.0 116.0 117.0 119.0 127.0 116.0 122.0 115.0 116.0 117.0 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:148.50 stddev:8.41 (5.7%) stddev-sans-first:7.91 03:50:47 INFO - PROCESS | 5388 | Values: 159.0 146.0 153.0 144.0 147.0 138.0 147.0 161.0 150.0 134.0 03:50:47 INFO - PROCESS | 5388 | 03:50:47 INFO - PROCESS | 5388 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.62 (2.5%) stddev-sans-first:1.72 03:50:47 INFO - PROCESS | 5388 | Values: 66.0 70.0 67.0 66.0 65.0 64.0 66.0 66.0 67.0 65.0 03:50:47 INFO - PROCESS | 5388 | -------- Summary: end -------- 03:50:47 INFO - PROCESS | 5388 | 03:50:48 INFO - TEST-INFO | 5388: exit 0 03:50:48 INFO - TEST-OK | kraken | took 60402ms 03:50:48 INFO - SUITE-END | took 1170s 03:50:48 INFO - Completed test suite (00:19:30) 03:50:48 INFO - javascript benchmark 03:50:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3309.4704847224443, 3371.730261579073, 3378.0203740915103, 3403.693667569918, 3417.0090673704626, 5556.472135147164, 5599.580031497633, 5621.465960733729, 5624.493795558399, 5643.266375371201, 5590.329160500735, 5593.049181639121, 5626.634268772527, 5629.465200805927, 5638.802641907534, 5095.7706903189355, 5176.0683077046115, 5178.378594568657, 5212.895742085156, 5213.635045546814, 4979.7261150636705, 5107.897842043157, 5227.7908883644795, 5245.868853278679, 5245.921311180336, 5162.586993040548, 5176.5858731301405, 5237.711925844077, 5271.736413179326, 5292.36491621006, 5182.974085129569, 5184.377874655047, 5186.273921650972, 5186.7147306898105, 5225.425203227642, 4877.487863774288, 5000.249962505617, 5016.272640467148, 5030.471800460972, 5169.302144210521, 5421.918671219935, 5434.673919564839, 5457.699826509541, 5458.727063646841, 5473.8357849264585, 6014.097885317194, 6037.9396206038255, 6066.373378904193, 6068.393160683941, 6077.696115194222, 6039.184710064173, 6113.046074236234, 6117.113018612276, 6132.268530072373, 6139.308154111995, 5625.437456254383, 5650.208970744099, 5659.886802263973, 5661.009323368394, 5663.207150998864, 6015.0, 6113.719560719409, 6166.1983942087245, 6177.907331390033, 6178.783742568989, 5940.435658612425, 6008.639481631116, 6017.157597936292, 6022.668753218615, 6025.9397406026255, 6081.787137450168, 6088.995315772936, 6094.329623741385, 6107.603005804608, 6110.144579758838, 5893.882122357529, 6002.879942401215, 6045.425684559959, 6052.303985041688, 6068.393160683984, 5963.254593175853, 6005.519558435315, 6035.366286539938, 6056.273247210363, 6057.061155520902, 4576.633869290516, 4580.7938642761155, 4598.770061496912, 4611.100835337077, 4620.1221767864, 4030.6170913763144, 4070.3080476319096, 4079.8164082616354, 4129.215449064668, 4165.770882601425, 5660.433956604306, 5732.082866741302, 5767.048437007847, 5786.479216870502, 5842.444967728059, 6115.938840611626, 6138.693065346715, 6138.846528836815, 6139.508839292846, 6167.475764559973, 5647.0, 5718.857028574235, 5839.503642190376, 5843.707814609337, 5846.561507886926, 5060.114479965991, 5075.492450754895, 5081.110805609003, 5081.2378143278065, 5102.0, 6319.399657032574, 6319.715612797435, 6324.873502529924, 6338.144350512714, 6346.809595712044, 5917.230760001173, 5977.491913187428, 6034.2155519782145, 6045.455908968126, 6108.11432342299, 6296.527760418078, 6331.303556608677, 6335.588186767845, 6339.5562310637815, 6343.397377249154, 5985.191999080069, 6050.152978582913, 6051.818445446644, 6062.727177277121, 6068.029115341524, 6008.87982240344, 6121.632702037714, 6143.72353244114, 6146.0, 6170.074488826533, 5842.560562219908, 5880.059190529495, 5928.822135335947, 5936.347001829881, 5937.435943585352, 5721.971390143022, 5865.5600829937075, 5870.119482077723, 5894.322152952465, 5923.229980102731, 5853.882922341614, 5893.174955506318, 5894.6757928314355, 5921.3782552831335, 5952.523798096228, 5984.042553191469, 5997.070454079625, 6007.279126504847, 6019.51843852482, 6025.397460254115, 5657.2928383952, 5758.827235182951, 5856.180134781049, 5865.14955331466, 5868.94131058701], "unit": "score", "name": "dojo.html", "value": 5583.14164133227}, {"lowerIsBetter": false, "replicates": [540.1818674591825, 565.8924804287186, 595.416491837999, 620.6927570852428, 627.6391075131801, 37403.251934961285, 39105.60894391055, 39137.217255654905, 39275.41086883699, 39443.0, 40785.0, 41325.0, 41369.17261654765, 41508.0, 41761.0, 8689.652413903452, 8828.337874659393, 8897.421667591618, 8898.955505222497, 8903.0, 8627.137286271354, 9014.0, 9028.187463128317, 9054.139856713602, 9104.999999999967, 9045.502497362642, 9149.313801464883, 9194.12655797698, 9196.356255062148, 9201.033891441402, 9071.59177836999, 9113.3165012624, 9129.908700912973, 9145.131212534832, 9159.0, 8924.821503569958, 9051.366404351698, 9057.909420905773, 9062.637494500212, 9068.365214434993, 33251.168720781934, 40412.79793601013, 40990.59009409927, 40998.79500602508, 41031.384529232084, 3635.763675361093, 3730.2539492101687, 3775.263823554408, 3848.0956975110826, 3896.766194028339, 28707.856460717772, 31623.20941976446, 32001.51997720036, 32271.0, 32585.348293034243, 4133.235351459959, 4133.7106402551835, 4160.966034144296, 4178.0, 4186.958130418688, 259847.0, 261655.0, 262128.0, 262737.9999999981, 263990.3600963985, 46183.30725039127, 62806.68596656987, 63338.0, 63395.36604633987, 63411.68294158592, 48702.51297487051, 48740.51259487431, 48844.267335989985, 48951.265731014064, 49079.0, 14477.855221447651, 14541.854581454261, 14559.854401456061, 14589.562313130624, 14663.706725865422, 11995.580154694544, 12180.208286461351, 12195.634130976085, 12196.0, 12205.45075471606, 15835.920820396055, 15837.762433563506, 15868.0, 15910.522684319489, 16040.518784436252, 6144.631322120687, 6308.968455157695, 6416.647084410309, 6424.261209960914, 6428.8071357859335, 996.7956568903357, 1003.5584342889106, 1059.7244716373798, 1080.7244152741, 1110.5502271580024, 30450.54324185139, 31009.224769380948, 31010.224744381572, 31423.685763142534, 31548.526772098438, 997.0308640435228, 1096.276457538021, 1180.4569897847086, 1213.3629844331797, 1273.420593629896, 15667.843321566867, 15869.920650396674, 16253.83746162547, 16372.181390930406, 16437.09595972233, 540392.0, 563826.0, 571057.0, 574381.0, 574677.0, 57912.13131803026, 58421.0, 58491.0, 58506.0, 58524.707376462844, 1451.5137428961416, 1455.3960106555874, 1458.8176477940258, 1462.2323280277726, 1486.472302332678, 29412.411751764415, 30234.84882575573, 31011.68988310088, 31824.84087579547, 32379.0, 51060.48939510706, 51737.741311293204, 51791.22313165381, 51909.48090519047, 51910.22134667908, 338259.0, 338630.0, 339602.0, 339809.0, 339960.0, 35147.648523514436, 35471.467927980586, 47961.280580792016, 48504.02991940212, 49125.263121053926, 44071.55928440674, 44640.55359446364, 44650.776746117364, 45091.54908451005, 45141.0, 37835.81082094572, 37867.24265514619, 38195.618043820316, 39356.409653854644, 40973.795131024155, 40585.59414405818, 40957.38563921603, 41100.588994109676, 41221.0, 42221.788891055345, 38933.41599876061, 38969.610303896596, 39891.40162897617, 40091.19817603573, 40402.0, 34776.0, 35304.29391412106, 35342.0, 35753.64246357503, 36033.459498107026, 27157.72842271552, 27568.448631026866, 27691.861540692167, 27960.86019569889, 28069.43861122807], "unit": "score", "name": "ext.html", "value": 19526.223096492075}, {"lowerIsBetter": false, "replicates": [370.2354637673203, 379.60141851056386, 379.70193398182425, 383.1474968195765, 384.8152886614425, 17729.202185901635, 17800.376986805466, 18321.541961450937, 18364.0, 18485.0, 15201.84798152018, 15589.688206235869, 15682.84317156828, 15704.450344237954, 15779.526614201592, 5244.895102097956, 5618.353889302721, 5633.436656334375, 5638.069718496464, 5699.173619825123, 4222.873313800591, 5534.08687566551, 5864.824055278348, 6144.907826382608, 6184.474319682809, 6015.458608725214, 6078.149059131725, 6088.512918966494, 6103.115048317991, 6108.572399932006, 5888.499477544414, 6013.36859629737, 6032.66820324882, 6042.607230530001, 6051.939480605226, 5316.38861530925, 5328.813491527817, 5342.038433082043, 5351.197320401932, 5364.544013758835, 21589.568208635897, 22253.109875604958, 22447.663285050738, 22756.089756409725, 22764.0, 2167.2739632223224, 2220.7224096987875, 2388.737238903719, 2493.4015836199364, 2520.3699075231193, 9216.723498295061, 9792.06975337349, 9916.305858589902, 11872.643820685393, 13527.729445411134, 1953.365156324186, 1972.1125493527827, 2016.3346095788502, 2019.7980201979685, 2021.9393418197478, 67873.64252714918, 69987.0, 71064.28935710629, 72206.27793722048, 72473.0, 10955.4522273886, 10979.615713449992, 11080.722981925517, 11137.387443690675, 11147.721306967229, 14829.555113346616, 14851.108933464027, 14917.328720207617, 14918.776218356734, 14996.550103496695, 7786.338161256356, 7798.376129909707, 7828.099768526578, 7921.168277330912, 7961.044674639081, 7270.163931147986, 7274.418046556263, 7533.585652789039, 7593.772186834404, 7638.809029774189, 4501.527339629357, 4748.453927798348, 4760.738159401197, 4837.879053023703, 4853.93213493031, 1831.2668168683406, 1839.6320735852883, 1894.8578856585812, 1906.5614908571106, 1937.6478691862874, 950.50098698184, 953.3469573342283, 1014.4927536231884, 1057.8466122412208, 1071.8754829671575, 17183.226754796066, 17400.5649858752, 17459.650806984042, 17692.823071769373, 17825.910870445565, 1028.881678606955, 1034.6482196053378, 1036.0, 1079.9136069114452, 1105.9723506912392, 9864.0, 10186.592536298465, 10194.796104078025, 10258.17934565233, 10361.585536578452, 454122.0, 458673.0, 459549.0, 472717.0, 474570.0, 76381.0, 79601.20398796054, 80282.5985870067, 80618.19381806107, 81765.0, 1045.2421994054403, 1064.377339256528, 1065.4885654885697, 1066.9413182274893, 1093.6445655161945, 15762.921185394, 15794.289256983233, 15934.362625495314, 16062.19689015568, 16251.43119990842, 33473.83263083669, 35722.0, 35831.46252806158, 36286.27427451489, 37014.25971480609, 46973.0, 47191.76404117957, 47209.29186062143, 47607.28589071098, 48785.75607121942, 8114.0, 8279.420440569102, 8315.916840831514, 8325.167483251626, 8363.540005299767, 9194.816103678022, 11393.601223957121, 12184.390780461119, 12603.0, 12617.93691031539, 10929.344239345664, 10988.560457581927, 11112.888871111185, 11179.496922638338, 11669.299842009506, 10908.78182436331, 10970.451477425937, 11188.83216751733, 11270.211085223955, 11273.71815704614, 10495.265331426726, 12232.938835305766, 12251.754964900474, 12264.141510094209, 12309.26144431337, 8336.666533338599, 8401.495910245405, 8563.571821409028, 8598.097199793932, 8857.689980850639, 8955.462672239426, 10962.98956167001, 11851.703707407383, 11896.76206475883, 12000.939995299968], "unit": "score", "name": "jquery.html", "value": 8855.249200908213}, {"lowerIsBetter": false, "replicates": [1622.302409963716, 1643.7945256842897, 1889.168765743073, 1926.8362189213917, 1974.4076776966906, 8246.463979841306, 8259.463134896236, 8436.662533498653, 8513.574321283942, 8540.91459085409, 8200.630971606277, 8275.586220688972, 8287.502749835014, 8292.668293268262, 8297.0, 2477.4178068154015, 2483.776460118589, 2498.088197807805, 2501.2996361018945, 2507.9373015674664, 2418.51629674065, 2420.7216170140396, 2462.91379801707, 2464.0759715106833, 2469.76537228963, 2378.21518898763, 2398.340456374502, 2470.1354525915967, 2471.9876400617973, 2479.801615870726, 2471.308033750544, 2473.5300292944285, 2488.1167185649106, 2505.386180385817, 2509.761572650595, 2438.0613463816558, 2443.3525115844313, 2449.8285120041605, 2455.2756936703713, 2466.962995555068, 8239.670413183465, 8275.337972962148, 8288.336933045402, 8306.293965012981, 8343.874841877378, 5111.386633603991, 5235.057689615867, 5249.895002099936, 5277.234800953878, 5282.788688452457, 3161.1780936956325, 3177.586913701204, 3227.080282119585, 3337.2991671748964, 3377.1894745261206, 1005.9949700251525, 2027.2904483430682, 2062.979370206294, 2095.434232757162, 2105.494681276498, 11651.592194273244, 11815.645530634009, 11816.05471562273, 11832.349220792852, 11859.229150105215, 4411.713238639478, 4503.009337945647, 4542.068875880436, 4544.454665440168, 4556.453225612948, 9478.33651644392, 9531.0, 9548.045195480536, 9555.0, 9559.139677429064, 4999.925001124986, 5035.093683137071, 5058.418281897555, 5067.8986420271385, 5078.771455284521, 4430.800613972379, 4583.381243532081, 4620.630349572093, 4629.236176030917, 4644.210484217691, 3789.2800367930004, 3823.2353529293696, 3861.613838616116, 3878.7478813877005, 3884.5532763731967, 1142.4630423700846, 1181.2262967756133, 1181.468339247342, 1183.1185766603935, 1185.6265276437894, 1428.4072110074203, 1457.890658200639, 1466.7799830025367, 1489.7244009858211, 1498.19846382185, 8283.461574997606, 8315.210055044761, 8317.875231871527, 8340.708075217339, 8352.12302708219, 511.74645827982, 516.1122868665964, 519.6310619460226, 522.9032628963578, 523.6439221329456, 6386.489080873519, 6387.489000879918, 6439.935600643934, 6461.547691661539, 6490.448311893448, 9969.950150249348, 10288.125509331641, 10326.586936522604, 10412.5834966602, 10476.266661333633, 9912.801743965225, 10182.541785619665, 10195.694129176136, 10265.230107741949, 10280.742981425525, 8041.195880412029, 8073.475224110414, 8085.676572937016, 8125.268725814587, 8130.75607731769, 7701.845963080819, 7773.067231932205, 7800.063992320957, 7891.565963872042, 7939.28546430824, 8870.802441670292, 9071.138241867013, 9073.364864459425, 9209.263258939403, 9209.815803683754, 9350.438973661601, 9453.054694530767, 9480.383775054599, 9484.05159484046, 9519.857202142111, 7022.578645281095, 7125.857482850418, 7327.2672732726305, 7504.362129218859, 7515.924840751522, 8066.072401673648, 8137.389695772959, 8144.348452123934, 8166.183381662024, 8212.507249565046, 7260.745873894389, 7414.962925185555, 7436.479446438698, 7461.701531938662, 7477.4391920605085, 7322.816929576803, 7341.77974660761, 7395.112586489656, 7398.852022959618, 7450.813729656802, 7718.073831140299, 7775.650095745592, 7799.844003120019, 7803.102643195878, 7842.0, 6715.0, 6730.663466826737, 6747.527673062838, 6837.0, 6853.588784672936, 7055.2591977841585, 7140.285971402818, 7141.357277845019, 7156.677949492181, 7214.2064372917885], "unit": "score", "name": "mootools.html", "value": 4840.905655230852}, {"lowerIsBetter": false, "replicates": [318.22829638127536, 330.36404920527985, 330.4349562248555, 338.6478062814673, 339.1774945756541, 6434.0, 6438.163038804954, 6448.64532450715, 6450.483961283097, 6491.8377040574005, 6335.904961425582, 6345.143405640237, 6354.14219080424, 6367.33143019982, 6389.297177310504, 4654.790534425959, 4774.665773395864, 4801.2798080287885, 4809.975950120244, 4854.126257273698, 4786.83246086387, 4809.735464549449, 4825.131476334276, 4825.638077144228, 4833.3958255218095, 4718.952810471886, 4751.14479393709, 4761.333413322138, 4762.071396077767, 4773.0, 4765.8570242892765, 4769.451513075988, 4773.785179666923, 4777.163996300634, 4788.545088216614, 4123.731957422788, 4123.97938010308, 4129.050318426779, 4132.359484279911, 4133.731307465036, 6001.811792579578, 6073.969630151865, 6099.69501524922, 6103.206583144207, 6138.84652883677, 5492.258545096401, 5560.833175004756, 5562.3047119110115, 5572.944270557283, 5577.860553486195, 6688.665566721645, 6710.7315707371645, 6737.124173857416, 6740.224874139439, 6745.494087943423, 4500.707454015478, 4524.864254072383, 4527.773611319454, 4532.954670453286, 4536.888462326718, 6995.825104372431, 7003.754868579626, 7009.579425234502, 7039.507234493536, 7094.68073936674, 4579.816807327669, 4674.11191873543, 4675.111728771522, 4679.415073115861, 4688.0, 4725.432948046187, 4751.073540659608, 4753.453352864396, 4761.857144285677, 4763.904721905612, 5490.56075513958, 5499.285092937893, 5511.173324001432, 5513.751881165357, 5514.255575497256, 6758.493113016445, 6817.659117044128, 6818.4886133540185, 6834.077399550997, 6838.863222735517, 1629.6903588318182, 1677.5973766296001, 1681.1510187355307, 1681.4955513345947, 1682.066453118531, 1072.3244356055634, 1080.4813689429118, 1089.1341383600056, 1096.2874131814226, 1112.821948488238, 6568.86862262752, 6604.933950660528, 6605.504587155982, 6607.504437167232, 6673.866522669519, 6982.895256571155, 7009.12385951756, 7017.122859642544, 7017.438604911595, 7045.436365090781, 6359.491240700733, 6449.484041276686, 6642.169728783902, 6642.568233064835, 6664.333566643297, 3760.511133552621, 3781.7920014399474, 3811.7141214408475, 3815.198808250243, 3830.8467661293794, 7330.120385553661, 7367.079115110611, 7409.0, 7424.962875185697, 7441.702331906771, 7229.89155162673, 7314.634268286564, 7316.853662926712, 7319.0, 7319.670614822346, 7144.8928266076055, 7318.377937875233, 7433.182349941502, 7445.143808461988, 7450.329470347587, 7101.7159313628945, 7120.501564890408, 7123.287671233043, 7140.214576396696, 7157.069580954442, 6992.965035174791, 7002.964985175042, 7010.123734533184, 7014.579125252501, 7017.0, 7353.8161545961775, 7356.96321518389, 7372.373348265243, 7384.187739348775, 7388.335049845325, 4503.5946764790015, 4577.496475387638, 4614.146382919036, 4621.168189725881, 4645.326427668037, 7042.978768078702, 7045.11936007999, 7066.681999309941, 7069.893951590833, 7110.928890711027, 6843.931560684329, 6892.827679308058, 6899.413549848118, 6906.896396554156, 6910.343517366044, 6876.759313424006, 6885.586864788129, 6892.931070689229, 6898.309914071085, 6908.723651053901, 6573.211214654081, 6731.831704207434, 6785.898211526733, 6820.420264277592, 6820.624865632438, 6906.447484201352, 6909.7581584644295, 6913.481488888253, 6948.33990770876, 6953.860922781415, 6722.9663851680425, 6742.86514269702, 6757.898631520629, 6768.187817461936, 6779.932200678128], "unit": "score", "name": "prototype.html", "value": 5083.429977636648}, {"lowerIsBetter": false, "replicates": [803.9477433966791, 875.3916028360288, 890.363390176024, 898.5462341517533, 899.8290324838279, 13946.163230206195, 14214.78677819831, 14247.0, 14283.571492855219, 14296.428142874272, 13518.594442166726, 13534.0, 13597.728045439086, 13608.795868061963, 13627.523036693718, 763.7861398808343, 900.3877363392891, 914.1589737441553, 917.8898532176148, 920.0983036624112, 897.7935074932769, 902.1474706402453, 907.2696479334134, 910.6129894794719, 916.0884919505102, 951.6098399656142, 951.9619215231417, 954.4607296877277, 955.3360414511917, 962.2927148545813, 932.0306880843914, 941.23759754599, 941.9529023548829, 945.3571571331491, 948.5873644964428, 710.5097482736895, 711.9252478489735, 713.750187434399, 713.83938613812, 716.187127610161, 13795.10331828438, 13884.652883677887, 13913.443462261497, 13921.721565568732, 13942.093763905314, 12609.873901260962, 12710.491580336868, 12898.935505322506, 13003.934980325037, 13329.0, 10388.428636424993, 10440.530176142016, 10614.257002009863, 10710.250282480229, 10809.189310801721, 3472.9581125662453, 3501.422265326218, 3524.1718196223865, 3537.345591065661, 3564.1267889367273, 50670.7466462669, 50742.49257507452, 50771.74614126905, 51696.22455663168, 53439.19841202424, 9726.95136524327, 9778.0, 9802.65690700822, 9804.950975245078, 9810.11708946184, 17653.205605747517, 17689.823101769074, 17706.20322085509, 17720.734188987175, 17785.199666014803, 7566.24337566239, 7648.42636802242, 7662.233776622294, 7717.382609391235, 7779.649915753805, 3903.434002069684, 3995.700322475826, 4129.91740165195, 4182.1008483176265, 4210.989362553027, 3263.608366995928, 3277.311764529428, 3293.4236508610898, 3308.503724441353, 3308.9172770680443, 621.4158690830695, 622.5766478794372, 631.0660222870086, 634.014108061968, 635.0474288567149, 703.736098962889, 708.8334241453255, 709.7622296530617, 715.1704023332909, 726.6766289001343, 8573.09982451846, 8662.436941598777, 8769.517676527725, 8772.736817895346, 8867.423617464845, 654.8952167653152, 736.5507040705165, 747.1818358896999, 758.3857075768645, 767.7850201943464, 4212.473440819897, 4411.470623525198, 4527.61515271199, 4529.909401811945, 4601.148787474328, 62141.378586214465, 63273.683631581545, 63435.048474272924, 63546.0, 63609.0, 55165.44834551684, 55800.16299755507, 56368.718156408955, 56769.336139621446, 56956.86086278334, 48502.5149748498, 49119.50880491149, 49736.0052798942, 49917.25124123141, 51430.48569514257, 8767.167119123673, 8818.42853644275, 8871.600777964877, 9036.45781253127, 9157.175854173156, 36265.456018159224, 36757.26485470329, 37188.81405592955, 37337.0, 37650.246995060494, 44308.556914430446, 44550.3317450232, 47445.288320674525, 49009.50990490049, 49166.75416623037, 11440.94279528597, 11636.76726465449, 11682.591109311134, 11754.23597466162, 11763.176577639482, 11410.201285909907, 11655.417229138679, 11831.11266654987, 11851.762964740828, 11923.880761192624, 11651.30092194471, 11757.412129393326, 11848.881511185122, 11989.880101198876, 12082.637520874388, 11823.467943942715, 11929.28424294545, 11937.940310298392, 12177.269363838199, 12301.692457688272, 10993.560257589606, 11052.11583073336, 11192.83210751823, 11647.0, 11852.822207667065, 9249.853926018995, 9421.340506164777, 9553.713388598353, 9609.279304052365, 10065.0, 9698.224142068477, 9880.752981175528, 10008.14930730896, 10091.7477063074, 10118.595256189965], "unit": "score", "name": "yui.html", "value": 6640.653196687975}], "name": "dromaeo_css", "value": 7350.854810238426}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 111.0, 109.0, 111.0, 122.0, 110.0, 110.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 149.0, 164.0, 132.0, 152.0, 162.0, 126.0, 169.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 168.0, 160.0, 163.0, 162.0, 161.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 76.0, 158.0, 74.0, 75.0, 74.0, 74.0, 157.0, 76.0], "unit": "score", "name": "audio-fft", "value": 91.2}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 144.0, 93.0, 94.0, 94.0, 146.0, 93.0, 94.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 118.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 149.0, 146.0, 148.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 98.0, 96.0, 98.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 64.0, 56.0, 57.0, 56.0, 60.0, 63.0, 55.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 67.0, 67.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.6}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 80.0, 82.0, 77.0, 86.0, 79.0, 78.0, 79.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [111.0, 116.0, 117.0, 119.0, 127.0, 116.0, 122.0, 115.0, 116.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.6}, {"lowerIsBetter": true, "replicates": [159.0, 146.0, 153.0, 144.0, 147.0, 138.0, 147.0, 161.0, 150.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 67.0, 66.0, 65.0, 64.0, 66.0, 66.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1516.9}]} 03:50:48 INFO - Return code: 0 03:50:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:50:48 ERROR - # TBPL SUCCESS # 03:50:48 INFO - Running post-action listener: _resource_record_post_action 03:50:48 INFO - Running post-run listener: _resource_record_post_run 03:50:49 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 266240; Write bytes: 497799168; Read time: 32; Write time: 465312 03:50:49 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 248061952; Read time: 0; Write time: 311364 03:50:49 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 246968320; Read time: 32; Write time: 152812 03:50:49 INFO - Running post-run listener: _upload_blobber_files 03:50:49 INFO - Blob upload gear active. 03:50:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 03:50:49 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 03:50:49 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', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 03:50:49 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 Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 03:50:50 INFO - (blobuploader) - INFO - Open directory for files ... 03:50:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:50:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:50:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:51 INFO - (blobuploader) - INFO - Done attempting. 03:50:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:50:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:50:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:51 INFO - (blobuploader) - INFO - Done attempting. 03:50:51 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:52 INFO - Return code: 0 03:50:52 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 03:50:52 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddb2444d7975e981e6035200e010db45813c837a637a8ea4e813853c162af8b7745354cc1097246d2bcc7970f9de0488960819d87ef34bc6a8e614975726f9e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e0b6226c54ff98586c67c75155eee97697a4bb2ae3c4fd7fe9952a1dbf3b16faafab594feb19385f4286229dbac5d4d134b2936c299e2eeb9ff18c056c3d1d7"} 03:50:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 03:50:52 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 03:50:52 INFO - Contents: 03:50:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddb2444d7975e981e6035200e010db45813c837a637a8ea4e813853c162af8b7745354cc1097246d2bcc7970f9de0488960819d87ef34bc6a8e614975726f9e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e0b6226c54ff98586c67c75155eee97697a4bb2ae3c4fd7fe9952a1dbf3b16faafab594feb19385f4286229dbac5d4d134b2936c299e2eeb9ff18c056c3d1d7"} 03:50:52 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:52 INFO - Copying logs to upload dir... 03:50:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 03:50:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.939399 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-19 03:50:51.812005) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-19 03:50:51.815708) ========= 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=8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddb2444d7975e981e6035200e010db45813c837a637a8ea4e813853c162af8b7745354cc1097246d2bcc7970f9de0488960819d87ef34bc6a8e614975726f9e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e0b6226c54ff98586c67c75155eee97697a4bb2ae3c4fd7fe9952a1dbf3b16faafab594feb19385f4286229dbac5d4d134b2936c299e2eeb9ff18c056c3d1d7"} build_url:https://queue.taskcluster.net/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/C3alvvLhRHmQVuODucicwA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddb2444d7975e981e6035200e010db45813c837a637a8ea4e813853c162af8b7745354cc1097246d2bcc7970f9de0488960819d87ef34bc6a8e614975726f9e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e0b6226c54ff98586c67c75155eee97697a4bb2ae3c4fd7fe9952a1dbf3b16faafab594feb19385f4286229dbac5d4d134b2936c299e2eeb9ff18c056c3d1d7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-19 03:50:51.841521) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 03:50:51.841887) ========= 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=8887e36bb8e381bfd44124ac000001a8-1458376091.969967-1799728924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 03:50:51.924753) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-19 03:50:51.925087) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-19 03:50:51.925385) ========= ========= Total master_lag: 0.40 =========