builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1458837337.65 results: success (0) buildid: 20160324065936 builduid: 9ed4186af88b45b7880e124ef5a3ba25 revision: 73efa9d61ae02f3dd977d34d9cd83af2e090822d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.649455) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.649855) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.650132) ========= 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=82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004915 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.685215) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.685485) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.726669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.726924) ========= 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=82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.058904 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.797430) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.797711) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.798068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:37.798605) ========= 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=82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-24 09:35:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.6M=0s 2016-03-24 09:35:38 (39.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195759 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:38.006351) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:38.006649) ========= 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=82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.125178 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:38.143437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 09:35:38.143767) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 73efa9d61ae02f3dd977d34d9cd83af2e090822d --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 73efa9d61ae02f3dd977d34d9cd83af2e090822d --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=82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-24 09:35:38,263 truncating revision to first 12 chars 2016-03-24 09:35:38,263 Setting DEBUG logging. 2016-03-24 09:35:38,263 attempt 1/10 2016-03-24 09:35:38,263 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/73efa9d61ae0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 09:35:39,329 unpacking tar archive at: mozilla-aurora-73efa9d61ae0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.382011 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 09:35:39.539157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:39.539490) ========= echo 73efa9d61ae02f3dd977d34d9cd83af2e090822d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'73efa9d61ae02f3dd977d34d9cd83af2e090822d'] 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=82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 73efa9d61ae02f3dd977d34d9cd83af2e090822d program finished with exit code 0 elapsedTime=0.004027 script_repo_revision: '73efa9d61ae02f3dd977d34d9cd83af2e090822d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:39.588680) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:39.588983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 09:35:39.599571) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-03-24 09:35:39.599964) ========= /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=82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:35:39 INFO - MultiFileLogger online at 20160324 09:35:39 in /builds/slave/test-pgo 09:35:39 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 09:35:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:35:39 INFO - {'append_to_log': False, 09:35:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:35:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:35:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:35:39 INFO - 'branch': 'Mozilla-Aurora', 09:35:39 INFO - 'buildbot_json_path': 'buildprops.json', 09:35:39 INFO - 'config_files': ('talos/linux_config.py',), 09:35:39 INFO - 'default_actions': ('clobber', 09:35:39 INFO - 'read-buildbot-config', 09:35:39 INFO - 'download-and-extract', 09:35:39 INFO - 'populate-webroot', 09:35:39 INFO - 'create-virtualenv', 09:35:39 INFO - 'install', 09:35:39 INFO - 'run-tests'), 09:35:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:35:39 INFO - 'download_minidump_stackwalk': True, 09:35:39 INFO - 'download_symbols': 'ondemand', 09:35:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:35:39 INFO - 'tooltool.py': '/tools/tooltool.py', 09:35:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:35:39 INFO - '/tools/misc-python/virtualenv.py')}, 09:35:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:35:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:35:39 INFO - 'installer_path': 'installer.exe', 09:35:39 INFO - 'log_level': 'info', 09:35:39 INFO - 'log_name': 'talos', 09:35:39 INFO - 'log_to_console': True, 09:35:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:35:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:35:39 INFO - 'opt_config_files': (), 09:35:39 INFO - 'pip_index': False, 09:35:39 INFO - 'sps_profile': False, 09:35:39 INFO - 'sps_profile_interval': 0, 09:35:39 INFO - 'suite': 'dromaeojs-e10s', 09:35:39 INFO - 'system_bits': '32', 09:35:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:35:39 INFO - 'title': 'talos-linux64-ix-055', 09:35:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:35:39 INFO - 'use_talos_json': True, 09:35:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:35:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:35:39 INFO - 'work_dir': 'build'} 09:35:39 INFO - ##### 09:35:39 INFO - ##### Running clobber step. 09:35:39 INFO - ##### 09:35:39 INFO - Running pre-action listener: _resource_record_pre_action 09:35:39 INFO - Running main action method: clobber 09:35:39 INFO - rmtree: /builds/slave/test-pgo/build 09:35:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:35:41 INFO - Running post-action listener: _resource_record_post_action 09:35:41 INFO - ##### 09:35:41 INFO - ##### Running read-buildbot-config step. 09:35:41 INFO - ##### 09:35:41 INFO - Running pre-action listener: _resource_record_pre_action 09:35:41 INFO - Running main action method: read_buildbot_config 09:35:41 INFO - Using buildbot properties: 09:35:41 INFO - { 09:35:41 INFO - "project": "", 09:35:41 INFO - "product": "firefox", 09:35:41 INFO - "script_repo_revision": "production", 09:35:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:35:41 INFO - "repository": "", 09:35:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:35:41 INFO - "buildid": "20160324065936", 09:35:41 INFO - "pgo_build": "True", 09:35:41 INFO - "basedir": "/builds/slave/test-pgo", 09:35:41 INFO - "buildnumber": 259, 09:35:41 INFO - "slavename": "talos-linux64-ix-055", 09:35:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:35:41 INFO - "platform": "ubuntu64_hw", 09:35:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:35:41 INFO - "branch": "mozilla-aurora", 09:35:41 INFO - "repo_path": "releases/mozilla-aurora", 09:35:41 INFO - "revision": "73efa9d61ae02f3dd977d34d9cd83af2e090822d", 09:35:41 INFO - "stage_platform": "linux64-pgo", 09:35:41 INFO - "builduid": "9ed4186af88b45b7880e124ef5a3ba25", 09:35:41 INFO - "slavebuilddir": "test" 09:35:41 INFO - } 09:35:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 09:35:41 INFO - Running post-action listener: _resource_record_post_action 09:35:41 INFO - ##### 09:35:41 INFO - ##### Running download-and-extract step. 09:35:41 INFO - ##### 09:35:41 INFO - Running pre-action listener: _resource_record_pre_action 09:35:41 INFO - Running main action method: download_and_extract 09:35:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:41 INFO - https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:35:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:35:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:35:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/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 09:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/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 09:35:45 INFO - Downloaded 1448 bytes. 09:35:45 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:35:45 INFO - Using the following test package requirements: 09:35:45 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:35:45 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:45 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:35:45 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:45 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:35:45 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:45 INFO - u'jsshell-linux-x86_64.zip'], 09:35:45 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:45 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:35:45 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:35:45 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:45 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:35:45 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:45 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:35:45 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:45 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:35:45 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:35:45 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:35:45 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:35:45 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:35: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')]} 09:35:45 INFO - https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:35:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:35:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/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 09:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/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 09:35:50 INFO - Downloaded 23310137 bytes. 09:35:50 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'] 09:35:50 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 09:35:51 INFO - Return code: 0 09:35:51 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 09:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:51 INFO - https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:35:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:35:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/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 09:35:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/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 09:35:55 INFO - Downloaded 23310137 bytes. 09:35:55 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'] 09:35:55 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 09:35:56 INFO - Return code: 0 09:35:56 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')]} 09:35:56 INFO - https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:35:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:35:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:35:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/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 09:35:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/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 09:35:58 INFO - Downloaded 10845161 bytes. 09:35:58 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'] 09:35:58 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 09:35:59 INFO - Return code: 0 09:35:59 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')]} 09:35:59 INFO - https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:35:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:35:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:35:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/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 09:35:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CkiyYb4CSxWYYoHF5CArYQ/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 09:36:01 INFO - Downloaded 60448260 bytes. 09:36:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:36:01 INFO - mkdir: /builds/slave/test-pgo/properties 09:36:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:36:01 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:36:01 INFO - Contents: 09:36:01 INFO - build_url:https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:36:02 INFO - Running post-action listener: _resource_record_post_action 09:36:02 INFO - Running post-action listener: set_extra_try_arguments 09:36:02 INFO - ##### 09:36:02 INFO - ##### Running populate-webroot step. 09:36:02 INFO - ##### 09:36:02 INFO - Running pre-action listener: _resource_record_pre_action 09:36:02 INFO - Running main action method: populate_webroot 09:36:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:36:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:36:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:36:02 INFO - '--tppagecycles', 09:36:02 INFO - '7'], 09:36:02 INFO - 'tests': ['tsvgm']}}, 09:36:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:36:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:36:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:36:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:36:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:36:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:36:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:02 INFO - 'talos_options': ['--e10s'], 09:36:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:02 INFO - 'tests': ['damp', 'tps']}, 09:36:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:02 INFO - 'talos_options': ['--e10s'], 09:36:02 INFO - 'tests': ['damp', 'tps']}, 09:36:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:36:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:36:02 INFO - 'other': {'tests': ['a11yr', 09:36:02 INFO - 'ts_paint', 09:36:02 INFO - 'tpaint', 09:36:02 INFO - 'sessionrestore', 09:36:02 INFO - 'sessionrestore_no_auto_restore', 09:36:02 INFO - 'tabpaint']}, 09:36:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:36:02 INFO - 'tests': ['a11yr', 09:36:02 INFO - 'ts_paint', 09:36:02 INFO - 'tpaint', 09:36:02 INFO - 'sessionrestore', 09:36:02 INFO - 'sessionrestore_no_auto_restore', 09:36:02 INFO - 'tabpaint']}, 09:36:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:36:02 INFO - 'tests': ['a11yr', 09:36:02 INFO - 'ts_paint', 09:36:02 INFO - 'tpaint', 09:36:02 INFO - 'sessionrestore', 09:36:02 INFO - 'sessionrestore_no_auto_restore', 09:36:02 INFO - 'tabpaint']}, 09:36:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:36:02 INFO - 'tests': ['a11yr', 09:36:02 INFO - 'ts_paint', 09:36:02 INFO - 'tpaint', 09:36:02 INFO - 'sessionrestore', 09:36:02 INFO - 'sessionrestore_no_auto_restore', 09:36:02 INFO - 'tabpaint']}, 09:36:02 INFO - 'other_l64': {'tests': ['a11yr', 09:36:02 INFO - 'ts_paint', 09:36:02 INFO - 'tpaint', 09:36:02 INFO - 'sessionrestore', 09:36:02 INFO - 'sessionrestore_no_auto_restore', 09:36:02 INFO - 'tabpaint']}, 09:36:02 INFO - 'other_nol64': {'tests': ['a11yr', 09:36:02 INFO - 'ts_paint', 09:36:02 INFO - 'tpaint', 09:36:02 INFO - 'sessionrestore', 09:36:02 INFO - 'sessionrestore_no_auto_restore', 09:36:02 INFO - 'tabpaint']}, 09:36:02 INFO - 'svgr': {'tests': ['tsvgx', 09:36:02 INFO - 'tsvgr_opacity', 09:36:02 INFO - 'tart', 09:36:02 INFO - 'tscrollx', 09:36:02 INFO - 'cart']}, 09:36:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:36:02 INFO - 'tests': ['tsvgx', 09:36:02 INFO - 'tsvgr_opacity', 09:36:02 INFO - 'tart', 09:36:02 INFO - 'tscrollx', 09:36:02 INFO - 'cart']}, 09:36:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:02 INFO - 'tests': ['tp5o']}, 09:36:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:02 INFO - 'talos_options': ['--e10s'], 09:36:02 INFO - 'tests': ['tp5o']}, 09:36:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:02 INFO - 'talos_options': ['--xperf_path', 09:36:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:02 INFO - 'tests': ['tp5n']}, 09:36:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:36:02 INFO - 'talos_options': ['--e10s', 09:36:02 INFO - '--xperf_path', 09:36:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:02 INFO - 'tests': ['tp5n']}}, 09:36:02 INFO - 'talos.zip': {'path': '', 09:36:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:36:02 INFO - Running post-action listener: _resource_record_post_action 09:36:02 INFO - ##### 09:36:02 INFO - ##### Running create-virtualenv step. 09:36:02 INFO - ##### 09:36:02 INFO - Running pre-action listener: _resource_record_pre_action 09:36:02 INFO - Running main action method: create_virtualenv 09:36:02 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:36:02 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 09:36:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:36:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:36:02 INFO - Using real prefix '/usr' 09:36:02 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:36:03 INFO - Installing distribute.............................................................................................................................................................................................done. 09:36:05 INFO - Installing pip.................done. 09:36:05 INFO - Return code: 0 09:36:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f914866cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c920>, '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 0x136d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136dcb0>, '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': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', '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 09:36:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:36:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:36:05 INFO - Using env: {'DISPLAY': ':0', 09:36:05 INFO - 'HOME': '/home/cltbld', 09:36:05 INFO - 'LANG': 'en_US.UTF-8', 09:36:05 INFO - 'LANGUAGE': 'en_US:en', 09:36:05 INFO - 'LOGNAME': 'cltbld', 09:36:05 INFO - 'MAIL': '/var/mail/cltbld', 09:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:05 INFO - 'MOZ_NO_REMOTE': '1', 09:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:05 INFO - 'NO_EM_RESTART': '1', 09:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:05 INFO - 'SHELL': '/bin/bash', 09:36:05 INFO - 'SHLVL': '1', 09:36:05 INFO - 'TERM': 'linux', 09:36:05 INFO - 'TMOUT': '86400', 09:36:05 INFO - 'USER': 'cltbld', 09:36:05 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', 09:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:05 INFO - '_': '/tools/buildbot/bin/python'} 09:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:06 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 09:36:06 INFO - Cleaning up... 09:36:06 INFO - Return code: 0 09:36:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:36: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')]} 09:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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')]} 09:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:06 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 0x7f914866cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c920>, '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 0x136d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136dcb0>, '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': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', '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 09:36:06 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 09:36:06 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 09:36:06 INFO - Using env: {'DISPLAY': ':0', 09:36:06 INFO - 'HOME': '/home/cltbld', 09:36:06 INFO - 'LANG': 'en_US.UTF-8', 09:36:06 INFO - 'LANGUAGE': 'en_US:en', 09:36:06 INFO - 'LOGNAME': 'cltbld', 09:36:06 INFO - 'MAIL': '/var/mail/cltbld', 09:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:06 INFO - 'MOZ_NO_REMOTE': '1', 09:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:06 INFO - 'NO_EM_RESTART': '1', 09:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:06 INFO - 'SHELL': '/bin/bash', 09:36:06 INFO - 'SHLVL': '1', 09:36:06 INFO - 'TERM': 'linux', 09:36:06 INFO - 'TMOUT': '86400', 09:36:06 INFO - 'USER': 'cltbld', 09:36:06 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', 09:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:06 INFO - '_': '/tools/buildbot/bin/python'} 09:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:06 INFO - Downloading/unpacking psutil>=0.7.1 09:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:36:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:09 INFO - Installing collected packages: psutil 09:36:09 INFO - Running setup.py install for psutil 09:36:09 INFO - building 'psutil._psutil_linux' extension 09:36:09 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 09:36:10 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 09:36:10 INFO - building 'psutil._psutil_posix' extension 09:36:10 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 09:36:10 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 09:36:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:10 INFO - Successfully installed psutil 09:36:10 INFO - Cleaning up... 09:36:11 INFO - Return code: 0 09:36:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:11 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 0x7f914866cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c920>, '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 0x136d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136dcb0>, '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': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', '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 09:36:11 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 09:36:11 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 09:36:11 INFO - Using env: {'DISPLAY': ':0', 09:36:11 INFO - 'HOME': '/home/cltbld', 09:36:11 INFO - 'LANG': 'en_US.UTF-8', 09:36:11 INFO - 'LANGUAGE': 'en_US:en', 09:36:11 INFO - 'LOGNAME': 'cltbld', 09:36:11 INFO - 'MAIL': '/var/mail/cltbld', 09:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:11 INFO - 'MOZ_NO_REMOTE': '1', 09:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:11 INFO - 'NO_EM_RESTART': '1', 09:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:11 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:11 INFO - 'SHELL': '/bin/bash', 09:36:11 INFO - 'SHLVL': '1', 09:36:11 INFO - 'TERM': 'linux', 09:36:11 INFO - 'TMOUT': '86400', 09:36:11 INFO - 'USER': 'cltbld', 09:36:11 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', 09:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:11 INFO - '_': '/tools/buildbot/bin/python'} 09:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:36:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:36:13 INFO - Installing collected packages: mozsystemmonitor 09:36:13 INFO - Running setup.py install for mozsystemmonitor 09:36:13 INFO - Successfully installed mozsystemmonitor 09:36:13 INFO - Cleaning up... 09:36:13 INFO - Return code: 0 09:36:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:13 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 0x7f914866cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c920>, '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 0x136d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136dcb0>, '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': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', '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 09:36:13 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 09:36:13 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 09:36:13 INFO - Using env: {'DISPLAY': ':0', 09:36:13 INFO - 'HOME': '/home/cltbld', 09:36:13 INFO - 'LANG': 'en_US.UTF-8', 09:36:13 INFO - 'LANGUAGE': 'en_US:en', 09:36:13 INFO - 'LOGNAME': 'cltbld', 09:36:13 INFO - 'MAIL': '/var/mail/cltbld', 09:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:13 INFO - 'MOZ_NO_REMOTE': '1', 09:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:13 INFO - 'NO_EM_RESTART': '1', 09:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:13 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:13 INFO - 'SHELL': '/bin/bash', 09:36:13 INFO - 'SHLVL': '1', 09:36:13 INFO - 'TERM': 'linux', 09:36:13 INFO - 'TMOUT': '86400', 09:36:13 INFO - 'USER': 'cltbld', 09:36:13 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', 09:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:13 INFO - '_': '/tools/buildbot/bin/python'} 09:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:16 INFO - Downloading blobuploader-1.2.4.tar.gz 09:36:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:36:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:36:16 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 09:36:16 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 09:36:16 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 09:36:16 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 09:36:16 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 09:36:16 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 09:36:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:36:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:36:16 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 09:36:16 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 09:36:16 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 09:36:16 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 09:36:16 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 09:36:16 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 09:36:16 INFO - Downloading docopt-0.6.1.tar.gz 09:36:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:36:16 INFO - Installing collected packages: blobuploader, requests, docopt 09:36:16 INFO - Running setup.py install for blobuploader 09:36:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:36:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:36:16 INFO - Running setup.py install for requests 09:36:17 INFO - Running setup.py install for docopt 09:36:17 INFO - Successfully installed blobuploader requests docopt 09:36:17 INFO - Cleaning up... 09:36:17 INFO - Return code: 0 09:36:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:17 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 0x7f914866cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c920>, '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 0x136d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136dcb0>, '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': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', '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 09:36:17 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 09:36:17 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 09:36:17 INFO - Using env: {'DISPLAY': ':0', 09:36:17 INFO - 'HOME': '/home/cltbld', 09:36:17 INFO - 'LANG': 'en_US.UTF-8', 09:36:17 INFO - 'LANGUAGE': 'en_US:en', 09:36:17 INFO - 'LOGNAME': 'cltbld', 09:36:17 INFO - 'MAIL': '/var/mail/cltbld', 09:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:17 INFO - 'MOZ_NO_REMOTE': '1', 09:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:17 INFO - 'NO_EM_RESTART': '1', 09:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:17 INFO - 'SHELL': '/bin/bash', 09:36:17 INFO - 'SHLVL': '1', 09:36:17 INFO - 'TERM': 'linux', 09:36:17 INFO - 'TMOUT': '86400', 09:36:17 INFO - 'USER': 'cltbld', 09:36:17 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', 09:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:17 INFO - '_': '/tools/buildbot/bin/python'} 09:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:17 INFO - Running setup.py (path:/tmp/pip-SqeetT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:17 INFO - Running setup.py (path:/tmp/pip-hmQ1Ka-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:17 INFO - Running setup.py (path:/tmp/pip-_Clkka-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:17 INFO - Running setup.py (path:/tmp/pip-HkRUnk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:17 INFO - Running setup.py (path:/tmp/pip-kmsjk6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:18 INFO - Running setup.py (path:/tmp/pip-XAH2bL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:18 INFO - Running setup.py (path:/tmp/pip-LLGEyf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:18 INFO - Running setup.py (path:/tmp/pip-AQXvdW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:18 INFO - Running setup.py (path:/tmp/pip-uSCeEt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:18 INFO - Running setup.py (path:/tmp/pip-4Vpc0T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:18 INFO - Running setup.py (path:/tmp/pip-RQPDB8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:18 INFO - Running setup.py (path:/tmp/pip-RGsDpM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:18 INFO - Running setup.py (path:/tmp/pip-k6Mfke-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:18 INFO - Running setup.py (path:/tmp/pip-Ukbr_j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:18 INFO - Running setup.py (path:/tmp/pip-7uqKfg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:18 INFO - Running setup.py (path:/tmp/pip-vcn_Iq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:18 INFO - Running setup.py (path:/tmp/pip-MQtLhQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:36:18 INFO - Running setup.py install for manifestparser 09:36:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:36:18 INFO - Running setup.py install for mozcrash 09:36:19 INFO - Running setup.py install for mozdebug 09:36:19 INFO - Running setup.py install for mozdevice 09:36:19 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:36:19 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:36:19 INFO - Running setup.py install for mozfile 09:36:19 INFO - Running setup.py install for mozhttpd 09:36:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:36:19 INFO - Running setup.py install for mozinfo 09:36:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:36:19 INFO - Running setup.py install for mozInstall 09:36:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:36:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:36:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:36:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:36:19 INFO - Running setup.py install for mozleak 09:36:19 INFO - Running setup.py install for mozlog 09:36:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:36:19 INFO - Running setup.py install for moznetwork 09:36:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:36:20 INFO - Running setup.py install for mozprocess 09:36:20 INFO - Running setup.py install for mozprofile 09:36:20 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:36:20 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:36:20 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:36:20 INFO - Running setup.py install for mozrunner 09:36:20 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:36:20 INFO - Running setup.py install for mozscreenshot 09:36:20 INFO - Running setup.py install for moztest 09:36:20 INFO - Running setup.py install for mozversion 09:36:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:36:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:36:20 INFO - Cleaning up... 09:36:20 INFO - Return code: 0 09:36:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:36:20 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')]} 09:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:20 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')]} 09:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:20 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 0x7f914866cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c920>, '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 0x136d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136dcb0>, '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': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', '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 09:36:20 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 09:36:20 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 09:36:20 INFO - Using env: {'DISPLAY': ':0', 09:36:20 INFO - 'HOME': '/home/cltbld', 09:36:20 INFO - 'LANG': 'en_US.UTF-8', 09:36:20 INFO - 'LANGUAGE': 'en_US:en', 09:36:20 INFO - 'LOGNAME': 'cltbld', 09:36:20 INFO - 'MAIL': '/var/mail/cltbld', 09:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:20 INFO - 'MOZ_NO_REMOTE': '1', 09:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:20 INFO - 'NO_EM_RESTART': '1', 09:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:20 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:20 INFO - 'SHELL': '/bin/bash', 09:36:20 INFO - 'SHLVL': '1', 09:36:20 INFO - 'TERM': 'linux', 09:36:20 INFO - 'TMOUT': '86400', 09:36:20 INFO - 'USER': 'cltbld', 09:36:20 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', 09:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:20 INFO - '_': '/tools/buildbot/bin/python'} 09:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:20 INFO - Running setup.py (path:/tmp/pip-DaiLwF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:20 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)) 09:36:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:20 INFO - Running setup.py (path:/tmp/pip-DQvWor-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:21 INFO - Running setup.py (path:/tmp/pip-BSF7uN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:21 INFO - Running setup.py (path:/tmp/pip-QNNsVh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:21 INFO - Running setup.py (path:/tmp/pip-LuS3pU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:21 INFO - Running setup.py (path:/tmp/pip-c0yaVd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:21 INFO - Running setup.py (path:/tmp/pip-XkXzKg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:21 INFO - Running setup.py (path:/tmp/pip-hyY79x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:21 INFO - Running setup.py (path:/tmp/pip-fJUC0z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:21 INFO - Running setup.py (path:/tmp/pip-a_tfqV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:21 INFO - Running setup.py (path:/tmp/pip-vppYrt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:21 INFO - Running setup.py (path:/tmp/pip-WV3oj_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:21 INFO - Running setup.py (path:/tmp/pip-Bdq7Si-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:21 INFO - Running setup.py (path:/tmp/pip-8gXr2T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:21 INFO - Running setup.py (path:/tmp/pip-ukOvBX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:21 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)) 09:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:21 INFO - Running setup.py (path:/tmp/pip-POIz1Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:22 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)) 09:36:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:22 INFO - Running setup.py (path:/tmp/pip-Ok2rP0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:22 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)) 09:36:22 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)) 09:36:22 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)) 09:36:22 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)) 09:36:22 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)) 09:36:22 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)) 09:36:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 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 09:36:22 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 09:36:24 INFO - Downloading blessings-1.6.tar.gz 09:36:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:36:24 INFO - Installing collected packages: blessings 09:36:24 INFO - Running setup.py install for blessings 09:36:24 INFO - Successfully installed blessings 09:36:24 INFO - Cleaning up... 09:36:24 INFO - Return code: 0 09:36:24 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:36:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:36:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:36:24 INFO - Reading from file tmpfile_stdout 09:36:24 INFO - Current package versions: 09:36:24 INFO - argparse == 1.2.1 09:36:24 INFO - blessings == 1.6 09:36:24 INFO - blobuploader == 1.2.4 09:36:24 INFO - docopt == 0.6.1 09:36:24 INFO - manifestparser == 1.1 09:36:24 INFO - mozInstall == 1.12 09:36:24 INFO - mozcrash == 0.17 09:36:24 INFO - mozdebug == 0.1 09:36:24 INFO - mozdevice == 0.48 09:36:24 INFO - mozfile == 1.2 09:36:24 INFO - mozhttpd == 0.7 09:36:24 INFO - mozinfo == 0.9 09:36:24 INFO - mozleak == 0.1 09:36:24 INFO - mozlog == 3.1 09:36:24 INFO - moznetwork == 0.27 09:36:24 INFO - mozprocess == 0.22 09:36:24 INFO - mozprofile == 0.28 09:36:24 INFO - mozrunner == 6.11 09:36:24 INFO - mozscreenshot == 0.1 09:36:24 INFO - mozsystemmonitor == 0.0 09:36:24 INFO - moztest == 0.7 09:36:24 INFO - mozversion == 1.4 09:36:24 INFO - psutil == 3.1.1 09:36:24 INFO - requests == 1.2.3 09:36:24 INFO - wsgiref == 0.1.2 09:36:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:24 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 0x7f914866cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c920>, '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 0x136d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136dcb0>, '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': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', '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 09:36:24 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 09:36:24 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 09:36:24 INFO - Using env: {'DISPLAY': ':0', 09:36:24 INFO - 'HOME': '/home/cltbld', 09:36:24 INFO - 'LANG': 'en_US.UTF-8', 09:36:24 INFO - 'LANGUAGE': 'en_US:en', 09:36:24 INFO - 'LOGNAME': 'cltbld', 09:36:24 INFO - 'MAIL': '/var/mail/cltbld', 09:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:24 INFO - 'MOZ_NO_REMOTE': '1', 09:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:24 INFO - 'NO_EM_RESTART': '1', 09:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:24 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:24 INFO - 'SHELL': '/bin/bash', 09:36:24 INFO - 'SHLVL': '1', 09:36:24 INFO - 'TERM': 'linux', 09:36:24 INFO - 'TMOUT': '86400', 09:36:24 INFO - 'USER': 'cltbld', 09:36:24 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', 09:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:24 INFO - '_': '/tools/buildbot/bin/python'} 09:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:24 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)) 09:36:24 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)) 09:36:24 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)) 09:36:24 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)) 09:36:24 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)) 09:36:24 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)) 09:36:24 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)) 09:36:24 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)) 09:36:24 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)) 09:36:24 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)) 09:36:24 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)) 09:36:24 INFO - Cleaning up... 09:36:24 INFO - Return code: 0 09:36:24 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f914866cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c920>, '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 0x136d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136dcb0>, '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': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', '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 09:36:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:36:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:36:24 INFO - Using env: {'DISPLAY': ':0', 09:36:24 INFO - 'HOME': '/home/cltbld', 09:36:24 INFO - 'LANG': 'en_US.UTF-8', 09:36:24 INFO - 'LANGUAGE': 'en_US:en', 09:36:24 INFO - 'LOGNAME': 'cltbld', 09:36:24 INFO - 'MAIL': '/var/mail/cltbld', 09:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:24 INFO - 'MOZ_NO_REMOTE': '1', 09:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:24 INFO - 'NO_EM_RESTART': '1', 09:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:24 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:24 INFO - 'SHELL': '/bin/bash', 09:36:24 INFO - 'SHLVL': '1', 09:36:24 INFO - 'TERM': 'linux', 09:36:24 INFO - 'TMOUT': '86400', 09:36:24 INFO - 'USER': 'cltbld', 09:36:24 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', 09:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:24 INFO - '_': '/tools/buildbot/bin/python'} 09:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:25 INFO - Downloading/unpacking jsonschema 09:36:25 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 09:36:25 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 09:36:25 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 09:36:25 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 09:36:25 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 09:36:25 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 09:36:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:36:27 INFO - Downloading/unpacking functools32 (from jsonschema) 09:36:27 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 09:36:27 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 09:36:27 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 09:36:27 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 09:36:27 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 09:36:27 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 09:36:27 INFO - Downloading functools32-3.2.3-2.tar.gz 09:36:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:36:27 INFO - warning: no files found matching '*.txt' 09:36:27 INFO - no previously-included directories found matching 'build' 09:36:27 INFO - no previously-included directories found matching 'dist' 09:36:27 INFO - no previously-included directories found matching '.git*' 09:36:27 INFO - Installing collected packages: jsonschema, functools32 09:36:27 INFO - Running setup.py install for functools32 09:36:28 INFO - warning: no files found matching '*.txt' 09:36:28 INFO - no previously-included directories found matching 'build' 09:36:28 INFO - no previously-included directories found matching 'dist' 09:36:28 INFO - no previously-included directories found matching '.git*' 09:36:28 INFO - Successfully installed jsonschema functools32 09:36:28 INFO - Cleaning up... 09:36:28 INFO - Return code: 0 09:36:28 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:28 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 0x7f914866cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c920>, '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 0x136d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136dcb0>, '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': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', '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 09:36:28 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 09:36:28 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 09:36:28 INFO - Using env: {'DISPLAY': ':0', 09:36:28 INFO - 'HOME': '/home/cltbld', 09:36:28 INFO - 'LANG': 'en_US.UTF-8', 09:36:28 INFO - 'LANGUAGE': 'en_US:en', 09:36:28 INFO - 'LOGNAME': 'cltbld', 09:36:28 INFO - 'MAIL': '/var/mail/cltbld', 09:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:28 INFO - 'MOZ_NO_REMOTE': '1', 09:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:28 INFO - 'NO_EM_RESTART': '1', 09:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:28 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:28 INFO - 'SHELL': '/bin/bash', 09:36:28 INFO - 'SHLVL': '1', 09:36:28 INFO - 'TERM': 'linux', 09:36:28 INFO - 'TMOUT': '86400', 09:36:28 INFO - 'USER': 'cltbld', 09:36:28 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', 09:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:28 INFO - '_': '/tools/buildbot/bin/python'} 09:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:28 INFO - Downloading/unpacking flake8 09:36:28 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 09:36:28 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 09:36:28 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 09:36:28 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 09:36:28 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 09:36:28 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 09:36:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:36:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:36:30 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 09:36:30 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 09:36:30 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 09:36:30 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 09:36:30 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 09:36:30 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 09:36:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:36:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:36:30 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 09:36:30 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 09:36:30 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 09:36:30 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 09:36:30 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 09:36:30 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 09:36:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:36:30 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 09:36:30 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 09:36:30 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 09:36:30 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 09:36:30 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 09:36:30 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 09:36:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:36:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:36:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:36:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:36:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:36:31 INFO - no previously-included directories found matching 'docs/_build' 09:36:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:36:31 INFO - Running setup.py install for pep8 09:36:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:36:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:36:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:36:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:36:31 INFO - no previously-included directories found matching 'docs/_build' 09:36:31 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:36:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:36:31 INFO - Cleaning up... 09:36:31 INFO - Return code: 0 09:36:31 INFO - Running post-action listener: _resource_record_post_action 09:36:31 INFO - Running post-action listener: _start_resource_monitoring 09:36:31 INFO - Starting resource monitoring. 09:36:31 INFO - ##### 09:36:31 INFO - ##### Running install step. 09:36:31 INFO - ##### 09:36:31 INFO - Running pre-action listener: _resource_record_pre_action 09:36:31 INFO - Running main action method: install 09:36:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:36:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:36:31 INFO - Reading from file tmpfile_stdout 09:36:31 INFO - Detecting whether we're running mozinstall >=1.0... 09:36:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:36:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:36:31 INFO - Reading from file tmpfile_stdout 09:36:31 INFO - Output received: 09:36:31 INFO - Usage: mozinstall [options] installer 09:36:31 INFO - Options: 09:36:31 INFO - -h, --help show this help message and exit 09:36:31 INFO - -d DEST, --destination=DEST 09:36:31 INFO - Directory to install application into. [default: 09:36:31 INFO - "/builds/slave/test-pgo"] 09:36:31 INFO - --app=APP Application being installed. [default: firefox] 09:36:31 INFO - mkdir: /builds/slave/test-pgo/build/application 09:36:31 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'] 09:36:31 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 09:36:47 INFO - Reading from file tmpfile_stdout 09:36:47 INFO - Output received: 09:36:47 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:36:47 INFO - Running post-action listener: _resource_record_post_action 09:36:47 INFO - ##### 09:36:47 INFO - ##### Running run-tests step. 09:36:47 INFO - ##### 09:36:47 INFO - Running pre-action listener: _resource_record_pre_action 09:36:47 INFO - Running main action method: run_tests 09:36:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:36:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:36:47 INFO - Python 2.7.3 09:36:47 INFO - Return code: 0 09:36:47 INFO - grabbing minidump binary from tooltool 09:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:47 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 0x136c920>, '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 0x136d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136dcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:36:47 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 09:36:47 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 09:36:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:36:47 INFO - Return code: 0 09:36:47 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:36:47 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:36:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:36:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:36:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:36:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:36:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:36:48 INFO - Return code: 0 09:36:48 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/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 09:36:48 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/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 09:36:48 INFO - Using env: {'DISPLAY': ':0', 09:36:48 INFO - 'HOME': '/home/cltbld', 09:36:48 INFO - 'LANG': 'en_US.UTF-8', 09:36:48 INFO - 'LANGUAGE': 'en_US:en', 09:36:48 INFO - 'LOGNAME': 'cltbld', 09:36:48 INFO - 'MAIL': '/var/mail/cltbld', 09:36:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:36:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:48 INFO - 'MOZ_NO_REMOTE': '1', 09:36:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:48 INFO - 'NO_EM_RESTART': '1', 09:36:48 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:48 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:48 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:36:48 INFO - 'SHELL': '/bin/bash', 09:36:48 INFO - 'SHLVL': '1', 09:36:48 INFO - 'TERM': 'linux', 09:36:48 INFO - 'TMOUT': '86400', 09:36:48 INFO - 'USER': 'cltbld', 09:36:48 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449', 09:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:48 INFO - '_': '/tools/buildbot/bin/python'} 09:36:48 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/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 09:36:48 INFO - mozversion application_buildid: 20160324065936 09:36:48 INFO - mozversion application_changeset: 73efa9d61ae02f3dd977d34d9cd83af2e090822d 09:36:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:36:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:36:48 INFO - mozversion application_name: Firefox 09:36:48 INFO - mozversion application_remotingname: firefox-dev 09:36:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:36:48 INFO - mozversion application_vendor: Mozilla 09:36:48 INFO - mozversion application_version: 47.0a2 09:36:48 INFO - mozversion platform_buildid: 20160324065936 09:36:48 INFO - mozversion platform_changeset: 73efa9d61ae02f3dd977d34d9cd83af2e090822d 09:36:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:36:48 INFO - mozversion platform_version: 47.0a2 09:36:48 INFO - using testdate: 1458837408 09:36:48 INFO - actual date: 1458837408 09:36:48 INFO - starting webserver on 'localhost:55441' 09:36:48 INFO - SUITE-START | Running 2 tests 09:36:48 INFO - TEST-START | dromaeo_css 09:36:48 INFO - operating with platform_type : linux_ 09:36:48 INFO - Initialising browser for dromaeo_css test... 09:36:48 INFO - TEST-INFO | started process 3329 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgbDgdE/profile http://localhost:55441/getInfo.html) 09:36:53 INFO - PROCESS | 3329 | 09:36:53 INFO - PROCESS | 3329 | (process:3408): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:36:54 INFO - PROCESS | 3329 | __metrics Screen width/height:1600/1200 09:36:54 INFO - PROCESS | 3329 | colorDepth:24 09:36:54 INFO - PROCESS | 3329 | Browser inner width/height: 1024/697 09:36:54 INFO - PROCESS | 3329 | __metrics 09:36:55 ERROR - PROCESS | 3329 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:36:55 INFO - TEST-INFO | 3329: exit 0 09:36:55 INFO - Browser initialized. 09:36:55 INFO - Running cycle 1/1 for dromaeo_css test... 09:36:55 INFO - TEST-INFO | started process 3460 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgbDgdE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:57 INFO - PROCESS | 3460 | 09:36:57 INFO - PROCESS | 3460 | (process:3533): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:37:07 INFO - PROCESS | 3460 | RSS: Main: 154324992 09:37:07 INFO - PROCESS | 3460 | 09:37:57 INFO - PROCESS | 3460 | 1458837477165 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] 09:40:05 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55441/tests/dromaeo/cssquery-ext.html) 09:40:06 INFO - PROCESS | 3460 | RSS: Main: 156774400 09:40:06 INFO - PROCESS | 3460 | 09:43:07 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-ext.html (next: http://localhost:55441/tests/dromaeo/cssquery-jquery.html) 09:43:08 INFO - PROCESS | 3460 | RSS: Main: 156766208 09:43:08 INFO - PROCESS | 3460 | 09:46:10 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55441/tests/dromaeo/cssquery-mootools.html) 09:46:10 INFO - PROCESS | 3460 | RSS: Main: 155131904 09:46:10 INFO - PROCESS | 3460 | 09:49:12 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55441/tests/dromaeo/cssquery-prototype.html) 09:49:13 INFO - PROCESS | 3460 | RSS: Main: 156504064 09:49:13 INFO - PROCESS | 3460 | 09:52:15 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55441/tests/dromaeo/cssquery-yui.html) 09:52:15 INFO - PROCESS | 3460 | RSS: Main: 155504640 09:52:15 INFO - PROCESS | 3460 | 09:55:17 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:55441/tests/dromaeo/cssquery-yui.html (next: http://localhost:55441/tests/dromaeo/cssquery-dojo.html) 09:55:18 INFO - PROCESS | 3460 | RSS: Main: 158412800 09:55:18 INFO - PROCESS | 3460 | 09:55:18 INFO - PROCESS | 3460 | __start_tp_report 09:55:18 INFO - PROCESS | 3460 | _x_x_mozilla_page_load 09:55:18 INFO - PROCESS | 3460 | _x_x_mozilla_page_load_details 09:55:18 INFO - PROCESS | 3460 | |i|pagename|runs| 09:55:18 INFO - PROCESS | 3460 | |0;dojo.html;3281.343731253749;3284.3759685659707;3294.7199488043516;3317.452620317648;3317.568716066911;5295.761690723917;5300.681959082448;5337.866553336164;5348.197770334452;5354.919676204855;5256.395514515832;5321.068812957727;5325.4940780625875;5331.786728530864;5334.626576139672;4851.296561998517;4873.756312184394;4935.383077115361;4941.160002799515;4945.876353091166;4891.046245982035;4958.603311735071;4963.156263435207;5018.946021335506;5065.670731402465;5062.746862656871;5111.207762796773;5114.718690472023;5115.59075273979;5136.666116702402;4938.703677779309;5067.290579318898;5080.263361812535;5085.364329458836;5140.280360749498;4878.8292409765845;4934.087193869145;4990.326305948687;5048.444671086178;5069.949300506984;5219.19102539107;5242.659227150223;5245.711485868275;5286.1013627683005;5293.550048245904;5806.1581070744505;5812.070068789016;5829.912551311733;5836.270466191726;5839.970800146015;5751.05107657236;5869.677167755772;5882.735276912549;5927.051671732545;5971.761129554812;5432.456754324536;5442.265294185314;5446.7276636168035;5453.83638490842;5457.263269458612;5838.854028649318;5881.441263080001;5885.823425297248;5886.676232807236;5897.085951677497;5630.8029218977135;5648.350439699405;5679.261695979496;5688.23208866806;5762.337331206881;5907.822765317047;5907.911381329283;5912.290525136925;5925.022371308772;5933.465988061009;5676.347220069662;5916.3787802281;5928.081147422156;5929.584929055011;5949.732262048218;5880.588358814927;5926.377730338339;5927.911081333784;5931.525477961753;5989.341172471025;4262.403263543107;4347.434833471629;4476.932846007313;4488.865334039984;4488.910221795546;3923.2741942740686;3962.1679447316387;4012.0972781124015;4020.8190631421658;4039.030632648143;5493.23094766733;5567.832965011056;5610.382857885629;5613.129964855454;5659.858503537363;5923;5931.080682494134;5937.346891841894;5948.7323070461935;5965.701714914237;5500.092484739973;5628.831135065954;5646.3224413069875;5655.264815573949;5655.434456554394;5047.899042019139;5092.879566495365;5108.540231379194;5125.948740512622;5156.948430515722;6033.698315084228;6097.451229389376;6099.3900609938655;6101.755929762849;6115.1744514490865;5748.45389687979;5916.142159386951;5918.112283157561;5928.614640048383;5934.584579079423;5959.970200148971;5964.671943043;5987.371326010706;6005.519558435228;6035.668038257938;5756.280464941882;5757.136429535603;5758.942410575841;5761.164631128547;5761.510271626791;5829.242198514166;5838.32859221195;5847.181394604844;5857.707114644336;5862.618929769551;5826.096954971986;5853.590248682552;5858.384869588632;5859.882802343844;5860.2967643883;5744.626599271034;5764.913526297193;5817.563682723728;5820.447057529697;5826.155207494974;5514.779408823602;5685.658860468385;5727.599068065196;5743.3395159557185;5808.82573522795;5601.24383208278;5624.85937851557;5702.885942281214;5747.281589801275;5863.560232982458;5568.638038527482;5588.105903055492;5588.804391846428;5591.04952158126;5598.21624972496 09:55:18 INFO - PROCESS | 3460 | |1;ext.html;509.2666560153381;538.1980848535683;551.4154995704553;575.7409165875357;605.1890466774522;40020.59979400205;40620.39069413954;40650.186996260054;40691;40692;40816.795916020375;40824;41053.38419923696;41091.17817643653;41260.17479650405;8775.254103401203;8949.731508054769;9001.144891235355;9003.594838232295;9027.052159523255;8662.090480499552;8815.162559556831;8853.73438796837;8911.821763564725;8915.375923685344;8898.332625053115;8938.4190027648;8949.910500894974;8954.059823718513;8991.820163596723;8883.333749968746;8964.641414343418;8966.23786978111;8968.192862642329;8968.730938071869;8900.910990890137;9023.233025192802;9131.908680913173;9135.132162444557;9138.862917056249;43518;43606;43916.56083439157;43949.56050439487;44180.779096104634;3168.683131686836;3534.8939531814085;3598.8380522876273;3840.7695538267794;3901.1612503311926;29974.40051198964;30166.09501714952;30246.243843904078;30545.541816872767;30900.845495772603;3930.449737036817;3955.9011024724614;3961.6038396160443;4033.455483509718;4038.818253178614;197915;199069;199395;199401;199470;44478.77760611176;63860.36139638637;63932.99999999907;64290.67854660697;64714.35285647177;43643.127137457705;43774.34338484862;43834.342484862755;44019.55980440219;44058;14987.775183372258;15309.540713778604;15388.769168462482;15407.075575465284;15409.075455472708;12605.243685378906;12791.680207994688;12803.551875684307;12867.806982895265;12870.678233044062;15765.290561924741;15780.842191578167;15792.447264345692;15801.920990395205;15824.208789560476;6059.151718759377;6128;6149.3235744068115;6208.348123447064;6244.968775156095;999.0209594597335;1007.2596641468515;1106.181425744943;1107.1751545098953;1145.3872178384524;30261;30358;30671;30850;30895.691043089282;1035.7928414317166;1051.0750539525322;1070.6466865934224;1107.0147568663895;1158.1892675127444;15537.68924621524;15716.60708482297;16005.759913601305;16162.515124546282;16263.674726505404;330311;512049;512163;771205;794477;61882.69058654678;62766.68616656979;62803.6859815698;62998;63043;1456.606716186645;1463.7731151671508;1474.0787008119926;1476.45371212652;1486.7621180611266;32114.518282226254;32218;32716.182095447803;32883.34233315272;33427;51185;51490.48509514857;51663.74168129135;51878.74060629673;52073;308102;310846;311132;311140;312457;35040;35041.824790875886;35116.82441587776;35162.29675406529;35452.29095418129;42343.57656423396;42754.144917100864;44535;47678.52321476741;48057.27914081362;40115.59884401118;40425.595744042184;40480.39279410752;40900;41497;39381.01547461336;39490.605093948696;42940.570594294906;44433.555664442945;44713.55286447094;37352;37840.81079594584;38047.61952380441;38115;38311.80844095873;34384;34974.47538286979;35279.11802204965;35936.10159745923;35940;26562.203133906012;26893.596596050684;26937.191884243504;27221.455570888076;27620.58569121505 09:55:18 INFO - PROCESS | 3460 | |2;jquery.html;374.58795325142347;387.66467006039767;390.5391637867317;398.7766850563685;398.80458575298076;17131.62946964243;19194.808051919477;19300.806991930112;19836.206551737912;19965.99999999998;18211.544711382223;18223.453296401098;18236.908815455936;18300.176492057857;18475.445736627924;5384.6499977501435;5607.43925607438;5620.381758006616;5628.240187574686;5656.406077361879;4117.629413352797;5907.438793314628;6128.080787881809;6153;6168.4448399644025;5908.438698323653;6101.542384321171;6104.08438734189;6104.633721976674;6130.816075517741;5989.161517387569;5998.790042348497;6009.218801555813;6018.127371531104;6026.517878569748;5251.527362537352;5347.25138480613;5351.357837059539;5378.408375078739;5379.085555455582;21874.89062554677;22111.44721381978;22123.115075396963;22123.668144977837;22141.66787498189;2461.6184491403683;2509.4228327484598;2586.1465716313573;2691.219546331581;2968.554716792477;13415.530456434075;13649.727005459934;13767.449302027906;13951;13964.650883727989;1917.731517587539;1925.3550060729672;1926.6532024235632;1951.2000079967145;1958.8139126782933;64100.35899640991;65880.34119658839;66265;66316.6684166581;68054.65972670155;10542.894571054345;10815.621453249098;10826.18803589734;10956.780864382668;10960.068394186424;13520;13523.580024097524;13625.659358516117;13629.114107582975;13717.17696938187;7941.563214023168;8139.145389734111;8142.877856832152;8268.586570671443;8338.541380224025;7989.960050199828;8018.639161237758;8078.474899131537;8108.1891810819625;8113.188681131957;6145.539084568675;6175.96912015446;6210.4100110489435;6359.046143078575;6388.297287298394;1891.952701182454;1900.2494014864328;1907.6661584222707;1963.3520938090396;1995.8702684325472;956.9282303827241;965.5703212070702;999.3504222255592;1030.2736570717625;1037.7561273100816;16903.323867045427;17266.136693165543;17422.738658920127;17565.12174391301;17979.910100449415;924.505389616552;971.2521358553875;984.478226539935;990.881094268678;1011.0243614911645;10047.648332308334;10093.142082922886;10114.54484548197;10177.84733229002;10306.12397946168;419490;420168;421084;427703;432687;74675.62662186654;75348;76309.61845190739;76556.61721691355;77458.61270693611;1017.1557607186018;1041.8749750030045;1079.2553138334524;1081.6268387406333;1086.43505377205;15549.455769048029;15644.530664080095;15663;16384.918075409547;16436.260368283216;32520.51219231761;33731.15672108217;35787.46318805168;36158.457623135146;36315;45634.16252238369;48368;48461.27308090311;48871.75564122156;49066.75466622644;7933.246341597539;8157.326995610316;8159.796005099683;8199.42604017713;8370.121137280497;6866.759663411756;10630.990055944672;11702.35637039937;12670.873291267339;13683.179009259477;11465.426728663366;11475.311481311148;11552.6534203974;11586.826197606873;11978.820317695066;9862.802743945225;11644;11702.70743231426;11949.402529873298;12025.398730063287;11509.827352589551;11740.941295293469;11743.11926605491;11885.821712674144;12316.630501084981;8136.7152149674475;8209.179082091743;8238;8372.07907130203;8401.411901166859;11033.393163375771;11168.553257869595;11189.608363707557;11315.264507806965;11667.124965627441 09:55:18 INFO - PROCESS | 3460 | |3;mootools.html;1603.4948991067813;1651.9174041297936;1900.8099190080993;1950.8341790947768;1973.1219607274759;7416.0729908761405;7955.840883182333;8365.079841217468;8565;8575.528345940978;8268.545230012347;8353.164683531644;8407.663693452254;8423.199796019368;8442;2466.2108125399877;2499.8750062496892;2502.674652295199;2504.6743923289946;2505.7619526144986;2415.625578035407;2467.3954881054165;2473.938151546208;2493.6508888755498;2493.775560199582;2439.756024397555;2464.9753502465014;2470.0243403855466;2477.529269438801;2480.6651102101164;2424.927252182446;2443.9633405498844;2461.3723500507435;2474;2496.750324967507;2430.501747141832;2430.8419952703193;2433.367324495644;2436.2082323245018;2481.727010028895;8456.746297611082;8527.95736021322;8539.231469167742;8540.78648033798;8594.484330940164;4985.351904252424;5176.55999240065;5185.974070129663;5204.219367094928;5232.686038837682;3124.4844600641095;3141.780075394723;3164.240582260264;3324.6176689680756;3335.2995870866903;992.1368409483723;1005.2460654509118;1005.8943810899823;1015.7308313296909;1031.118393773328;11748.353840538766;11749.118816088741;11793.351365674798;11798.764024719543;11821.645350639408;4602.723836569817;4686.250199967989;4744.786484608201;4759.928601070987;4785.353977213102;9008.32437567172;9013.414128081653;9087.727368178965;9112.772180695403;9142.177204051533;5023.321851549994;5024.899502009939;5038.546530812171;5055.115354812893;5058.317127187856;4504.729716216972;4594.724316541018;4605.815767369268;4660.440747110369;4674.182018146811;3644.2529281497227;3689.723270754704;3704.2961837251373;3764.1906989997283;3772.905677358088;1141.594733869481;1146.2549342927164;1157.4039369724599;1160.7040204747734;1164.1094562659573;1045.3048722599538;1058.4548957287004;1067.6209945469402;1288.2013151845915;1428.649980754701;7664.425168112414;7667.1949445308555;7776.844463110706;7795.610219489003;7816.765497035098;517.0615333170284;519.4675457655933;539.9541039011649;542.8018773147852;549.5027000564495;6059;6136.509079273647;6137.7851775187655;6147.600405973598;6184.196054512884;10087.394756314645;10512.579496820195;10528.210384221215;10541.736456588647;10630;10035.147012503872;10221.080102790636;10272.948635256776;10385.896141038493;10464.947675261576;7972;7973.521588704581;8036.718714844952;8061.758147255592;8123.675052997932;7602.46782725204;7654.8086297843;7662.501937374052;7698.2686644768655;7730.613469326624;8295.668173273243;8541.402101852811;8685.782855428664;8696.608652610774;8745.212930836255;8685.435446695945;8853.73438796837;8860.468371897448;8863.822723545622;9016.549172541478;6841.863162736817;7048.859022819617;7102.680379382837;7491.175970643116;7624.58064806441;8146.714864979697;8183.918160818315;8194.959025204837;8201.671933122609;8233.670653173805;7360.521566098187;7364.96317518409;7367.926320736724;7486.139094004041;7572.20491848348;7036.648167591702;7212.2427145151105;7220.711171553079;7279.272072792678;7357.8160545986775;7062.258462861326;7111.928880711127;7183.138023437221;7183.461240407095;7205.459590530626;6701.53089283765;6781.762638307636;6836.794896153124;6849.726010959505;6854.931450685629;6767.424768894699;6797.456203503807;6819.89770153458;6852.862942741018;6869 09:55:18 INFO - PROCESS | 3460 | |4;prototype.html;351.69051234913275;354.40460027154376;358.1297447203295;359.86684926577163;360.31899709548975;6295.67790763939;6329.968350158254;6337.778177763779;6385.39338762818;6393.136926514919;6293.30773614902;6296.9685151574295;6309.085182648513;6311;6316.178896743417;4670.1126785910565;4793.113274044295;4820.132376172288;4821.879453013667;4862.829800956967;4787.353707249512;4797.880052998668;4802.327674125625;4811.59101476375;4815.253635686474;4700.647451441138;4748.691335063227;4750.76246187691;4751.073540659573;4759.500252473493;4722.7402492862875;4729.59798417135;4734.455537613184;4734.786934587934;4761.428628564559;4116.650084742801;4119.588041195886;4132.979335103305;4141.420201171838;4142.689298302639;5926.259217597801;5927.703614819285;5941.405859414024;5967.9701601491715;5974.761009559613;5422;5489.780408783684;5558.777648894039;5560.666360018412;5582.804601838916;6621.93378066218;6635.767748128841;6660.567063140928;6689.498287628398;6691.096701945224;4596.885077873047;4597.310403439511;4602.884927876797;4605.286180642006;4607.078584283123;6934.341237582422;6939.514234003622;6951.096357473496;6964.303569642995;6997.440204783605;4570.794314255866;4640.65195110368;4642.51253618372;4656.998745269783;4660.53394660538;4672.813087476531;4708.882277943078;4709.905801883943;4719.5752382285755;4724.692894961817;5465.863353416196;5476.698781566973;5480.808171713971;5485.451454854483;5500.779968801283;6730.226024007204;6731.562448440835;6750.966245168841;6763.425108865801;6768.187817461936;1677.7567252748283;1691.4502786594405;1695.440504633468;1695.8219386964438;1696.720041193214;1071.6838532632892;1090.5310716392028;1092.8743394303879;1107.8338249262674;1120.2326406411635;6514.478841692748;6525.902111468332;6533.150690410216;6558.704858281389;6572.934270657232;6906.240313565604;6907.585544867324;6933.791986240421;7019.227884932653;7056.506044576933;6459.547831651833;6539.738410463528;6602.60384376939;6682.599044057372;6715.059891615178;3773.6226377362045;3807;3824.5028146340796;3828.5405751310022;3831.8275677594575;7299.635018249066;7305.817354566178;7344.596047217347;7373.631318434164;7380.225076366904;7341.119065712042;7358.66885990121;7368.410527157815;7381.298776616213;7386.96306518464;7093.82265443368;7276.454265930077;7322.560646361236;7361.153467351216;7376.483646144826;7035.964820175866;7047.788566343018;7057.329553692391;7070.964645176741;7073.504854660125;6910.550814197061;6943.930560694328;6960.930390696029;6960.965195173992;6961.199462061928;7285.089363829521;7332.78001659951;7358.66885990121;7367.594782287026;7384.040074790243;4517.299818528133;4640.04878999811;4640.976795116003;4680.5085466025575;4700.200965835747;6983.476239282176;6987.441004719712;6993.930060699327;7013.509054366145;7017.824554385977;6779.559328643622;6784.3894049535775;6785.185777706707;6787.558808677618;6792.286809884891;6720.764773232913;6779.423748981392;6785.389314961677;6793.082933804071;6795.354441328066;6571.408573228432;6706.429953453816;6785.185777706707;6806.149231346082;6811.591304521745;6869.969504574354;6874.690638921161;6917.273686263071;6921.7231310747;6936.583804971718;6662.933370666231;6713.6643167842385;6728.697208625722;6748.966255168692;6757.966210168917 09:55:18 INFO - PROCESS | 3460 | |5;yui.html;765.6401491299089;801.5030680977793;818.6970820796306;846.9068402475726;877.0922095631015;16016.439424620141;16282.185890705447;16367.83632163681;16381.508554743363;16421.67156656869;14685.33915973781;14717.926410367932;14818;14848.628784280398;14853.851461485381;920.5765347939956;921.6451666108563;933.1927882381725;945.1918609588771;947.1712251779693;911.3939230411768;911.544227886057;914.7575892388522;915.0529202275646;918.5269586163131;976.9951150244239;978.5498670611527;980.2843923935532;980.4313498171043;981.4209616326366;967.5984466446416;967.9128878400978;972.5672075926216;974.6393834281362;975.4244995452682;714.0859699584488;714.17156098925;715.7637979466764;718.3857801579678;720.9026781384498;15182.240887955668;15304.540863774104;15374.308156133;15377.231138443145;15394.769078463833;13723.862761372358;13841.238731869744;13937.442502299897;14029.929850350683;14116.50592229267;10936.398498082603;10946.233763636468;11046.889531104667;11130.833037504444;11260.831087533694;3727.0682329417646;3765.6799172070405;3809.4285857121654;3811.1805961718364;3988.880333589997;54235.6441088972;54308.18537721937;54868.45131548713;55022.44977550213;55209.72395137999;10643;11162.665120046411;11260.774784504263;11310.943445282886;11352.091832653368;20131.295404660767;20180.59638807245;20217.29239476611;20231.393058208276;20264.392068237976;8079.596020199084;8209.876851847228;8274.958625206835;8315.83368332642;8352.373571982125;4517.548245175456;4766.713997160182;4790.257510085942;4879.170541008037;4892.290617860462;3395.881144159992;3483.512308276843;3488.8778892738633;3494.109002204422;3498.5801703795705;627.8461776864606;628.9622622642656;631.5705320382184;633.3096924352386;639.5203597302024;638.565775272819;655.2890114226022;659.133239789675;664.9900251496232;665.8235567574596;7973;8485.660573576988;8956.641734330684;8972.910270897208;8985.371024028385;570.0736303506801;623.5915475363644;633.2749002392327;643.6073994863129;663.3896814930275;3992.9201415972097;4000.959990400117;4019.738716983387;4157.750534967911;4178.185253875465;62494.375056249766;62916;63402.68298658569;63910.68044659747;64495.03257451142;51754;53405.732971335674;53679.46320536744;54445.183322250195;55264.44735552673;51657;52345.47654523406;52588.73705631447;53222;53953.46046539484;9173.44959302444;9318.394304370195;9528.95235523818;9572;9597.424154550748;36996.630033699315;37285.4407183887;37331.253374932894;37843.243135136596;38523.80738096291;44727;47303.763481182374;47626.52373476221;47793.76103119462;48058;12155.574554890536;12697.42861571213;13004.739905201654;13082;13248.20510769357;12877.549285774952;13136.868631313946;13229.669258268235;13324.133931294435;13342.666433338856;11975.28148311104;12142.332171730639;12195.207311524722;12280.140390172603;12476.126671132934;12465.93767031159;12712.046596505113;12768;12863.678408039874;13008.544700935421;11198;11289.661310160709;11414.086873050303;11433.771324573296;11539.19225654196;10712.303700259457;10827.458627068772;11291.266067705574;11325.377104259016;11381.658550243506;9933.900660993297;10155.387619937035;10373.844392333971;10613;10619.203559732896 09:55:18 INFO - PROCESS | 3460 | __end_tp_report 09:55:18 INFO - PROCESS | 3460 | __start_cc_report 09:55:18 INFO - PROCESS | 3460 | _x_x_mozilla_cycle_collect,307 09:55:18 INFO - PROCESS | 3460 | __end_cc_report 09:55:18 INFO - PROCESS | 3460 | __startTimestamp1458838518229__endTimestamp 09:55:18 INFO - PROCESS | 3460 | 09:55:18 INFO - PROCESS | 3460 | ------- Summary: start ------- 09:55:18 INFO - PROCESS | 3460 | Number of tests: 6 09:55:18 INFO - PROCESS | 3460 | 09:55:18 INFO - PROCESS | 3460 | [#0] dojo.html Cycles:165 Average:5440.99 Median:5655.26 stddev:608.75 (10.8%) stddev-sans-first:586.56 09:55:18 INFO - PROCESS | 3460 | Values: 3281.3 3284.4 3294.7 3317.5 3317.6 5295.8 5300.7 5337.9 5348.2 5354.9 5256.4 5321.1 5325.5 5331.8 5334.6 4851.3 4873.8 4935.4 4941.2 4945.9 4891.0 4958.6 4963.2 5018.9 5065.7 5062.7 5111.2 5114.7 5115.6 5136.7 4938.7 5067.3 5080.3 5085.4 5140.3 4878.8 4934.1 4990.3 5048.4 5069.9 5219.2 5242.7 5245.7 5286.1 5293.6 5806.2 5812.1 5829.9 5836.3 5840.0 5751.1 5869.7 5882.7 5927.1 5971.8 5432.5 5442.3 5446.7 5453.8 5457.3 5838.9 5881.4 5885.8 5886.7 5897.1 5630.8 5648.4 5679.3 5688.2 5762.3 5907.8 5907.9 5912.3 5925.0 5933.5 5676.3 5916.4 5928.1 5929.6 5949.7 5880.6 5926.4 5927.9 5931.5 5989.3 4262.4 4347.4 4476.9 4488.9 4488.9 3923.3 3962.2 4012.1 4020.8 4039.0 5493.2 5567.8 5610.4 5613.1 5659.9 5923.0 5931.1 5937.3 5948.7 5965.7 5500.1 5628.8 5646.3 5655.3 5655.4 5047.9 5092.9 5108.5 5125.9 5156.9 6033.7 6097.5 6099.4 6101.8 6115.2 5748.5 5916.1 5918.1 5928.6 5934.6 5960.0 5964.7 5987.4 6005.5 6035.7 5756.3 5757.1 5758.9 5761.2 5761.5 5829.2 5838.3 5847.2 5857.7 5862.6 5826.1 5853.6 5858.4 5859.9 5860.3 5744.6 5764.9 5817.6 5820.4 5826.2 5514.8 5685.7 5727.6 5743.3 5808.8 5601.2 5624.9 5702.9 5747.3 5863.6 5568.6 5588.1 5588.8 5591.0 5598.2 09:55:18 INFO - PROCESS | 3460 | 09:55:18 INFO - PROCESS | 3460 | [#1] ext.html Cycles:180 Average:53256.21 Median:40068.10 stddev:110595.64 (276.0%) stddev-sans-first:110834.98 09:55:18 INFO - PROCESS | 3460 | Values: 509.3 538.2 551.4 575.7 605.2 40020.6 40620.4 40650.2 40691.0 40692.0 40816.8 40824.0 41053.4 41091.2 41260.2 8775.3 8949.7 9001.1 9003.6 9027.1 8662.1 8815.2 8853.7 8911.8 8915.4 8898.3 8938.4 8949.9 8954.1 8991.8 8883.3 8964.6 8966.2 8968.2 8968.7 8900.9 9023.2 9131.9 9135.1 9138.9 43518.0 43606.0 43916.6 43949.6 44180.8 3168.7 3534.9 3598.8 3840.8 3901.2 29974.4 30166.1 30246.2 30545.5 30900.8 3930.4 3955.9 3961.6 4033.5 4038.8 197915.0 199069.0 199395.0 199401.0 199470.0 44478.8 63860.4 63933.0 64290.7 64714.4 43643.1 43774.3 43834.3 44019.6 44058.0 14987.8 15309.5 15388.8 15407.1 15409.1 12605.2 12791.7 12803.6 12867.8 12870.7 15765.3 15780.8 15792.4 15801.9 15824.2 6059.2 6128.0 6149.3 6208.3 6245.0 999.0 1007.3 1106.2 1107.2 1145.4 30261.0 30358.0 30671.0 30850.0 30895.7 1035.8 1051.1 1070.6 1107.0 1158.2 15537.7 15716.6 16005.8 16162.5 16263.7 330311.0 512049.0 512163.0 771205.0 794477.0 61882.7 62766.7 62803.7 62998.0 63043.0 1456.6 1463.8 1474.1 1476.5 1486.8 32114.5 32218.0 32716.2 32883.3 33427.0 51185.0 51490.5 51663.7 51878.7 52073.0 308102.0 310846.0 311132.0 311140.0 312457.0 35040.0 35041.8 35116.8 35162.3 35452.3 42343.6 42754.1 44535.0 47678.5 48057.3 40115.6 40425.6 40480.4 40900.0 41497.0 39381.0 39490.6 42940.6 44433.6 44713.6 37352.0 37840.8 38047.6 38115.0 38311.8 34384.0 34974.5 35279.1 35936.1 35940.0 26562.2 26893.6 26937.2 27221.5 27620.6 09:55:18 INFO - PROCESS | 3460 | 09:55:18 INFO - PROCESS | 3460 | [#2] jquery.html Cycles:180 Average:25704.46 Median:17744.53 stddev:69594.84 (392.2%) stddev-sans-first:69764.08 09:55:18 INFO - PROCESS | 3460 | Values: 374.6 387.7 390.5 398.8 398.8 17131.6 19194.8 19300.8 19836.2 19966.0 18211.5 18223.5 18236.9 18300.2 18475.4 5384.6 5607.4 5620.4 5628.2 5656.4 4117.6 5907.4 6128.1 6153.0 6168.4 5908.4 6101.5 6104.1 6104.6 6130.8 5989.2 5998.8 6009.2 6018.1 6026.5 5251.5 5347.3 5351.4 5378.4 5379.1 21874.9 22111.4 22123.1 22123.7 22141.7 2461.6 2509.4 2586.1 2691.2 2968.6 13415.5 13649.7 13767.4 13951.0 13964.7 1917.7 1925.4 1926.7 1951.2 1958.8 64100.4 65880.3 66265.0 66316.7 68054.7 10542.9 10815.6 10826.2 10956.8 10960.1 13520.0 13523.6 13625.7 13629.1 13717.2 7941.6 8139.1 8142.9 8268.6 8338.5 7990.0 8018.6 8078.5 8108.2 8113.2 6145.5 6176.0 6210.4 6359.0 6388.3 1892.0 1900.2 1907.7 1963.4 1995.9 956.9 965.6 999.4 1030.3 1037.8 16903.3 17266.1 17422.7 17565.1 17979.9 924.5 971.3 984.5 990.9 1011.0 10047.6 10093.1 10114.5 10177.8 10306.1 419490.0 420168.0 421084.0 427703.0 432687.0 74675.6 75348.0 76309.6 76556.6 77458.6 1017.2 1041.9 1079.3 1081.6 1086.4 15549.5 15644.5 15663.0 16384.9 16436.3 32520.5 33731.2 35787.5 36158.5 36315.0 45634.2 48368.0 48461.3 48871.8 49066.8 7933.2 8157.3 8159.8 8199.4 8370.1 6866.8 10631.0 11702.4 12670.9 13683.2 11465.4 11475.3 11552.7 11586.8 11978.8 9862.8 11644.0 11702.7 11949.4 12025.4 11509.8 11740.9 11743.1 11885.8 12316.6 8136.7 8209.2 8238.0 8372.1 8401.4 11033.4 11168.6 11189.6 11315.3 11667.1 09:55:18 INFO - PROCESS | 3460 | 09:55:18 INFO - PROCESS | 3460 | [#3] mootools.html Cycles:180 Average:5806.32 Median:2886.32 stddev:3054.30 (105.8%) stddev-sans-first:3046.53 09:55:18 INFO - PROCESS | 3460 | Values: 1603.5 1651.9 1900.8 1950.8 1973.1 7416.1 7955.8 8365.1 8565.0 8575.5 8268.5 8353.2 8407.7 8423.2 8442.0 2466.2 2499.9 2502.7 2504.7 2505.8 2415.6 2467.4 2473.9 2493.7 2493.8 2439.8 2465.0 2470.0 2477.5 2480.7 2424.9 2444.0 2461.4 2474.0 2496.8 2430.5 2430.8 2433.4 2436.2 2481.7 8456.7 8528.0 8539.2 8540.8 8594.5 4985.4 5176.6 5186.0 5204.2 5232.7 3124.5 3141.8 3164.2 3324.6 3335.3 992.1 1005.2 1005.9 1015.7 1031.1 11748.4 11749.1 11793.4 11798.8 11821.6 4602.7 4686.3 4744.8 4759.9 4785.4 9008.3 9013.4 9087.7 9112.8 9142.2 5023.3 5024.9 5038.5 5055.1 5058.3 4504.7 4594.7 4605.8 4660.4 4674.2 3644.3 3689.7 3704.3 3764.2 3772.9 1141.6 1146.3 1157.4 1160.7 1164.1 1045.3 1058.5 1067.6 1288.2 1428.6 7664.4 7667.2 7776.8 7795.6 7816.8 517.1 519.5 540.0 542.8 549.5 6059.0 6136.5 6137.8 6147.6 6184.2 10087.4 10512.6 10528.2 10541.7 10630.0 10035.1 10221.1 10272.9 10385.9 10464.9 7972.0 7973.5 8036.7 8061.8 8123.7 7602.5 7654.8 7662.5 7698.3 7730.6 8295.7 8541.4 8685.8 8696.6 8745.2 8685.4 8853.7 8860.5 8863.8 9016.5 6841.9 7048.9 7102.7 7491.2 7624.6 8146.7 8183.9 8195.0 8201.7 8233.7 7360.5 7365.0 7367.9 7486.1 7572.2 7036.6 7212.2 7220.7 7279.3 7357.8 7062.3 7111.9 7183.1 7183.5 7205.5 6701.5 6781.8 6836.8 6849.7 6854.9 6767.4 6797.5 6819.9 6852.9 6869.0 09:55:18 INFO - PROCESS | 3460 | 09:55:18 INFO - PROCESS | 3460 | [#4] prototype.html Cycles:180 Average:5641.32 Median:6487.01 stddev:1745.11 (26.9%) stddev-sans-first:1704.25 09:55:18 INFO - PROCESS | 3460 | Values: 351.7 354.4 358.1 359.9 360.3 6295.7 6330.0 6337.8 6385.4 6393.1 6293.3 6297.0 6309.1 6311.0 6316.2 4670.1 4793.1 4820.1 4821.9 4862.8 4787.4 4797.9 4802.3 4811.6 4815.3 4700.6 4748.7 4750.8 4751.1 4759.5 4722.7 4729.6 4734.5 4734.8 4761.4 4116.7 4119.6 4133.0 4141.4 4142.7 5926.3 5927.7 5941.4 5968.0 5974.8 5422.0 5489.8 5558.8 5560.7 5582.8 6621.9 6635.8 6660.6 6689.5 6691.1 4596.9 4597.3 4602.9 4605.3 4607.1 6934.3 6939.5 6951.1 6964.3 6997.4 4570.8 4640.7 4642.5 4657.0 4660.5 4672.8 4708.9 4709.9 4719.6 4724.7 5465.9 5476.7 5480.8 5485.5 5500.8 6730.2 6731.6 6751.0 6763.4 6768.2 1677.8 1691.5 1695.4 1695.8 1696.7 1071.7 1090.5 1092.9 1107.8 1120.2 6514.5 6525.9 6533.2 6558.7 6572.9 6906.2 6907.6 6933.8 7019.2 7056.5 6459.5 6539.7 6602.6 6682.6 6715.1 3773.6 3807.0 3824.5 3828.5 3831.8 7299.6 7305.8 7344.6 7373.6 7380.2 7341.1 7358.7 7368.4 7381.3 7387.0 7093.8 7276.5 7322.6 7361.2 7376.5 7036.0 7047.8 7057.3 7071.0 7073.5 6910.6 6943.9 6960.9 6961.0 6961.2 7285.1 7332.8 7358.7 7367.6 7384.0 4517.3 4640.0 4641.0 4680.5 4700.2 6983.5 6987.4 6993.9 7013.5 7017.8 6779.6 6784.4 6785.2 6787.6 6792.3 6720.8 6779.4 6785.4 6793.1 6795.4 6571.4 6706.4 6785.2 6806.1 6811.6 6870.0 6874.7 6917.3 6921.7 6936.6 6662.9 6713.7 6728.7 6749.0 6758.0 09:55:18 INFO - PROCESS | 3460 | 09:55:18 INFO - PROCESS | 3460 | [#5] yui.html Cycles:180 Average:15156.86 Median:25910.66 stddev:17479.03 (67.5%) stddev-sans-first:17494.65 09:55:18 INFO - PROCESS | 3460 | Values: 765.6 801.5 818.7 846.9 877.1 16016.4 16282.2 16367.8 16381.5 16421.7 14685.3 14717.9 14818.0 14848.6 14853.9 920.6 921.6 933.2 945.2 947.2 911.4 911.5 914.8 915.1 918.5 977.0 978.5 980.3 980.4 981.4 967.6 967.9 972.6 974.6 975.4 714.1 714.2 715.8 718.4 720.9 15182.2 15304.5 15374.3 15377.2 15394.8 13723.9 13841.2 13937.4 14029.9 14116.5 10936.4 10946.2 11046.9 11130.8 11260.8 3727.1 3765.7 3809.4 3811.2 3988.9 54235.6 54308.2 54868.5 55022.4 55209.7 10643.0 11162.7 11260.8 11310.9 11352.1 20131.3 20180.6 20217.3 20231.4 20264.4 8079.6 8209.9 8275.0 8315.8 8352.4 4517.5 4766.7 4790.3 4879.2 4892.3 3395.9 3483.5 3488.9 3494.1 3498.6 627.8 629.0 631.6 633.3 639.5 638.6 655.3 659.1 665.0 665.8 7973.0 8485.7 8956.6 8972.9 8985.4 570.1 623.6 633.3 643.6 663.4 3992.9 4001.0 4019.7 4157.8 4178.2 62494.4 62916.0 63402.7 63910.7 64495.0 51754.0 53405.7 53679.5 54445.2 55264.4 51657.0 52345.5 52588.7 53222.0 53953.5 9173.4 9318.4 9529.0 9572.0 9597.4 36996.6 37285.4 37331.3 37843.2 38523.8 44727.0 47303.8 47626.5 47793.8 48058.0 12155.6 12697.4 13004.7 13082.0 13248.2 12877.5 13136.9 13229.7 13324.1 13342.7 11975.3 12142.3 12195.2 12280.1 12476.1 12465.9 12712.0 12768.0 12863.7 13008.5 11198.0 11289.7 11414.1 11433.8 11539.2 10712.3 10827.5 11291.3 11325.4 11381.7 9933.9 10155.4 10373.8 10613.0 10619.2 09:55:18 INFO - PROCESS | 3460 | -------- Summary: end -------- 09:55:18 INFO - PROCESS | 3460 | 09:55:18 INFO - TEST-INFO | 3460: exit 0 09:55:18 INFO - TEST-OK | dromaeo_css | took 1110467ms 09:55:18 INFO - TEST-START | kraken 09:55:18 INFO - operating with platform_type : linux_ 09:55:18 INFO - Initialising browser for kraken test... 09:55:18 INFO - TEST-INFO | started process 3709 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpapKu8n/profile http://localhost:55441/getInfo.html) 09:55:22 INFO - PROCESS | 3709 | 09:55:22 INFO - PROCESS | 3709 | (process:3785): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:55:23 INFO - PROCESS | 3709 | __metrics Screen width/height:1600/1200 09:55:23 INFO - PROCESS | 3709 | colorDepth:24 09:55:23 INFO - PROCESS | 3709 | Browser inner width/height: 1024/697 09:55:23 INFO - PROCESS | 3709 | __metrics 09:55:23 ERROR - PROCESS | 3709 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:55:24 INFO - TEST-INFO | 3709: exit 0 09:55:24 INFO - Browser initialized. 09:55:24 INFO - Running cycle 1/1 for kraken test... 09:55:24 INFO - TEST-INFO | started process 3836 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpapKu8n/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:26 INFO - PROCESS | 3836 | 09:55:26 INFO - PROCESS | 3836 | (process:3908): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:55:36 INFO - PROCESS | 3836 | RSS: Main: 154202112 09:55:36 INFO - PROCESS | 3836 | 09:55:38 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55441/tests/kraken/driver.html?testName=audio-beat-detection) 09:55:39 INFO - PROCESS | 3836 | RSS: Main: 157708288 09:55:39 INFO - PROCESS | 3836 | 09:55:42 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55441/tests/kraken/driver.html?testName=audio-dft) 09:55:42 INFO - PROCESS | 3836 | RSS: Main: 157073408 09:55:42 INFO - PROCESS | 3836 | 09:55:45 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55441/tests/kraken/driver.html?testName=audio-fft) 09:55:46 INFO - PROCESS | 3836 | RSS: Main: 159367168 09:55:46 INFO - PROCESS | 3836 | 09:55:48 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55441/tests/kraken/driver.html?testName=audio-oscillator) 09:55:48 INFO - PROCESS | 3836 | RSS: Main: 159244288 09:55:48 INFO - PROCESS | 3836 | 09:55:51 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55441/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:55:51 INFO - PROCESS | 3836 | RSS: Main: 159145984 09:55:51 INFO - PROCESS | 3836 | 09:55:54 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55441/tests/kraken/driver.html?testName=imaging-darkroom) 09:55:55 INFO - PROCESS | 3836 | RSS: Main: 158236672 09:55:55 INFO - PROCESS | 3836 | 09:55:58 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55441/tests/kraken/driver.html?testName=imaging-desaturate) 09:55:59 INFO - PROCESS | 3836 | RSS: Main: 158773248 09:55:59 INFO - PROCESS | 3836 | 09:56:02 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55441/tests/kraken/driver.html?testName=json-parse-financial) 09:56:02 INFO - PROCESS | 3836 | RSS: Main: 158322688 09:56:02 INFO - PROCESS | 3836 | 09:56:04 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55441/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:56:04 INFO - PROCESS | 3836 | RSS: Main: 158826496 09:56:04 INFO - PROCESS | 3836 | 09:56:06 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:56:07 INFO - PROCESS | 3836 | RSS: Main: 157614080 09:56:07 INFO - PROCESS | 3836 | 09:56:09 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:56:09 INFO - PROCESS | 3836 | RSS: Main: 157794304 09:56:09 INFO - PROCESS | 3836 | 09:56:12 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:56:12 INFO - PROCESS | 3836 | RSS: Main: 159281152 09:56:12 INFO - PROCESS | 3836 | 09:56:15 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:56:16 INFO - PROCESS | 3836 | RSS: Main: 159178752 09:56:16 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | Cycle 1(1): loaded http://localhost:55441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55441/tests/kraken/driver.html?testName=ai-astar) 09:56:17 INFO - PROCESS | 3836 | RSS: Main: 159272960 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | __start_tp_report 09:56:17 INFO - PROCESS | 3836 | _x_x_mozilla_page_load 09:56:17 INFO - PROCESS | 3836 | _x_x_mozilla_page_load_details 09:56:17 INFO - PROCESS | 3836 | |i|pagename|runs| 09:56:17 INFO - PROCESS | 3836 | |0;ai-astar;111;106;111;110;112;121;113;109;110;110 09:56:17 INFO - PROCESS | 3836 | |1;audio-beat-detection;160;126;151;170;139;160;164;127;160;129 09:56:17 INFO - PROCESS | 3836 | |2;audio-dft;163;161;162;161;163;164;163;161;161;161 09:56:17 INFO - PROCESS | 3836 | |3;audio-fft;76;75;75;159;76;74;72;73;163;76 09:56:17 INFO - PROCESS | 3836 | |4;audio-oscillator;95;92;148;92;93;94;150;93;93;150 09:56:17 INFO - PROCESS | 3836 | |5;imaging-gaussian-blur;118;117;117;117;117;118;117;117;118;117 09:56:17 INFO - PROCESS | 3836 | |6;imaging-darkroom;148;147;148;148;148;149;147;148;148;148 09:56:17 INFO - PROCESS | 3836 | |7;imaging-desaturate;96;96;96;96;98;96;96;97;96;95 09:56:17 INFO - PROCESS | 3836 | |8;json-parse-financial;55;56;56;56;56;58;56;66;54;54 09:56:17 INFO - PROCESS | 3836 | |9;json-stringify-tinderbox;64;65;64;64;64;65;65;64;64;67 09:56:17 INFO - PROCESS | 3836 | |10;stanford-crypto-aes;86;78;84;81;80;81;79;80;80;79 09:56:17 INFO - PROCESS | 3836 | |11;stanford-crypto-ccm;111;117;121;110;120;109;117;123;116;129 09:56:17 INFO - PROCESS | 3836 | |12;stanford-crypto-pbkdf2;140;140;158;146;151;138;149;150;148;138 09:56:17 INFO - PROCESS | 3836 | |13;stanford-crypto-sha256-iterative;66;71;69;67;69;66;67;70;70;68 09:56:17 INFO - PROCESS | 3836 | __end_tp_report 09:56:17 INFO - PROCESS | 3836 | __start_cc_report 09:56:17 INFO - PROCESS | 3836 | _x_x_mozilla_cycle_collect,812 09:56:17 INFO - PROCESS | 3836 | __end_cc_report 09:56:17 INFO - PROCESS | 3836 | __startTimestamp1458838577945__endTimestamp 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | ------- Summary: start ------- 09:56:17 INFO - PROCESS | 3836 | Number of tests: 14 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:3.89 (3.5%) stddev-sans-first:4.12 09:56:17 INFO - PROCESS | 3836 | Values: 111.0 106.0 111.0 110.0 112.0 121.0 113.0 109.0 110.0 110.0 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:160.00 stddev:16.81 (10.5%) stddev-sans-first:17.32 09:56:17 INFO - PROCESS | 3836 | Values: 160.0 126.0 151.0 170.0 139.0 160.0 164.0 127.0 160.0 129.0 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.15 (0.7%) stddev-sans-first:1.17 09:56:17 INFO - PROCESS | 3836 | Values: 163.0 161.0 162.0 161.0 163.0 164.0 163.0 161.0 161.0 161.0 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#3] audio-fft Cycles:10 Average:91.90 Median:75.00 stddev:36.46 (48.6%) stddev-sans-first:38.21 09:56:17 INFO - PROCESS | 3836 | Values: 76.0 75.0 75.0 159.0 76.0 74.0 72.0 73.0 163.0 76.0 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:93.00 stddev:27.16 (29.2%) stddev-sans-first:28.26 09:56:17 INFO - PROCESS | 3836 | Values: 95.0 92.0 148.0 92.0 93.0 94.0 150.0 93.0 93.0 150.0 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 09:56:17 INFO - PROCESS | 3836 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 09:56:17 INFO - PROCESS | 3836 | Values: 148.0 147.0 148.0 148.0 148.0 149.0 147.0 148.0 148.0 148.0 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 09:56:17 INFO - PROCESS | 3836 | Values: 96.0 96.0 96.0 96.0 98.0 96.0 96.0 97.0 96.0 95.0 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:3.47 (6.2%) stddev-sans-first:3.62 09:56:17 INFO - PROCESS | 3836 | Values: 55.0 56.0 56.0 56.0 56.0 58.0 56.0 66.0 54.0 54.0 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:64.50 stddev:0.97 (1.5%) stddev-sans-first:1.00 09:56:17 INFO - PROCESS | 3836 | Values: 64.0 65.0 64.0 64.0 64.0 65.0 65.0 64.0 64.0 67.0 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:2.44 (3.0%) stddev-sans-first:1.72 09:56:17 INFO - PROCESS | 3836 | Values: 86.0 78.0 84.0 81.0 80.0 81.0 79.0 80.0 80.0 79.0 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:118.50 stddev:6.27 (5.3%) stddev-sans-first:6.22 09:56:17 INFO - PROCESS | 3836 | Values: 111.0 117.0 121.0 110.0 120.0 109.0 117.0 123.0 116.0 129.0 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:148.50 stddev:6.65 (4.5%) stddev-sans-first:6.71 09:56:17 INFO - PROCESS | 3836 | Values: 140.0 140.0 158.0 146.0 151.0 138.0 149.0 150.0 148.0 138.0 09:56:17 INFO - PROCESS | 3836 | 09:56:17 INFO - PROCESS | 3836 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.77 (2.6%) stddev-sans-first:1.67 09:56:17 INFO - PROCESS | 3836 | Values: 66.0 71.0 69.0 67.0 69.0 66.0 67.0 70.0 70.0 68.0 09:56:17 INFO - PROCESS | 3836 | -------- Summary: end -------- 09:56:17 INFO - PROCESS | 3836 | 09:56:18 INFO - TEST-INFO | 3836: exit 0 09:56:18 INFO - TEST-OK | kraken | took 59981ms 09:56:18 INFO - SUITE-END | took 1170s 09:56:19 INFO - Completed test suite (00:19:30) 09:56:19 INFO - javascript benchmark 09:56:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3281.343731253749, 3284.3759685659707, 3294.7199488043516, 3317.452620317648, 3317.568716066911, 5295.761690723917, 5300.681959082448, 5337.866553336164, 5348.197770334452, 5354.919676204855, 5256.395514515832, 5321.068812957727, 5325.4940780625875, 5331.786728530864, 5334.626576139672, 4851.296561998517, 4873.756312184394, 4935.383077115361, 4941.160002799515, 4945.876353091166, 4891.046245982035, 4958.603311735071, 4963.156263435207, 5018.946021335506, 5065.670731402465, 5062.746862656871, 5111.207762796773, 5114.718690472023, 5115.59075273979, 5136.666116702402, 4938.703677779309, 5067.290579318898, 5080.263361812535, 5085.364329458836, 5140.280360749498, 4878.8292409765845, 4934.087193869145, 4990.326305948687, 5048.444671086178, 5069.949300506984, 5219.19102539107, 5242.659227150223, 5245.711485868275, 5286.1013627683005, 5293.550048245904, 5806.1581070744505, 5812.070068789016, 5829.912551311733, 5836.270466191726, 5839.970800146015, 5751.05107657236, 5869.677167755772, 5882.735276912549, 5927.051671732545, 5971.761129554812, 5432.456754324536, 5442.265294185314, 5446.7276636168035, 5453.83638490842, 5457.263269458612, 5838.854028649318, 5881.441263080001, 5885.823425297248, 5886.676232807236, 5897.085951677497, 5630.8029218977135, 5648.350439699405, 5679.261695979496, 5688.23208866806, 5762.337331206881, 5907.822765317047, 5907.911381329283, 5912.290525136925, 5925.022371308772, 5933.465988061009, 5676.347220069662, 5916.3787802281, 5928.081147422156, 5929.584929055011, 5949.732262048218, 5880.588358814927, 5926.377730338339, 5927.911081333784, 5931.525477961753, 5989.341172471025, 4262.403263543107, 4347.434833471629, 4476.932846007313, 4488.865334039984, 4488.910221795546, 3923.2741942740686, 3962.1679447316387, 4012.0972781124015, 4020.8190631421658, 4039.030632648143, 5493.23094766733, 5567.832965011056, 5610.382857885629, 5613.129964855454, 5659.858503537363, 5923.0, 5931.080682494134, 5937.346891841894, 5948.7323070461935, 5965.701714914237, 5500.092484739973, 5628.831135065954, 5646.3224413069875, 5655.264815573949, 5655.434456554394, 5047.899042019139, 5092.879566495365, 5108.540231379194, 5125.948740512622, 5156.948430515722, 6033.698315084228, 6097.451229389376, 6099.3900609938655, 6101.755929762849, 6115.1744514490865, 5748.45389687979, 5916.142159386951, 5918.112283157561, 5928.614640048383, 5934.584579079423, 5959.970200148971, 5964.671943043, 5987.371326010706, 6005.519558435228, 6035.668038257938, 5756.280464941882, 5757.136429535603, 5758.942410575841, 5761.164631128547, 5761.510271626791, 5829.242198514166, 5838.32859221195, 5847.181394604844, 5857.707114644336, 5862.618929769551, 5826.096954971986, 5853.590248682552, 5858.384869588632, 5859.882802343844, 5860.2967643883, 5744.626599271034, 5764.913526297193, 5817.563682723728, 5820.447057529697, 5826.155207494974, 5514.779408823602, 5685.658860468385, 5727.599068065196, 5743.3395159557185, 5808.82573522795, 5601.24383208278, 5624.85937851557, 5702.885942281214, 5747.281589801275, 5863.560232982458, 5568.638038527482, 5588.105903055492, 5588.804391846428, 5591.04952158126, 5598.21624972496], "unit": "score", "name": "dojo.html", "value": 5401.27372229094}, {"lowerIsBetter": false, "replicates": [509.2666560153381, 538.1980848535683, 551.4154995704553, 575.7409165875357, 605.1890466774522, 40020.59979400205, 40620.39069413954, 40650.186996260054, 40691.0, 40692.0, 40816.795916020375, 40824.0, 41053.38419923696, 41091.17817643653, 41260.17479650405, 8775.254103401203, 8949.731508054769, 9001.144891235355, 9003.594838232295, 9027.052159523255, 8662.090480499552, 8815.162559556831, 8853.73438796837, 8911.821763564725, 8915.375923685344, 8898.332625053115, 8938.4190027648, 8949.910500894974, 8954.059823718513, 8991.820163596723, 8883.333749968746, 8964.641414343418, 8966.23786978111, 8968.192862642329, 8968.730938071869, 8900.910990890137, 9023.233025192802, 9131.908680913173, 9135.132162444557, 9138.862917056249, 43518.0, 43606.0, 43916.56083439157, 43949.56050439487, 44180.779096104634, 3168.683131686836, 3534.8939531814085, 3598.8380522876273, 3840.7695538267794, 3901.1612503311926, 29974.40051198964, 30166.09501714952, 30246.243843904078, 30545.541816872767, 30900.845495772603, 3930.449737036817, 3955.9011024724614, 3961.6038396160443, 4033.455483509718, 4038.818253178614, 197915.0, 199069.0, 199395.0, 199401.0, 199470.0, 44478.77760611176, 63860.36139638637, 63932.99999999907, 64290.67854660697, 64714.35285647177, 43643.127137457705, 43774.34338484862, 43834.342484862755, 44019.55980440219, 44058.0, 14987.775183372258, 15309.540713778604, 15388.769168462482, 15407.075575465284, 15409.075455472708, 12605.243685378906, 12791.680207994688, 12803.551875684307, 12867.806982895265, 12870.678233044062, 15765.290561924741, 15780.842191578167, 15792.447264345692, 15801.920990395205, 15824.208789560476, 6059.151718759377, 6128.0, 6149.3235744068115, 6208.348123447064, 6244.968775156095, 999.0209594597335, 1007.2596641468515, 1106.181425744943, 1107.1751545098953, 1145.3872178384524, 30261.0, 30358.0, 30671.0, 30850.0, 30895.691043089282, 1035.7928414317166, 1051.0750539525322, 1070.6466865934224, 1107.0147568663895, 1158.1892675127444, 15537.68924621524, 15716.60708482297, 16005.759913601305, 16162.515124546282, 16263.674726505404, 330311.0, 512049.0, 512163.0, 771205.0, 794477.0, 61882.69058654678, 62766.68616656979, 62803.6859815698, 62998.0, 63043.0, 1456.606716186645, 1463.7731151671508, 1474.0787008119926, 1476.45371212652, 1486.7621180611266, 32114.518282226254, 32218.0, 32716.182095447803, 32883.34233315272, 33427.0, 51185.0, 51490.48509514857, 51663.74168129135, 51878.74060629673, 52073.0, 308102.0, 310846.0, 311132.0, 311140.0, 312457.0, 35040.0, 35041.824790875886, 35116.82441587776, 35162.29675406529, 35452.29095418129, 42343.57656423396, 42754.144917100864, 44535.0, 47678.52321476741, 48057.27914081362, 40115.59884401118, 40425.595744042184, 40480.39279410752, 40900.0, 41497.0, 39381.01547461336, 39490.605093948696, 42940.570594294906, 44433.555664442945, 44713.55286447094, 37352.0, 37840.81079594584, 38047.61952380441, 38115.0, 38311.80844095873, 34384.0, 34974.47538286979, 35279.11802204965, 35936.10159745923, 35940.0, 26562.203133906012, 26893.596596050684, 26937.191884243504, 27221.455570888076, 27620.58569121505], "unit": "score", "name": "ext.html", "value": 19210.953392571377}, {"lowerIsBetter": false, "replicates": [374.58795325142347, 387.66467006039767, 390.5391637867317, 398.7766850563685, 398.80458575298076, 17131.62946964243, 19194.808051919477, 19300.806991930112, 19836.206551737912, 19965.99999999998, 18211.544711382223, 18223.453296401098, 18236.908815455936, 18300.176492057857, 18475.445736627924, 5384.6499977501435, 5607.43925607438, 5620.381758006616, 5628.240187574686, 5656.406077361879, 4117.629413352797, 5907.438793314628, 6128.080787881809, 6153.0, 6168.4448399644025, 5908.438698323653, 6101.542384321171, 6104.08438734189, 6104.633721976674, 6130.816075517741, 5989.161517387569, 5998.790042348497, 6009.218801555813, 6018.127371531104, 6026.517878569748, 5251.527362537352, 5347.25138480613, 5351.357837059539, 5378.408375078739, 5379.085555455582, 21874.89062554677, 22111.44721381978, 22123.115075396963, 22123.668144977837, 22141.66787498189, 2461.6184491403683, 2509.4228327484598, 2586.1465716313573, 2691.219546331581, 2968.554716792477, 13415.530456434075, 13649.727005459934, 13767.449302027906, 13951.0, 13964.650883727989, 1917.731517587539, 1925.3550060729672, 1926.6532024235632, 1951.2000079967145, 1958.8139126782933, 64100.35899640991, 65880.34119658839, 66265.0, 66316.6684166581, 68054.65972670155, 10542.894571054345, 10815.621453249098, 10826.18803589734, 10956.780864382668, 10960.068394186424, 13520.0, 13523.580024097524, 13625.659358516117, 13629.114107582975, 13717.17696938187, 7941.563214023168, 8139.145389734111, 8142.877856832152, 8268.586570671443, 8338.541380224025, 7989.960050199828, 8018.639161237758, 8078.474899131537, 8108.1891810819625, 8113.188681131957, 6145.539084568675, 6175.96912015446, 6210.4100110489435, 6359.046143078575, 6388.297287298394, 1891.952701182454, 1900.2494014864328, 1907.6661584222707, 1963.3520938090396, 1995.8702684325472, 956.9282303827241, 965.5703212070702, 999.3504222255592, 1030.2736570717625, 1037.7561273100816, 16903.323867045427, 17266.136693165543, 17422.738658920127, 17565.12174391301, 17979.910100449415, 924.505389616552, 971.2521358553875, 984.478226539935, 990.881094268678, 1011.0243614911645, 10047.648332308334, 10093.142082922886, 10114.54484548197, 10177.84733229002, 10306.12397946168, 419490.0, 420168.0, 421084.0, 427703.0, 432687.0, 74675.62662186654, 75348.0, 76309.61845190739, 76556.61721691355, 77458.61270693611, 1017.1557607186018, 1041.8749750030045, 1079.2553138334524, 1081.6268387406333, 1086.43505377205, 15549.455769048029, 15644.530664080095, 15663.0, 16384.918075409547, 16436.260368283216, 32520.51219231761, 33731.15672108217, 35787.46318805168, 36158.457623135146, 36315.0, 45634.16252238369, 48368.0, 48461.27308090311, 48871.75564122156, 49066.75466622644, 7933.246341597539, 8157.326995610316, 8159.796005099683, 8199.42604017713, 8370.121137280497, 6866.759663411756, 10630.990055944672, 11702.35637039937, 12670.873291267339, 13683.179009259477, 11465.426728663366, 11475.311481311148, 11552.6534203974, 11586.826197606873, 11978.820317695066, 9862.802743945225, 11644.0, 11702.70743231426, 11949.402529873298, 12025.398730063287, 11509.827352589551, 11740.941295293469, 11743.11926605491, 11885.821712674144, 12316.630501084981, 8136.7152149674475, 8209.179082091743, 8238.0, 8372.07907130203, 8401.411901166859, 11033.393163375771, 11168.553257869595, 11189.608363707557, 11315.264507806965, 11667.124965627441], "unit": "score", "name": "jquery.html", "value": 8987.162533243893}, {"lowerIsBetter": false, "replicates": [1603.4948991067813, 1651.9174041297936, 1900.8099190080993, 1950.8341790947768, 1973.1219607274759, 7416.0729908761405, 7955.840883182333, 8365.079841217468, 8565.0, 8575.528345940978, 8268.545230012347, 8353.164683531644, 8407.663693452254, 8423.199796019368, 8442.0, 2466.2108125399877, 2499.8750062496892, 2502.674652295199, 2504.6743923289946, 2505.7619526144986, 2415.625578035407, 2467.3954881054165, 2473.938151546208, 2493.6508888755498, 2493.775560199582, 2439.756024397555, 2464.9753502465014, 2470.0243403855466, 2477.529269438801, 2480.6651102101164, 2424.927252182446, 2443.9633405498844, 2461.3723500507435, 2474.0, 2496.750324967507, 2430.501747141832, 2430.8419952703193, 2433.367324495644, 2436.2082323245018, 2481.727010028895, 8456.746297611082, 8527.95736021322, 8539.231469167742, 8540.78648033798, 8594.484330940164, 4985.351904252424, 5176.55999240065, 5185.974070129663, 5204.219367094928, 5232.686038837682, 3124.4844600641095, 3141.780075394723, 3164.240582260264, 3324.6176689680756, 3335.2995870866903, 992.1368409483723, 1005.2460654509118, 1005.8943810899823, 1015.7308313296909, 1031.118393773328, 11748.353840538766, 11749.118816088741, 11793.351365674798, 11798.764024719543, 11821.645350639408, 4602.723836569817, 4686.250199967989, 4744.786484608201, 4759.928601070987, 4785.353977213102, 9008.32437567172, 9013.414128081653, 9087.727368178965, 9112.772180695403, 9142.177204051533, 5023.321851549994, 5024.899502009939, 5038.546530812171, 5055.115354812893, 5058.317127187856, 4504.729716216972, 4594.724316541018, 4605.815767369268, 4660.440747110369, 4674.182018146811, 3644.2529281497227, 3689.723270754704, 3704.2961837251373, 3764.1906989997283, 3772.905677358088, 1141.594733869481, 1146.2549342927164, 1157.4039369724599, 1160.7040204747734, 1164.1094562659573, 1045.3048722599538, 1058.4548957287004, 1067.6209945469402, 1288.2013151845915, 1428.649980754701, 7664.425168112414, 7667.1949445308555, 7776.844463110706, 7795.610219489003, 7816.765497035098, 517.0615333170284, 519.4675457655933, 539.9541039011649, 542.8018773147852, 549.5027000564495, 6059.0, 6136.509079273647, 6137.7851775187655, 6147.600405973598, 6184.196054512884, 10087.394756314645, 10512.579496820195, 10528.210384221215, 10541.736456588647, 10630.0, 10035.147012503872, 10221.080102790636, 10272.948635256776, 10385.896141038493, 10464.947675261576, 7972.0, 7973.521588704581, 8036.718714844952, 8061.758147255592, 8123.675052997932, 7602.46782725204, 7654.8086297843, 7662.501937374052, 7698.2686644768655, 7730.613469326624, 8295.668173273243, 8541.402101852811, 8685.782855428664, 8696.608652610774, 8745.212930836255, 8685.435446695945, 8853.73438796837, 8860.468371897448, 8863.822723545622, 9016.549172541478, 6841.863162736817, 7048.859022819617, 7102.680379382837, 7491.175970643116, 7624.58064806441, 8146.714864979697, 8183.918160818315, 8194.959025204837, 8201.671933122609, 8233.670653173805, 7360.521566098187, 7364.96317518409, 7367.926320736724, 7486.139094004041, 7572.20491848348, 7036.648167591702, 7212.2427145151105, 7220.711171553079, 7279.272072792678, 7357.8160545986775, 7062.258462861326, 7111.928880711127, 7183.138023437221, 7183.461240407095, 7205.459590530626, 6701.53089283765, 6781.762638307636, 6836.794896153124, 6849.726010959505, 6854.931450685629, 6767.424768894699, 6797.456203503807, 6819.89770153458, 6852.862942741018, 6869.0], "unit": "score", "name": "mootools.html", "value": 4675.251600961507}, {"lowerIsBetter": false, "replicates": [351.69051234913275, 354.40460027154376, 358.1297447203295, 359.86684926577163, 360.31899709548975, 6295.67790763939, 6329.968350158254, 6337.778177763779, 6385.39338762818, 6393.136926514919, 6293.30773614902, 6296.9685151574295, 6309.085182648513, 6311.0, 6316.178896743417, 4670.1126785910565, 4793.113274044295, 4820.132376172288, 4821.879453013667, 4862.829800956967, 4787.353707249512, 4797.880052998668, 4802.327674125625, 4811.59101476375, 4815.253635686474, 4700.647451441138, 4748.691335063227, 4750.76246187691, 4751.073540659573, 4759.500252473493, 4722.7402492862875, 4729.59798417135, 4734.455537613184, 4734.786934587934, 4761.428628564559, 4116.650084742801, 4119.588041195886, 4132.979335103305, 4141.420201171838, 4142.689298302639, 5926.259217597801, 5927.703614819285, 5941.405859414024, 5967.9701601491715, 5974.761009559613, 5422.0, 5489.780408783684, 5558.777648894039, 5560.666360018412, 5582.804601838916, 6621.93378066218, 6635.767748128841, 6660.567063140928, 6689.498287628398, 6691.096701945224, 4596.885077873047, 4597.310403439511, 4602.884927876797, 4605.286180642006, 4607.078584283123, 6934.341237582422, 6939.514234003622, 6951.096357473496, 6964.303569642995, 6997.440204783605, 4570.794314255866, 4640.65195110368, 4642.51253618372, 4656.998745269783, 4660.53394660538, 4672.813087476531, 4708.882277943078, 4709.905801883943, 4719.5752382285755, 4724.692894961817, 5465.863353416196, 5476.698781566973, 5480.808171713971, 5485.451454854483, 5500.779968801283, 6730.226024007204, 6731.562448440835, 6750.966245168841, 6763.425108865801, 6768.187817461936, 1677.7567252748283, 1691.4502786594405, 1695.440504633468, 1695.8219386964438, 1696.720041193214, 1071.6838532632892, 1090.5310716392028, 1092.8743394303879, 1107.8338249262674, 1120.2326406411635, 6514.478841692748, 6525.902111468332, 6533.150690410216, 6558.704858281389, 6572.934270657232, 6906.240313565604, 6907.585544867324, 6933.791986240421, 7019.227884932653, 7056.506044576933, 6459.547831651833, 6539.738410463528, 6602.60384376939, 6682.599044057372, 6715.059891615178, 3773.6226377362045, 3807.0, 3824.5028146340796, 3828.5405751310022, 3831.8275677594575, 7299.635018249066, 7305.817354566178, 7344.596047217347, 7373.631318434164, 7380.225076366904, 7341.119065712042, 7358.66885990121, 7368.410527157815, 7381.298776616213, 7386.96306518464, 7093.82265443368, 7276.454265930077, 7322.560646361236, 7361.153467351216, 7376.483646144826, 7035.964820175866, 7047.788566343018, 7057.329553692391, 7070.964645176741, 7073.504854660125, 6910.550814197061, 6943.930560694328, 6960.930390696029, 6960.965195173992, 6961.199462061928, 7285.089363829521, 7332.78001659951, 7358.66885990121, 7367.594782287026, 7384.040074790243, 4517.299818528133, 4640.04878999811, 4640.976795116003, 4680.5085466025575, 4700.200965835747, 6983.476239282176, 6987.441004719712, 6993.930060699327, 7013.509054366145, 7017.824554385977, 6779.559328643622, 6784.3894049535775, 6785.185777706707, 6787.558808677618, 6792.286809884891, 6720.764773232913, 6779.423748981392, 6785.389314961677, 6793.082933804071, 6795.354441328066, 6571.408573228432, 6706.429953453816, 6785.185777706707, 6806.149231346082, 6811.591304521745, 6869.969504574354, 6874.690638921161, 6917.273686263071, 6921.7231310747, 6936.583804971718, 6662.933370666231, 6713.6643167842385, 6728.697208625722, 6748.966255168692, 6757.966210168917], "unit": "score", "name": "prototype.html", "value": 5071.9950931622}, {"lowerIsBetter": false, "replicates": [765.6401491299089, 801.5030680977793, 818.6970820796306, 846.9068402475726, 877.0922095631015, 16016.439424620141, 16282.185890705447, 16367.83632163681, 16381.508554743363, 16421.67156656869, 14685.33915973781, 14717.926410367932, 14818.0, 14848.628784280398, 14853.851461485381, 920.5765347939956, 921.6451666108563, 933.1927882381725, 945.1918609588771, 947.1712251779693, 911.3939230411768, 911.544227886057, 914.7575892388522, 915.0529202275646, 918.5269586163131, 976.9951150244239, 978.5498670611527, 980.2843923935532, 980.4313498171043, 981.4209616326366, 967.5984466446416, 967.9128878400978, 972.5672075926216, 974.6393834281362, 975.4244995452682, 714.0859699584488, 714.17156098925, 715.7637979466764, 718.3857801579678, 720.9026781384498, 15182.240887955668, 15304.540863774104, 15374.308156133, 15377.231138443145, 15394.769078463833, 13723.862761372358, 13841.238731869744, 13937.442502299897, 14029.929850350683, 14116.50592229267, 10936.398498082603, 10946.233763636468, 11046.889531104667, 11130.833037504444, 11260.831087533694, 3727.0682329417646, 3765.6799172070405, 3809.4285857121654, 3811.1805961718364, 3988.880333589997, 54235.6441088972, 54308.18537721937, 54868.45131548713, 55022.44977550213, 55209.72395137999, 10643.0, 11162.665120046411, 11260.774784504263, 11310.943445282886, 11352.091832653368, 20131.295404660767, 20180.59638807245, 20217.29239476611, 20231.393058208276, 20264.392068237976, 8079.596020199084, 8209.876851847228, 8274.958625206835, 8315.83368332642, 8352.373571982125, 4517.548245175456, 4766.713997160182, 4790.257510085942, 4879.170541008037, 4892.290617860462, 3395.881144159992, 3483.512308276843, 3488.8778892738633, 3494.109002204422, 3498.5801703795705, 627.8461776864606, 628.9622622642656, 631.5705320382184, 633.3096924352386, 639.5203597302024, 638.565775272819, 655.2890114226022, 659.133239789675, 664.9900251496232, 665.8235567574596, 7973.0, 8485.660573576988, 8956.641734330684, 8972.910270897208, 8985.371024028385, 570.0736303506801, 623.5915475363644, 633.2749002392327, 643.6073994863129, 663.3896814930275, 3992.9201415972097, 4000.959990400117, 4019.738716983387, 4157.750534967911, 4178.185253875465, 62494.375056249766, 62916.0, 63402.68298658569, 63910.68044659747, 64495.03257451142, 51754.0, 53405.732971335674, 53679.46320536744, 54445.183322250195, 55264.44735552673, 51657.0, 52345.47654523406, 52588.73705631447, 53222.0, 53953.46046539484, 9173.44959302444, 9318.394304370195, 9528.95235523818, 9572.0, 9597.424154550748, 36996.630033699315, 37285.4407183887, 37331.253374932894, 37843.243135136596, 38523.80738096291, 44727.0, 47303.763481182374, 47626.52373476221, 47793.76103119462, 48058.0, 12155.574554890536, 12697.42861571213, 13004.739905201654, 13082.0, 13248.20510769357, 12877.549285774952, 13136.868631313946, 13229.669258268235, 13324.133931294435, 13342.666433338856, 11975.28148311104, 12142.332171730639, 12195.207311524722, 12280.140390172603, 12476.126671132934, 12465.93767031159, 12712.046596505113, 12768.0, 12863.678408039874, 13008.544700935421, 11198.0, 11289.661310160709, 11414.086873050303, 11433.771324573296, 11539.19225654196, 10712.303700259457, 10827.458627068772, 11291.266067705574, 11325.377104259016, 11381.658550243506, 9933.900660993297, 10155.387619937035, 10373.844392333971, 10613.0, 10619.203559732896], "unit": "score", "name": "yui.html", "value": 6911.8858331264255}], "name": "dromaeo_css", "value": 7312.188829780383}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 110.0, 112.0, 121.0, 113.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [160.0, 126.0, 151.0, 170.0, 139.0, 160.0, 164.0, 127.0, 160.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 161.0, 163.0, 164.0, 163.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 75.0, 159.0, 76.0, 74.0, 72.0, 73.0, 163.0, 76.0], "unit": "score", "name": "audio-fft", "value": 91.9}, {"lowerIsBetter": true, "replicates": [95.0, 92.0, 148.0, 92.0, 93.0, 94.0, 150.0, 93.0, 93.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 149.0, 147.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 97.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 56.0, 56.0, 56.0, 58.0, 56.0, 66.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [86.0, 78.0, 84.0, 81.0, 80.0, 81.0, 79.0, 80.0, 80.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.8}, {"lowerIsBetter": true, "replicates": [111.0, 117.0, 121.0, 110.0, 120.0, 109.0, 117.0, 123.0, 116.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.3}, {"lowerIsBetter": true, "replicates": [140.0, 140.0, 158.0, 146.0, 151.0, 138.0, 149.0, 150.0, 148.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 69.0, 67.0, 69.0, 66.0, 67.0, 70.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1518.6999999999996}]} 09:56:19 INFO - Return code: 0 09:56:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:56:19 ERROR - # TBPL SUCCESS # 09:56:19 INFO - Running post-action listener: _resource_record_post_action 09:56:19 INFO - Running post-run listener: _resource_record_post_run 09:56:20 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 7950336; Write bytes: 378294272; Read time: 1688; Write time: 255052 09:56:20 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 3055616; Read time: 0; Write time: 364 09:56:20 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 6189056; Write bytes: 375238656; Read time: 1648; Write time: 254688 09:56:20 INFO - Running post-run listener: _upload_blobber_files 09:56:20 INFO - Blob upload gear active. 09:56:20 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:56:20 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 09:56:20 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'] 09:56:20 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 09:56:21 INFO - (blobuploader) - INFO - Open directory for files ... 09:56:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:56:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:56:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:22 INFO - (blobuploader) - INFO - Done attempting. 09:56:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:56:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:56:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:23 INFO - (blobuploader) - INFO - Done attempting. 09:56:23 INFO - (blobuploader) - INFO - Iteration through files over. 09:56:23 INFO - Return code: 0 09:56:23 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:56:23 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:56:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d61c1fe682d7f9d49532ece349a8ecbf00d11425069f372444cef971f3d872242e162f260ce22162c42c7b9a7779b66fc60a2a82ffd2bcff9d22caa27bdcd9a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b604a1eae8a1453c59b044fc62ccffbbd12beedc973e98dc688c1f815cb82fff006fbd4030d7a5f573c9842c66d3288b8ef5b9ec95b4a593e3307dcf4021f417"} 09:56:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:56:23 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:56:23 INFO - Contents: 09:56:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d61c1fe682d7f9d49532ece349a8ecbf00d11425069f372444cef971f3d872242e162f260ce22162c42c7b9a7779b66fc60a2a82ffd2bcff9d22caa27bdcd9a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b604a1eae8a1453c59b044fc62ccffbbd12beedc973e98dc688c1f815cb82fff006fbd4030d7a5f573c9842c66d3288b8ef5b9ec95b4a593e3307dcf4021f417"} 09:56:23 INFO - Running post-run listener: copy_logs_to_upload_dir 09:56:23 INFO - Copying logs to upload dir... 09:56:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:56:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.141464 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-03-24 09:56:23.772590) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 09:56:23.776004) ========= 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=82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449 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/d61c1fe682d7f9d49532ece349a8ecbf00d11425069f372444cef971f3d872242e162f260ce22162c42c7b9a7779b66fc60a2a82ffd2bcff9d22caa27bdcd9a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b604a1eae8a1453c59b044fc62ccffbbd12beedc973e98dc688c1f815cb82fff006fbd4030d7a5f573c9842c66d3288b8ef5b9ec95b4a593e3307dcf4021f417"} build_url:https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010433 build_url: 'https://queue.taskcluster.net/v1/task/CkiyYb4CSxWYYoHF5CArYQ/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/d61c1fe682d7f9d49532ece349a8ecbf00d11425069f372444cef971f3d872242e162f260ce22162c42c7b9a7779b66fc60a2a82ffd2bcff9d22caa27bdcd9a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b604a1eae8a1453c59b044fc62ccffbbd12beedc973e98dc688c1f815cb82fff006fbd4030d7a5f573c9842c66d3288b8ef5b9ec95b4a593e3307dcf4021f417"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 09:56:23.882384) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:56:23.882717) ========= 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=82e07478c745e68b1fe4678a000001bc-1458836171.636980-57784449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:56:24.013821) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 09:56:24.014124) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 09:56:24.014412) ========= ========= Total master_lag: 0.38 =========