builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1457146798.31 results: success (0) buildid: 20160304163145 builduid: 10c7fcc6d5fa418c91b3a630bfc05914 revision: 806c404edf0659469c38c8e4a21b28e0c430b3ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.314339) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.314723) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.315032) ========= 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=52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008992 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.337923) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.338214) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.351471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.351752) ========= 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=52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.400557) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.400853) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.401208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.401501) ========= 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=52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-04 18:59:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 92.6M=0s 2016-03-04 18:59:58 (92.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161375 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.575136) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.575456) ========= 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=52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015442 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.624922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:58.625279) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 806c404edf0659469c38c8e4a21b28e0c430b3ba --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 806c404edf0659469c38c8e4a21b28e0c430b3ba --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=52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-04 18:59:59,003 truncating revision to first 12 chars 2016-03-04 18:59:59,003 Setting DEBUG logging. 2016-03-04 18:59:59,003 attempt 1/10 2016-03-04 18:59:59,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/806c404edf06?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-04 18:59:59,410 unpacking tar archive at: mozilla-inbound-806c404edf06/testing/mozharness/ program finished with exit code 0 elapsedTime=0.717088 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:59.356412) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:59.356980) ========= echo 806c404edf0659469c38c8e4a21b28e0c430b3ba in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'806c404edf0659469c38c8e4a21b28e0c430b3ba'] 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=52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 806c404edf0659469c38c8e4a21b28e0c430b3ba program finished with exit code 0 elapsedTime=0.004236 script_repo_revision: '806c404edf0659469c38c8e4a21b28e0c430b3ba' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:59.407676) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:59.408004) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 18:59:59.423270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-04 18:59:59.423558) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:59:59 INFO - MultiFileLogger online at 20160304 18:59:59 in /builds/slave/test-pgo 18:59:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:59:59 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:59:59 INFO - {'append_to_log': False, 18:59:59 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:59:59 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:59:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:59:59 INFO - 'branch': 'Mozilla-Inbound', 18:59:59 INFO - 'buildbot_json_path': 'buildprops.json', 18:59:59 INFO - 'config_files': ('talos/linux_config.py',), 18:59:59 INFO - 'default_actions': ('clobber', 18:59:59 INFO - 'read-buildbot-config', 18:59:59 INFO - 'download-and-extract', 18:59:59 INFO - 'populate-webroot', 18:59:59 INFO - 'create-virtualenv', 18:59:59 INFO - 'install', 18:59:59 INFO - 'run-tests'), 18:59:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:59:59 INFO - 'download_minidump_stackwalk': True, 18:59:59 INFO - 'download_symbols': 'ondemand', 18:59:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:59:59 INFO - 'tooltool.py': '/tools/tooltool.py', 18:59:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:59:59 INFO - '/tools/misc-python/virtualenv.py')}, 18:59:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:59:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:59:59 INFO - 'installer_path': 'installer.exe', 18:59:59 INFO - 'log_level': 'info', 18:59:59 INFO - 'log_name': 'talos', 18:59:59 INFO - 'log_to_console': True, 18:59:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:59:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:59:59 INFO - 'opt_config_files': (), 18:59:59 INFO - 'pip_index': False, 18:59:59 INFO - 'sps_profile': False, 18:59:59 INFO - 'sps_profile_interval': 0, 18:59:59 INFO - 'suite': 'dromaeojs-e10s', 18:59:59 INFO - 'system_bits': '32', 18:59:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:59:59 INFO - 'title': 'talos-linux64-ix-056', 18:59:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:59:59 INFO - 'use_talos_json': True, 18:59:59 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:59:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:59:59 INFO - 'work_dir': 'build'} 18:59:59 INFO - ##### 18:59:59 INFO - ##### Running clobber step. 18:59:59 INFO - ##### 18:59:59 INFO - Running pre-action listener: _resource_record_pre_action 18:59:59 INFO - Running main action method: clobber 18:59:59 INFO - rmtree: /builds/slave/test-pgo/build 18:59:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:00:00 INFO - Running post-action listener: _resource_record_post_action 19:00:00 INFO - ##### 19:00:00 INFO - ##### Running read-buildbot-config step. 19:00:00 INFO - ##### 19:00:00 INFO - Running pre-action listener: _resource_record_pre_action 19:00:00 INFO - Running main action method: read_buildbot_config 19:00:00 INFO - Using buildbot properties: 19:00:00 INFO - { 19:00:00 INFO - "project": "", 19:00:00 INFO - "product": "firefox", 19:00:00 INFO - "script_repo_revision": "production", 19:00:00 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:00:00 INFO - "repository": "", 19:00:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:00:00 INFO - "buildid": "20160304163145", 19:00:00 INFO - "pgo_build": "True", 19:00:00 INFO - "basedir": "/builds/slave/test-pgo", 19:00:00 INFO - "buildnumber": 457, 19:00:00 INFO - "slavename": "talos-linux64-ix-056", 19:00:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:00:00 INFO - "platform": "ubuntu64_hw", 19:00:00 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:00:00 INFO - "branch": "mozilla-inbound", 19:00:00 INFO - "repo_path": "integration/mozilla-inbound", 19:00:00 INFO - "revision": "806c404edf0659469c38c8e4a21b28e0c430b3ba", 19:00:00 INFO - "stage_platform": "linux64-pgo", 19:00:00 INFO - "builduid": "10c7fcc6d5fa418c91b3a630bfc05914", 19:00:00 INFO - "slavebuilddir": "test" 19:00:00 INFO - } 19:00:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 19:00:00 INFO - Running post-action listener: _resource_record_post_action 19:00:00 INFO - ##### 19:00:00 INFO - ##### Running download-and-extract step. 19:00:00 INFO - ##### 19:00:00 INFO - Running pre-action listener: _resource_record_pre_action 19:00:00 INFO - Running main action method: download_and_extract 19:00:00 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:00 INFO - https://queue.taskcluster.net/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:00:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 19:00:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 19:00:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 19:00:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:00:01 INFO - Downloaded 1448 bytes. 19:00:01 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 19:00:01 INFO - Using the following test package requirements: 19:00:01 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:01 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:01 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:00:01 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:01 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:00:01 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:01 INFO - u'jsshell-linux-x86_64.zip'], 19:00:01 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:01 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:00:01 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:01 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:01 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:00:01 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:01 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:00:01 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:01 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:00:01 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:01 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:01 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:00:01 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:01 INFO - https://queue.taskcluster.net/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:00:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:00:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:00:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:00:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:00:03 INFO - Downloaded 23398135 bytes. 19:00:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:00:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:00:05 INFO - Return code: 0 19:00:05 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:00: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')]} 19:00:05 INFO - https://queue.taskcluster.net/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:00:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:00:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:00:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:00:10 INFO - Downloaded 23398135 bytes. 19:00:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:00:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:00:12 INFO - Return code: 0 19:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:12 INFO - https://queue.taskcluster.net/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:00:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:00:13 INFO - Downloaded 10845161 bytes. 19:00:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:00:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:00:13 INFO - Return code: 0 19:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:13 INFO - https://queue.taskcluster.net/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:00:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:00:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:00:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:00:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:00:15 INFO - Downloaded 56121614 bytes. 19:00:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:00:15 INFO - mkdir: /builds/slave/test-pgo/properties 19:00:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:00:15 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:00:15 INFO - Contents: 19:00:15 INFO - build_url:https://queue.taskcluster.net/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:00:15 INFO - Running post-action listener: _resource_record_post_action 19:00:15 INFO - Running post-action listener: set_extra_try_arguments 19:00:15 INFO - ##### 19:00:15 INFO - ##### Running populate-webroot step. 19:00:15 INFO - ##### 19:00:15 INFO - Running pre-action listener: _resource_record_pre_action 19:00:15 INFO - Running main action method: populate_webroot 19:00:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:00:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:00:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:00:15 INFO - '--tppagecycles', 19:00:15 INFO - '7'], 19:00:15 INFO - 'tests': ['tsvgm']}}, 19:00:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:00:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:00:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:00:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:00:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:00:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:00:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:15 INFO - 'talos_options': ['--e10s'], 19:00:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:15 INFO - 'tests': ['damp', 'tps']}, 19:00:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:15 INFO - 'talos_options': ['--e10s'], 19:00:15 INFO - 'tests': ['damp', 'tps']}, 19:00:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:00:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:00:15 INFO - 'other': {'tests': ['a11yr', 19:00:15 INFO - 'ts_paint', 19:00:15 INFO - 'tpaint', 19:00:15 INFO - 'sessionrestore', 19:00:15 INFO - 'sessionrestore_no_auto_restore', 19:00:15 INFO - 'tabpaint']}, 19:00:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:00:15 INFO - 'tests': ['a11yr', 19:00:15 INFO - 'ts_paint', 19:00:15 INFO - 'tpaint', 19:00:15 INFO - 'sessionrestore', 19:00:15 INFO - 'sessionrestore_no_auto_restore', 19:00:15 INFO - 'tabpaint']}, 19:00:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:00:15 INFO - 'tests': ['a11yr', 19:00:15 INFO - 'ts_paint', 19:00:15 INFO - 'tpaint', 19:00:15 INFO - 'sessionrestore', 19:00:15 INFO - 'sessionrestore_no_auto_restore', 19:00:15 INFO - 'tabpaint']}, 19:00:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:00:15 INFO - 'tests': ['a11yr', 19:00:15 INFO - 'ts_paint', 19:00:15 INFO - 'tpaint', 19:00:15 INFO - 'sessionrestore', 19:00:15 INFO - 'sessionrestore_no_auto_restore', 19:00:15 INFO - 'tabpaint']}, 19:00:15 INFO - 'other_l64': {'tests': ['a11yr', 19:00:15 INFO - 'ts_paint', 19:00:15 INFO - 'tpaint', 19:00:15 INFO - 'sessionrestore', 19:00:15 INFO - 'sessionrestore_no_auto_restore', 19:00:15 INFO - 'tabpaint']}, 19:00:15 INFO - 'other_nol64': {'tests': ['a11yr', 19:00:15 INFO - 'ts_paint', 19:00:15 INFO - 'tpaint', 19:00:15 INFO - 'sessionrestore', 19:00:15 INFO - 'sessionrestore_no_auto_restore', 19:00:15 INFO - 'tabpaint']}, 19:00:15 INFO - 'svgr': {'tests': ['tsvgx', 19:00:15 INFO - 'tsvgr_opacity', 19:00:15 INFO - 'tart', 19:00:15 INFO - 'tscrollx', 19:00:15 INFO - 'cart']}, 19:00:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:00:15 INFO - 'tests': ['tsvgx', 19:00:15 INFO - 'tsvgr_opacity', 19:00:15 INFO - 'tart', 19:00:15 INFO - 'tscrollx', 19:00:15 INFO - 'cart']}, 19:00:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:15 INFO - 'tests': ['tp5o']}, 19:00:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:15 INFO - 'talos_options': ['--e10s'], 19:00:15 INFO - 'tests': ['tp5o']}, 19:00:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:15 INFO - 'talos_options': ['--xperf_path', 19:00:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:15 INFO - 'tests': ['tp5n']}, 19:00:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:15 INFO - 'talos_options': ['--e10s', 19:00:15 INFO - '--xperf_path', 19:00:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:15 INFO - 'tests': ['tp5n']}}, 19:00:15 INFO - 'talos.zip': {'path': '', 19:00:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:00:15 INFO - Running post-action listener: _resource_record_post_action 19:00:15 INFO - ##### 19:00:15 INFO - ##### Running create-virtualenv step. 19:00:15 INFO - ##### 19:00:15 INFO - Running pre-action listener: _resource_record_pre_action 19:00:15 INFO - Running main action method: create_virtualenv 19:00:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:00:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 19:00:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:00:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:00:15 INFO - Using real prefix '/usr' 19:00:15 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:00:16 INFO - Installing distribute.............................................................................................................................................................................................done. 19:00:18 INFO - Installing pip.................done. 19:00:18 INFO - Return code: 0 19:00:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:18 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 0x7ffbc470cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c30920>, '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 0x1c31820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c31cb0>, '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': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:00:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:00:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:00:18 INFO - Using env: {'DISPLAY': ':0', 19:00:18 INFO - 'HOME': '/home/cltbld', 19:00:18 INFO - 'LANG': 'en_US.UTF-8', 19:00:18 INFO - 'LANGUAGE': 'en_US:en', 19:00:18 INFO - 'LOGNAME': 'cltbld', 19:00:18 INFO - 'MAIL': '/var/mail/cltbld', 19:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:18 INFO - 'MOZ_NO_REMOTE': '1', 19:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:18 INFO - 'NO_EM_RESTART': '1', 19:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:18 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:18 INFO - 'SHELL': '/bin/bash', 19:00:18 INFO - 'SHLVL': '1', 19:00:18 INFO - 'TERM': 'linux', 19:00:18 INFO - 'TMOUT': '86400', 19:00:18 INFO - 'USER': 'cltbld', 19:00:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 19:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:18 INFO - '_': '/tools/buildbot/bin/python'} 19:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:00:18 INFO - Cleaning up... 19:00:18 INFO - Return code: 0 19:00:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:18 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 0x7ffbc470cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c30920>, '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 0x1c31820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c31cb0>, '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': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:00:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:00:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:00:18 INFO - Using env: {'DISPLAY': ':0', 19:00:18 INFO - 'HOME': '/home/cltbld', 19:00:18 INFO - 'LANG': 'en_US.UTF-8', 19:00:18 INFO - 'LANGUAGE': 'en_US:en', 19:00:18 INFO - 'LOGNAME': 'cltbld', 19:00:18 INFO - 'MAIL': '/var/mail/cltbld', 19:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:18 INFO - 'MOZ_NO_REMOTE': '1', 19:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:18 INFO - 'NO_EM_RESTART': '1', 19:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:18 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:18 INFO - 'SHELL': '/bin/bash', 19:00:18 INFO - 'SHLVL': '1', 19:00:18 INFO - 'TERM': 'linux', 19:00:18 INFO - 'TMOUT': '86400', 19:00:18 INFO - 'USER': 'cltbld', 19:00:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 19:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:18 INFO - '_': '/tools/buildbot/bin/python'} 19:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:18 INFO - Downloading/unpacking psutil>=0.7.1 19:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:20 INFO - Installing collected packages: psutil 19:00:20 INFO - Running setup.py install for psutil 19:00:20 INFO - building 'psutil._psutil_linux' extension 19:00:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:00:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:00:21 INFO - building 'psutil._psutil_posix' extension 19:00:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:00:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:00:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:21 INFO - Successfully installed psutil 19:00:21 INFO - Cleaning up... 19:00:21 INFO - Return code: 0 19:00:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffbc470cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c30920>, '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 0x1c31820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c31cb0>, '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': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:00:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:00:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:00:21 INFO - Using env: {'DISPLAY': ':0', 19:00:21 INFO - 'HOME': '/home/cltbld', 19:00:21 INFO - 'LANG': 'en_US.UTF-8', 19:00:21 INFO - 'LANGUAGE': 'en_US:en', 19:00:21 INFO - 'LOGNAME': 'cltbld', 19:00:21 INFO - 'MAIL': '/var/mail/cltbld', 19:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:21 INFO - 'MOZ_NO_REMOTE': '1', 19:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:21 INFO - 'NO_EM_RESTART': '1', 19:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:21 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:21 INFO - 'SHELL': '/bin/bash', 19:00:21 INFO - 'SHLVL': '1', 19:00:21 INFO - 'TERM': 'linux', 19:00:21 INFO - 'TMOUT': '86400', 19:00:21 INFO - 'USER': 'cltbld', 19:00:21 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 19:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:21 INFO - '_': '/tools/buildbot/bin/python'} 19:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:00:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:00:23 INFO - Installing collected packages: mozsystemmonitor 19:00:23 INFO - Running setup.py install for mozsystemmonitor 19:00:23 INFO - Successfully installed mozsystemmonitor 19:00:23 INFO - Cleaning up... 19:00:23 INFO - Return code: 0 19:00:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:23 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 0x7ffbc470cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c30920>, '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 0x1c31820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c31cb0>, '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': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:00:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:00:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:00:23 INFO - Using env: {'DISPLAY': ':0', 19:00:23 INFO - 'HOME': '/home/cltbld', 19:00:23 INFO - 'LANG': 'en_US.UTF-8', 19:00:23 INFO - 'LANGUAGE': 'en_US:en', 19:00:23 INFO - 'LOGNAME': 'cltbld', 19:00:23 INFO - 'MAIL': '/var/mail/cltbld', 19:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:23 INFO - 'MOZ_NO_REMOTE': '1', 19:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:23 INFO - 'NO_EM_RESTART': '1', 19:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:23 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:23 INFO - 'SHELL': '/bin/bash', 19:00:23 INFO - 'SHLVL': '1', 19:00:23 INFO - 'TERM': 'linux', 19:00:23 INFO - 'TMOUT': '86400', 19:00:23 INFO - 'USER': 'cltbld', 19:00:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 19:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:23 INFO - '_': '/tools/buildbot/bin/python'} 19:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:23 INFO - Downloading/unpacking blobuploader==1.2.4 19:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:25 INFO - Downloading blobuploader-1.2.4.tar.gz 19:00:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:00:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:00:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:26 INFO - Downloading docopt-0.6.1.tar.gz 19:00:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:26 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:26 INFO - Running setup.py install for blobuploader 19:00:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:00:26 INFO - Running setup.py install for requests 19:00:26 INFO - Running setup.py install for docopt 19:00:26 INFO - Successfully installed blobuploader requests docopt 19:00:26 INFO - Cleaning up... 19:00:26 INFO - Return code: 0 19:00:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:26 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 0x7ffbc470cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c30920>, '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 0x1c31820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c31cb0>, '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': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:00:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:00:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:00:26 INFO - Using env: {'DISPLAY': ':0', 19:00:26 INFO - 'HOME': '/home/cltbld', 19:00:26 INFO - 'LANG': 'en_US.UTF-8', 19:00:26 INFO - 'LANGUAGE': 'en_US:en', 19:00:26 INFO - 'LOGNAME': 'cltbld', 19:00:26 INFO - 'MAIL': '/var/mail/cltbld', 19:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:26 INFO - 'MOZ_NO_REMOTE': '1', 19:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:26 INFO - 'NO_EM_RESTART': '1', 19:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:26 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:26 INFO - 'SHELL': '/bin/bash', 19:00:26 INFO - 'SHLVL': '1', 19:00:26 INFO - 'TERM': 'linux', 19:00:26 INFO - 'TMOUT': '86400', 19:00:26 INFO - 'USER': 'cltbld', 19:00:26 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 19:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:26 INFO - '_': '/tools/buildbot/bin/python'} 19:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:00:27 INFO - Running setup.py (path:/tmp/pip-Aczp8u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:00:27 INFO - Running setup.py (path:/tmp/pip-W0O6Tq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:00:27 INFO - Running setup.py (path:/tmp/pip-6PtpeW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:00:27 INFO - Running setup.py (path:/tmp/pip-scJfAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:00:27 INFO - Running setup.py (path:/tmp/pip-HgCWOc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:00:27 INFO - Running setup.py (path:/tmp/pip-22dtPZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:00:27 INFO - Running setup.py (path:/tmp/pip-7hRtac-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:00:27 INFO - Running setup.py (path:/tmp/pip-eBchT9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:00:27 INFO - Running setup.py (path:/tmp/pip-MP7mV8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:00:27 INFO - Running setup.py (path:/tmp/pip-RyJsMN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:00:27 INFO - Running setup.py (path:/tmp/pip-7CISyl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:00:27 INFO - Running setup.py (path:/tmp/pip-cfuAl8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:00:28 INFO - Running setup.py (path:/tmp/pip-eNI5oi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:00:28 INFO - Running setup.py (path:/tmp/pip-Bxjrrq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:00:28 INFO - Running setup.py (path:/tmp/pip-zL9ivw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:00:28 INFO - Running setup.py (path:/tmp/pip-RARI7R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:00:28 INFO - Running setup.py (path:/tmp/pip-hbPXd6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:00:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:28 INFO - Running setup.py install for manifestparser 19:00:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:00:28 INFO - Running setup.py install for mozcrash 19:00:28 INFO - Running setup.py install for mozdebug 19:00:28 INFO - Running setup.py install for mozdevice 19:00:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:00:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:00:28 INFO - Running setup.py install for mozfile 19:00:28 INFO - Running setup.py install for mozhttpd 19:00:28 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:00:28 INFO - Running setup.py install for mozinfo 19:00:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:00:29 INFO - Running setup.py install for mozInstall 19:00:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:00:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:00:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:00:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:00:29 INFO - Running setup.py install for mozleak 19:00:29 INFO - Running setup.py install for mozlog 19:00:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:00:29 INFO - Running setup.py install for moznetwork 19:00:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:00:29 INFO - Running setup.py install for mozprocess 19:00:29 INFO - Running setup.py install for mozprofile 19:00:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:00:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:00:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:00:29 INFO - Running setup.py install for mozrunner 19:00:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:00:29 INFO - Running setup.py install for mozscreenshot 19:00:29 INFO - Running setup.py install for moztest 19:00:30 INFO - Running setup.py install for mozversion 19:00:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:00:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:00:30 INFO - Cleaning up... 19:00:30 INFO - Return code: 0 19:00:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:30 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 0x7ffbc470cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c30920>, '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 0x1c31820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c31cb0>, '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': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:00:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:00:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:00:30 INFO - Using env: {'DISPLAY': ':0', 19:00:30 INFO - 'HOME': '/home/cltbld', 19:00:30 INFO - 'LANG': 'en_US.UTF-8', 19:00:30 INFO - 'LANGUAGE': 'en_US:en', 19:00:30 INFO - 'LOGNAME': 'cltbld', 19:00:30 INFO - 'MAIL': '/var/mail/cltbld', 19:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:30 INFO - 'MOZ_NO_REMOTE': '1', 19:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:30 INFO - 'NO_EM_RESTART': '1', 19:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:30 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:30 INFO - 'SHELL': '/bin/bash', 19:00:30 INFO - 'SHLVL': '1', 19:00:30 INFO - 'TERM': 'linux', 19:00:30 INFO - 'TMOUT': '86400', 19:00:30 INFO - 'USER': 'cltbld', 19:00:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 19:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:30 INFO - '_': '/tools/buildbot/bin/python'} 19:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:00:30 INFO - Running setup.py (path:/tmp/pip-LmGo8A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:00:30 INFO - Running setup.py (path:/tmp/pip-KwhEJh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:00:30 INFO - Running setup.py (path:/tmp/pip-rCjbyZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:00:30 INFO - Running setup.py (path:/tmp/pip-kzOOmq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:00:30 INFO - Running setup.py (path:/tmp/pip-YMOm56-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:00:30 INFO - Running setup.py (path:/tmp/pip-gq0MfE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:00:30 INFO - Running setup.py (path:/tmp/pip-3YbrRi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:00:30 INFO - Running setup.py (path:/tmp/pip-8W2TDR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:00:30 INFO - Running setup.py (path:/tmp/pip-zRyDih-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:00:31 INFO - Running setup.py (path:/tmp/pip-SyiYBo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:00:31 INFO - Running setup.py (path:/tmp/pip-F0WdzL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 19:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:00:31 INFO - Running setup.py (path:/tmp/pip-6mombu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:00:31 INFO - Running setup.py (path:/tmp/pip-K5UZ_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:00:31 INFO - Running setup.py (path:/tmp/pip-mQhNjn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 19:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:00:31 INFO - Running setup.py (path:/tmp/pip-lyyYAL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 19:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:00:31 INFO - Running setup.py (path:/tmp/pip-caR8ss-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 19:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:00:31 INFO - Running setup.py (path:/tmp/pip-RigCCv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:00:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:33 INFO - Downloading blessings-1.6.tar.gz 19:00:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:33 INFO - Installing collected packages: blessings 19:00:33 INFO - Running setup.py install for blessings 19:00:33 INFO - Successfully installed blessings 19:00:33 INFO - Cleaning up... 19:00:33 INFO - Return code: 0 19:00:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:00:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:00:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:00:33 INFO - Reading from file tmpfile_stdout 19:00:33 INFO - Current package versions: 19:00:33 INFO - argparse == 1.2.1 19:00:33 INFO - blessings == 1.6 19:00:33 INFO - blobuploader == 1.2.4 19:00:33 INFO - docopt == 0.6.1 19:00:33 INFO - manifestparser == 1.1 19:00:33 INFO - mozInstall == 1.12 19:00:33 INFO - mozcrash == 0.17 19:00:33 INFO - mozdebug == 0.1 19:00:33 INFO - mozdevice == 0.48 19:00:33 INFO - mozfile == 1.2 19:00:33 INFO - mozhttpd == 0.7 19:00:33 INFO - mozinfo == 0.9 19:00:33 INFO - mozleak == 0.1 19:00:33 INFO - mozlog == 3.1 19:00:33 INFO - moznetwork == 0.27 19:00:33 INFO - mozprocess == 0.22 19:00:33 INFO - mozprofile == 0.28 19:00:33 INFO - mozrunner == 6.11 19:00:33 INFO - mozscreenshot == 0.1 19:00:33 INFO - mozsystemmonitor == 0.0 19:00:33 INFO - moztest == 0.7 19:00:33 INFO - mozversion == 1.4 19:00:33 INFO - psutil == 3.1.1 19:00:33 INFO - requests == 1.2.3 19:00:33 INFO - wsgiref == 0.1.2 19:00:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:33 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 0x7ffbc470cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c30920>, '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 0x1c31820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c31cb0>, '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': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:00:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 19:00:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:00:33 INFO - Using env: {'DISPLAY': ':0', 19:00:33 INFO - 'HOME': '/home/cltbld', 19:00:33 INFO - 'LANG': 'en_US.UTF-8', 19:00:33 INFO - 'LANGUAGE': 'en_US:en', 19:00:33 INFO - 'LOGNAME': 'cltbld', 19:00:33 INFO - 'MAIL': '/var/mail/cltbld', 19:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:33 INFO - 'MOZ_NO_REMOTE': '1', 19:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:33 INFO - 'NO_EM_RESTART': '1', 19:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:33 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:33 INFO - 'SHELL': '/bin/bash', 19:00:33 INFO - 'SHLVL': '1', 19:00:33 INFO - 'TERM': 'linux', 19:00:33 INFO - 'TMOUT': '86400', 19:00:33 INFO - 'USER': 'cltbld', 19:00:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 19:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:33 INFO - '_': '/tools/buildbot/bin/python'} 19:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:00:34 INFO - Cleaning up... 19:00:34 INFO - Return code: 0 19:00:34 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc470cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c30920>, '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 0x1c31820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c31cb0>, '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': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:00:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:00:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:00:34 INFO - Using env: {'DISPLAY': ':0', 19:00:34 INFO - 'HOME': '/home/cltbld', 19:00:34 INFO - 'LANG': 'en_US.UTF-8', 19:00:34 INFO - 'LANGUAGE': 'en_US:en', 19:00:34 INFO - 'LOGNAME': 'cltbld', 19:00:34 INFO - 'MAIL': '/var/mail/cltbld', 19:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:34 INFO - 'MOZ_NO_REMOTE': '1', 19:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:34 INFO - 'NO_EM_RESTART': '1', 19:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:34 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:34 INFO - 'SHELL': '/bin/bash', 19:00:34 INFO - 'SHLVL': '1', 19:00:34 INFO - 'TERM': 'linux', 19:00:34 INFO - 'TMOUT': '86400', 19:00:34 INFO - 'USER': 'cltbld', 19:00:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 19:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:34 INFO - '_': '/tools/buildbot/bin/python'} 19:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:34 INFO - Downloading/unpacking jsonschema 19:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:00:36 INFO - Downloading/unpacking functools32 (from jsonschema) 19:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:36 INFO - Downloading functools32-3.2.3-2.tar.gz 19:00:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:00:36 INFO - warning: no files found matching '*.txt' 19:00:36 INFO - no previously-included directories found matching 'build' 19:00:36 INFO - no previously-included directories found matching 'dist' 19:00:36 INFO - no previously-included directories found matching '.git*' 19:00:36 INFO - Installing collected packages: jsonschema, functools32 19:00:36 INFO - Running setup.py install for functools32 19:00:36 INFO - warning: no files found matching '*.txt' 19:00:36 INFO - no previously-included directories found matching 'build' 19:00:36 INFO - no previously-included directories found matching 'dist' 19:00:36 INFO - no previously-included directories found matching '.git*' 19:00:36 INFO - Successfully installed jsonschema functools32 19:00:36 INFO - Cleaning up... 19:00:36 INFO - Return code: 0 19:00:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:36 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 0x7ffbc470cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba16d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c30920>, '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 0x1c31820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c31cb0>, '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': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:00:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:00:36 INFO - Using env: {'DISPLAY': ':0', 19:00:36 INFO - 'HOME': '/home/cltbld', 19:00:36 INFO - 'LANG': 'en_US.UTF-8', 19:00:36 INFO - 'LANGUAGE': 'en_US:en', 19:00:36 INFO - 'LOGNAME': 'cltbld', 19:00:36 INFO - 'MAIL': '/var/mail/cltbld', 19:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:36 INFO - 'MOZ_NO_REMOTE': '1', 19:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:36 INFO - 'NO_EM_RESTART': '1', 19:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:36 INFO - 'SHELL': '/bin/bash', 19:00:36 INFO - 'SHLVL': '1', 19:00:36 INFO - 'TERM': 'linux', 19:00:36 INFO - 'TMOUT': '86400', 19:00:36 INFO - 'USER': 'cltbld', 19:00:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 19:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:36 INFO - '_': '/tools/buildbot/bin/python'} 19:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:37 INFO - Downloading/unpacking flake8 19:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:00:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:00:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:00:39 INFO - no previously-included directories found matching 'docs/_build' 19:00:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:00:39 INFO - Running setup.py install for pep8 19:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:00:39 INFO - no previously-included directories found matching 'docs/_build' 19:00:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:00:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:00:39 INFO - Cleaning up... 19:00:39 INFO - Return code: 0 19:00:39 INFO - Running post-action listener: _resource_record_post_action 19:00:39 INFO - Running post-action listener: _start_resource_monitoring 19:00:39 INFO - Starting resource monitoring. 19:00:39 INFO - ##### 19:00:39 INFO - ##### Running install step. 19:00:39 INFO - ##### 19:00:39 INFO - Running pre-action listener: _resource_record_pre_action 19:00:39 INFO - Running main action method: install 19:00:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:00:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:00:40 INFO - Reading from file tmpfile_stdout 19:00:40 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:00:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:00:40 INFO - Reading from file tmpfile_stdout 19:00:40 INFO - Output received: 19:00:40 INFO - Usage: mozinstall [options] installer 19:00:40 INFO - Options: 19:00:40 INFO - -h, --help show this help message and exit 19:00:40 INFO - -d DEST, --destination=DEST 19:00:40 INFO - Directory to install application into. [default: 19:00:40 INFO - "/builds/slave/test-pgo"] 19:00:40 INFO - --app=APP Application being installed. [default: firefox] 19:00:40 INFO - mkdir: /builds/slave/test-pgo/build/application 19:00:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:00:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:00:56 INFO - Reading from file tmpfile_stdout 19:00:56 INFO - Output received: 19:00:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:00:56 INFO - Running post-action listener: _resource_record_post_action 19:00:56 INFO - ##### 19:00:56 INFO - ##### Running run-tests step. 19:00:56 INFO - ##### 19:00:56 INFO - Running pre-action listener: _resource_record_pre_action 19:00:56 INFO - Running main action method: run_tests 19:00:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:00:56 INFO - Python 2.7.3 19:00:56 INFO - Return code: 0 19:00:56 INFO - grabbing minidump binary from tooltool 19:00: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')]} 19:00:56 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 0x1c30920>, '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 0x1c31820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c31cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:00:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:00:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:00:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:00:56 INFO - Return code: 0 19:00:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:00:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:00:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:00:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:00:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:00:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:00:57 INFO - Return code: 0 19:00:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 19:00:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 19:00:57 INFO - Using env: {'DISPLAY': ':0', 19:00:57 INFO - 'HOME': '/home/cltbld', 19:00:57 INFO - 'LANG': 'en_US.UTF-8', 19:00:57 INFO - 'LANGUAGE': 'en_US:en', 19:00:57 INFO - 'LOGNAME': 'cltbld', 19:00:57 INFO - 'MAIL': '/var/mail/cltbld', 19:00:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:00:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:57 INFO - 'MOZ_NO_REMOTE': '1', 19:00:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:57 INFO - 'NO_EM_RESTART': '1', 19:00:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:00:57 INFO - 'SHELL': '/bin/bash', 19:00:57 INFO - 'SHLVL': '1', 19:00:57 INFO - 'TERM': 'linux', 19:00:57 INFO - 'TMOUT': '86400', 19:00:57 INFO - 'USER': 'cltbld', 19:00:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726', 19:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:57 INFO - '_': '/tools/buildbot/bin/python'} 19:00:57 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 19:00:57 INFO - mozversion application_buildid: 20160304163145 19:00:57 INFO - mozversion application_changeset: 806c404edf0659469c38c8e4a21b28e0c430b3ba 19:00:57 INFO - mozversion application_display_name: Nightly 19:00:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:00:57 INFO - mozversion application_name: Firefox 19:00:57 INFO - mozversion application_remotingname: firefox 19:00:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:00:57 INFO - mozversion application_vendor: Mozilla 19:00:57 INFO - mozversion application_version: 47.0a1 19:00:57 INFO - mozversion platform_buildid: 20160304163145 19:00:57 INFO - mozversion platform_changeset: 806c404edf0659469c38c8e4a21b28e0c430b3ba 19:00:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:00:57 INFO - mozversion platform_version: 47.0a1 19:00:57 INFO - using testdate: 1457146857 19:00:57 INFO - actual date: 1457146857 19:00:57 INFO - starting webserver on 'localhost:47625' 19:00:57 INFO - SUITE-START | Running 2 tests 19:00:57 INFO - TEST-START | dromaeo_css 19:00:57 INFO - operating with platform_type : linux_ 19:00:57 INFO - Initialising browser for dromaeo_css test... 19:00:57 INFO - TEST-INFO | started process 20991 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE1z7In/profile http://localhost:47625/getInfo.html) 19:01:01 INFO - PROCESS | 20991 | 19:01:01 INFO - PROCESS | 20991 | (process:21074): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:01:02 INFO - PROCESS | 20991 | __metrics Screen width/height:1600/1200 19:01:02 INFO - PROCESS | 20991 | colorDepth:24 19:01:02 INFO - PROCESS | 20991 | Browser inner width/height: 1024/697 19:01:02 INFO - PROCESS | 20991 | __metrics 19:01:03 ERROR - PROCESS | 20991 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:01:04 INFO - TEST-INFO | 20991: exit 0 19:01:04 INFO - Browser initialized. 19:01:04 INFO - Running cycle 1/1 for dromaeo_css test... 19:01:04 INFO - TEST-INFO | started process 21125 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE1z7In/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:06 INFO - PROCESS | 21125 | 19:01:06 INFO - PROCESS | 21125 | (process:21186): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:01:16 INFO - PROCESS | 21125 | RSS: Main: 164691968 19:01:16 INFO - PROCESS | 21125 | 19:02:05 INFO - PROCESS | 21125 | 1457146925856 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:04:14 INFO - PROCESS | 21125 | Cycle 1(1): loaded http://localhost:47625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47625/tests/dromaeo/cssquery-ext.html) 19:04:15 INFO - PROCESS | 21125 | RSS: Main: 172122112 19:04:15 INFO - PROCESS | 21125 | 19:07:17 INFO - PROCESS | 21125 | Cycle 1(1): loaded http://localhost:47625/tests/dromaeo/cssquery-ext.html (next: http://localhost:47625/tests/dromaeo/cssquery-jquery.html) 19:07:18 INFO - PROCESS | 21125 | RSS: Main: 170033152 19:07:18 INFO - PROCESS | 21125 | 19:10:19 INFO - PROCESS | 21125 | Cycle 1(1): loaded http://localhost:47625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47625/tests/dromaeo/cssquery-mootools.html) 19:10:20 INFO - PROCESS | 21125 | RSS: Main: 169119744 19:10:20 INFO - PROCESS | 21125 | 19:13:22 INFO - PROCESS | 21125 | Cycle 1(1): loaded http://localhost:47625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47625/tests/dromaeo/cssquery-prototype.html) 19:13:22 INFO - PROCESS | 21125 | RSS: Main: 166678528 19:13:22 INFO - PROCESS | 21125 | 19:16:25 INFO - PROCESS | 21125 | Cycle 1(1): loaded http://localhost:47625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47625/tests/dromaeo/cssquery-yui.html) 19:16:25 INFO - PROCESS | 21125 | RSS: Main: 166797312 19:16:25 INFO - PROCESS | 21125 | 19:19:28 INFO - PROCESS | 21125 | Cycle 1(1): loaded http://localhost:47625/tests/dromaeo/cssquery-yui.html (next: http://localhost:47625/tests/dromaeo/cssquery-dojo.html) 19:19:28 INFO - PROCESS | 21125 | RSS: Main: 171196416 19:19:28 INFO - PROCESS | 21125 | 19:19:28 INFO - PROCESS | 21125 | __start_tp_report 19:19:28 INFO - PROCESS | 21125 | _x_x_mozilla_page_load 19:19:28 INFO - PROCESS | 21125 | _x_x_mozilla_page_load_details 19:19:28 INFO - PROCESS | 21125 | |i|pagename|runs| 19:19:28 INFO - PROCESS | 21125 | |0;dojo.html;3113.424016556937;3147.0873446700457;3155.9368812623743;3171.730402915752;3191.3138675184846;4999.550040496355;5036.2445633155;5036.571891389227;5042.672226305288;5054.418741844689;5024.899502009957;5089.491050894909;5185.611079169068;5204.115300398932;5211.609129315298;4679.1343601433755;4718.90562188756;4763.919655524309;4783.043391321732;4888.462269150391;4675.812967481296;4679.789409476582;4714.528547145275;4730.645201609876;4735.810567577293;4669.789859456333;4731.124741922738;4740.952590474086;4772.117158325721;4787.976060119712;4717.315989181584;4725.31482934976;4739.170645137087;4758.143534163849;4758.881027974294;4602.240630295997;4673.696209746356;4728.38530990969;4734.171519984024;4734.668573199878;5015.523525265094;5016.247562865563;5031.345925029759;5068.82259120929;5087.720175390352;5528.281323427969;5529.944700552983;5532.114861622121;5532.474414930575;5582.525485333752;5425.321834770653;5574.10814269719;5584.776608935678;5585.134304182858;5627.8593035174035;5286.867828304285;5301.860100078463;5304.655197412233;5313.920291195635;5325.573954083664;5713.400092990176;5714.599978001583;5732.369439361667;5738.368779434259;5769.913451298234;5305.522502974673;5447.373552041487;5513.889722205534;5514.834554963358;5575.776968921279;5431.619786614899;5453.127499600045;5578.414266501959;5587.608867379326;5596.524295434933;5535.474129957647;5578.107502799533;5579.581531385163;5586.245856809279;5626.1842032905;5408.432114627986;5445.727713614304;5470.9179362308805;5482.780688772405;5576.525995290364;4229.3444516099435;4236.322188449833;4237.173751118502;4274.615284624337;4292.377605247284;3814.4659747635355;3826.1391186983265;3830.138218900725;3860.0542866997203;3882.6699730522655;5108.66793658411;5151.948480515147;5226.137687281632;5258.158694608845;5289.418164001957;5520.420355862657;5567.582431317586;5596.776128954878;5617.101263797773;5618.101103823368;5291.867703307371;5300.814471493479;5307.761150748225;5307.893842123136;5327.467253274642;4614.538546145426;4687.484376718558;4738.076075165379;4783.641226907996;4792.113459010095;5753.338366087954;5797.623154495029;5828.504577110908;5828.5337173026055;5831.446012628793;5532.557395408277;5534.612577119563;5556.9719601873785;5567.109262517978;5567.582431317586;5547.389787123332;5772.94227057724;5796.565257605612;5845.795397161079;5858.7070646468355;5436.374816896107;5467.289252397163;5471.72641367922;5474.124140137718;5493.835184944458;5288.550473209666;5431.8098866539485;5453.454654534674;5484.396716361117;5557.166425036277;5307.52232299095;5378.489043540857;5388.811391601275;5422.430644782241;5432.049391356576;5406.162044883049;5406.7296635167295;5443.918341224964;5461.481159289861;5469.75386107634;5206.765695543634;5346.866328341823;5348.438413966477;5359.356877174764;5419.160030195326;5438.048341540294;5440.347158341025;5495.505404513613;5503.697296648723;5518.530924871431;5249.501297376743;5273.973630131978;5299.6290259681455;5309.761060752198;5315.364041899732 19:19:28 INFO - PROCESS | 21125 | |1;ext.html;514.2106865960751;527.4066674990636;539.1319974840507;559.0300828063309;569.2485918587464;36347;36678.083047923814;36707.08232294194;36709.26581468369;36976;40014;40468;40557.59442405575;40582.79708601453;40633.796831015876;8341.249287564118;8531.146885311451;8539.274161696263;8552.828943421158;8564.314854811631;8321.750347489586;8443.15568443157;8522.531260780655;8655.783605409884;8722.21500064994;8697.652093916236;8718;8721.433106848066;8731.95634021829;8740.562971851383;8568.443051201682;8632.438891472035;8636.093210212963;8710.303175745925;8715.825683486295;8551.615177316973;8752.518611476366;8804.735857924272;8812.559372031374;8831.60257788401;39368.80315598432;39684.60315396838;39788.60211397878;39794;39837.20325593501;2747.5603903375363;3161.4151381994407;3215.7105860472434;3268.1176082457605;3599.4960705501253;26829.597556036675;27188;27219.863900680568;27479.17562473129;27914.581281280593;3461.7576769626135;3600.5859326177565;3627.4740162676526;3656.2504686539196;3740.9625903740884;179134;179823;181429;182401.0879945605;182430;41236.79381603073;41725.37411938823;41803;55850.44149558452;56498.58753531195;40011;40021.199576008315;40094;40243.798781005906;40513.1897362057;12808.551700690432;12860.164089334163;12899.290539020256;12906.161099528501;12912.935435322763;10522.789544209227;10639.202059845542;10640.946795265974;10641.627543036111;10670.66616672916;14197.78703319451;14359.712805744035;14376.496822611367;14387.352569134415;14395.496157634432;5688.260526131577;5718.485336319751;5792.275965504312;5820.30156381237;5883.970580147072;940.7036783413203;1043.838205078214;1043.994780026095;1068.2255364860414;1096.2326371539793;28294.717052829208;29042.41915161685;29092.563611545844;29212.707872921423;29242.122736317946;1043.2592859069994;1050.4065203160342;1100.1418893263267;1138.1463902073444;1151.2459339132881;14963.401463941538;15000.924995375171;15273.159976201194;15384.230788460532;15563.377464901503;324059;326124;327840;328623;330087;52186;52242.47757522376;52543;52618;52625;1244.9315287659265;1277.9903875938091;1310.7313000834806;1344.4823742858873;1357.3077730357588;27621;28943.855280723463;29014.27464313409;29030.7096929028;29301.41397172087;46707;46782.76608617071;46794;46805.531944680115;47019.294710580056;254165;257440;257645;258604;259301;31874;32455.188620284684;32592.185195370304;32664.51003234906;32700.50949235811;43207.135857283305;44095.33856992212;44097;44140.7792961046;44770.328445074;35183.82408087943;35286;35362.46956295709;35646.64353356433;35922.8203858979;37089.44365834461;37313.44029839609;37515.06212344604;37576;38321.23357532889;34032.65967340295;37394.43908341431;37960.240795184494;38247.61752382552;38868.80565597154;30146.54780178343;31331.68668313379;31385.686143139188;31387.215319617193;31392.529112063796;25335.239942801745;25497.745022549538;25501.872490637426;25531.617025744257;25792.484150317265 19:19:28 INFO - PROCESS | 21125 | |2;jquery.html;345.59047528678514;356.45996315581897;357.26225344663277;369.1804194687796;369.549150036955;16453.506394808144;16598.585035374123;17730.556736081606;17770.911145444286;17843;16503.422380216696;16857.325706971707;16949.745753813702;17010.574735631617;17065.82934170658;5238.292830467895;5271.182966640177;5499.202615620733;5533.750981205855;5543.861403464905;5449.455054494559;5457.263269458632;5485.286912701344;5492.231087647732;5503.449655034485;5465.371482279529;5471.5896307776875;5556.666600003992;5739.311282646088;5797.594168408213;5031.572316353115;5720.3135623725;5734.598578099534;5755.971220143893;5789.8263052108505;5006.774695138727;5027.371578552681;5062.848114556569;5073.492650734934;5082.745862706887;11862.576490821071;11947.103967202494;11964.1625086244;12537.498500059986;19002.809971900242;1981.2372236688834;2041.5916816636732;2187.9671804922777;2743.8490883001427;2851;8830.621608263486;9144.222741067017;9270.907290927073;9334.71995840126;9512.1439070484;1785.5625371783867;1818.1182126668687;1836.917338719761;1892.3376818113688;1893.2237782509105;58864;62206.37793622051;63010;63051.68474157646;63630.36369636337;9883.50582470888;10086.344387614781;10334.844977325347;10363.63727269557;10404.635837745642;13580.45678172862;13631.795523067161;13642;13676.111052781538;13722.862771372158;7049.400800931876;7097.822554436078;7163.391111755455;7196.352328290374;7206.099237595301;6751.25736169021;6791.898121528181;6880;6925.168979722465;6931.514793964374;4462.821487140543;4482.484514280834;4484.663650226246;4491.708038977456;4569.588737013684;1875.5967466994662;1924.2969971575258;1926.9325573604856;1930.5849242412949;1964.79369666183;880.9779755506164;891.3537685178194;902.9142231487998;951.3530799056708;970.5535453691381;14905.925470372578;16715.97853814766;16732;16938.15309234558;17048.57378565521;911.9954400227956;926.0693003531408;927.9814403712023;933.8552524358599;951.9190868776093;9420.19928306088;9584.952075239578;9597.280203984728;9622.182114520205;9739.74038619173;432485;437347;438757;444112;448264;63929;68127.65936170386;76887;77119.61440192876;78986.21013789788;1019.7246743379246;1035.3942943378058;1063.2716589136312;1066.3495267886583;1067.0609863320383;15678.764818527503;15755.606109847346;15854.023332336317;15874.10127196956;16100.758488622914;33973.83013084919;34634.13414664553;34712;35042.824785875906;35061.649383505835;45047.32429013633;47575.28637070516;48842;48911.5108848907;49358.506414936826;7732.265434783687;7744.883826742491;7921.485103468256;7974;8007.55958422269;7154.785356439315;9137.680181193626;9161.221296189899;10928.672139835817;11541.307521548733;10708;10926.836097458385;10993.175511836484;11215.439228038402;11240.55037798479;9961.352512086982;10939.07017903487;11041.668749937515;11296.096312294832;11306.321620702784;5874.089516125007;8101.311388531805;9794.314397992071;10850.131989440668;11229.49467273991;7836.216378362118;7891;7899.881501777593;8108.878366824384;8132.87800683002;10045.547950342398;10947.890521094687;11139.94430027877;11286.548538058385;11321.094312455149 19:19:28 INFO - PROCESS | 21125 | |3;mootools.html;1469.3828591991362;1501.4969985055009;1652.8760342974272;1762.6650936322105;1805.0072460146923;6241.687915604224;7132.786016419503;7436;7565.962170189148;7618.276263754941;7208.783736487901;7214;7230.60231687257;7251.238619944896;7332.8900066499045;2218.744844342897;2226.521297920947;2242.7532971373134;2244.461329280969;2251.6960210371635;2190.123950419837;2224.1103558576538;2245.38251980705;2250.673652320421;2252.707148070757;2199.736031676201;2205.900734466945;2208.205046183373;2216.3794137641485;2286.0284379138884;2188.081005977477;2213.922512712047;2218.6450167973126;2225.043231410493;2230.631945728953;2168.0785666091847;2171.9022643981057;2180.585688719154;2182.1053368118996;2190.9890450547805;7493.925060749377;7502.324790768803;7540.396768258526;7547.28300811422;7551.584662843541;4463.174312752151;4527.185106680796;4552.135094332067;4552.590266875997;4588.7935042923145;2763.1848604661673;2835.3620435402077;2842.346260360108;2853.857307134656;2859.513882639956;957.9185769209626;962.6101428921298;968.9224862011022;975.4537459022899;1010.7473131717071;10220.131288840457;10254;10263.846042309371;10274.48627568626;10288.639897603623;4163.3130533461635;4165.396017577435;4198.748075115503;4291.399204111427;4295.205387003414;8790.428622139669;8816.250618697482;8822.647094116164;8822.911770882209;8834.337424693174;4464.799084041226;4488.775561221991;4496.145732310851;4507.57178068083;4509.436320459942;4024.2555127301544;4061.4923134608175;4066.2070896175555;4139.048018955657;4155.355919832431;3448.5516882805578;3455.930881382358;3460.7923524588605;3466.5146879436898;3502.2120022994623;1037.2065369991963;1040.4381633917599;1050.81610718124;1055.8680164979378;1104.0725790336155;980.1129977370491;993.4833886379042;997.586001809241;1096.9048422641017;1296.1898813241723;6921.550099243533;6955;6971.965140174267;6990.860182796316;7001.334873187039;476.1334371444008;486.88558188825596;492.45829587454233;494.48820470813257;497;5460.535854452337;5480.3971563128025;5510.035743744908;5519.061759500894;5530.115181570929;8889.4666320021;9017.549122543847;9082.636694532144;9136.177744003071;9199.03410141939;8823.735287941372;8891.510966896753;8966.506842123616;8980.55097245135;8994.415363001384;7146.178189508169;7188.964055179796;7211.71153153868;7223.386012188917;7270.382017528569;6677.29888361715;6750.6624668767345;6791.72833086671;6827;6827.761028363983;7803.492772969966;7891.210878912063;7945.761627151194;7961.72133975308;7979.680812767424;7881.093674227537;8098.230668086522;8143.75568732939;8208.876866847122;8229.094799572162;7065;7143.428525717826;7188.5327453715345;7199.316064973819;7225.927740722525;7166.211716711054;7257.237990010973;7270.418366530559;7277;7300.853982920418;6202.100695399232;6368.904466432915;6373.776917807854;6443.645599491885;6520.706568204348;6331.303556608677;6394.968025159845;6421.101045853491;6493.577917435352;6641.070250165078;6784.05023296729;6832.316768323128;6890.517663763489;6900.585964842126;6906.274841141809;6181.443670069715;6242.375762423721;6350.079238510482;6383.872322553616;6385.584936979081;6303.432691057827;6325.810225693236;6368.617882926854;6413.71138298787;6432.324605916311 19:19:28 INFO - PROCESS | 21125 | |4;prototype.html;342.525602041173;345.7372396978296;348.59737003760665;350.18581797321235;354.5851353915918;6204.100405441209;6232.2832874219475;6265.467435267997;6271.122042913996;6281.246250449946;6150.569460137792;6154.476869466101;6159.23009623797;6162.291336496304;6178.104174894637;4590.196715574778;4664.113818374515;4690.530946905316;4694.90610187796;4798.952010479894;4668.533146685321;4671.789769460365;4678.345031695565;4691.765411729417;4708.317293992386;4619.099275641252;4627.375304333922;4665.673402861801;4666.580007799297;4683.953160468386;4635.6523260755575;4658.324542941272;4671.135839869635;4685.62514998801;4707.082118986799;4027.194561087794;4057.9188416231805;4063.309237429644;4063.654589359878;4070.104576993057;5772.9711351442975;5831.183634291203;5883.588148829584;5899.233099697055;5904.793332233351;5156.123459011939;5362.544183744387;5415.862668839549;5433.782648694087;5451.672899625995;6492.513061520358;6524.543281970264;6528.37980391862;6531.608103513757;6548.345165483413;4460.464744230713;4461.687681862271;4462.352958820953;4476.8880777980485;4485.529019452943;6767.3571010754395;6826.863462730767;6839.316068393121;6843.863122737567;6846.760363387258;4637.466691330473;4637.6289896808175;4643.257078867365;4643.349931009661;4651.5813576778255;4496.955030449719;4639.721616703008;4649.67452278344;4656.115338085753;4685.062987402465;5373.570114390839;5408.702521361363;5435.728213589305;5453.454654534515;5485.9725701371235;6528.738850446024;6579;6598.10925525048;6629.171353580802;6634.734610615618;1634.1502418742425;1662.3599914032943;1663.6340005198838;1664.25108701085;1664.9583760406088;1061.368485750977;1079.6976846482996;1081.5565618096543;1096.7093720164162;1106.31961343773;6241.75032998684;6271.96864015677;6287.434130928238;6302.149209856702;6312.936870631235;6695.665216739144;6702.597844129368;6706.698198581075;6736.157980252468;6743.5953842769595;6193.81418557444;6272.2473303203;6372.7132279047555;6378.362163783585;6383.776567820104;3676.632336766302;3682.6869716074434;3686.0416291764336;3697.574778900407;3704.148045949447;7222.927770722225;7250.383717384081;7253.347198752138;7269.127704675473;7269.6728647211;6984.3364880336285;6985.79042628722;6987.371136597731;6989.231184569693;7007.684654190573;7031.8593628127155;7210.1708303545765;7210.351068403869;7236.131664200225;7263.709451621876;6757;6771.356721111487;6771.796846094625;6826.351496607815;6835.282295358916;6733.259341472336;6770.4922130839395;6774.187097548326;6780.457563395015;6788.422984046411;7152.962820391118;7212.4230061596;7212.908256605736;7224.783256502314;7233.421326293778;4430.977845110754;4478.820847166076;4545.568171023748;4547;4563.954360456353;6663.666816659051;6812.114425124702;6837.589744615339;6843.931560684528;6845.794626161223;6534.8366290843105;6575.408213260829;6586.341365863375;6609.603423794588;6620.437262832713;6511.967440162769;6527.314631963765;6534.575252608755;6608.339166083353;6612.338766123542;6386.361363863576;6448.2262128543;6459.128017717548;6488.188976377953;6531.150950376421;6569.507286953593;6620.66896655175;6622.10601568782;6636.668166591555;6655.23464801554;6466.61200327963;6489.707963141575;6502.057201705632;6502.544821862424;6514.6416947068365 19:19:28 INFO - PROCESS | 21125 | |5;yui.html;706.3995603736824;724.0623392706447;776.8951191589135;787.5943888897219;800.0039950261925;13768.518101866437;13772.104813187148;13906.791398129011;13931.303434828256;13943.930280348597;12668.936655316711;12739.681507962305;12793;12841.29372884491;12889.2266464012;671.3018460800762;814.1858141858127;820.1429506166071;822.3914303415489;840.920112589303;824.7360844529753;826.6817275348974;830.3149901331426;830.7092517618815;830.9459885107449;869.8999615044256;874.1040433555625;875.1423604867234;878.4202426398579;880.9603567839463;858.6651206029653;860.8837806896051;861.8922634670666;866.9133086691344;869.9173578510031;636.1983900285627;638.1767519899324;639.1563136659611;639.6098379988204;639.8560323927126;12735.872641273561;12759.553415630502;12779.424925878266;12831.230126192459;12865.871341286562;12194.39028048594;12263.467066616673;12303.876961230362;12482.838842376908;12492.81260781089;9953.800923981553;9958.103770660602;10120.139788118018;10140.797184056351;10154.9492252539;3384.8646054157803;3453.913652158691;3463.6363181866045;3564.091156755011;3580.5524309461316;47454;47942.28086578669;48781.75609121967;48819.267710984364;48956.26565601519;10318.122959548522;10325.225608079425;10370.319021989466;10480.47597620116;10735.35587864715;17763.378281760335;17779.111044447727;17808.732869006973;17821.841580297238;17897.105144742713;7769.805754856174;7813.687452501837;7958.3235424989525;8071.798205044921;8122.9187708123345;4244.596763307481;4273.423087883159;4282.407407407385;4302.182585308781;4484.573965473275;2941.3087924337765;2991.670916199216;2994.191568276553;3000.0999700090324;3007.473692103873;516.4164494121694;520.9869753256199;527.5542166868989;532.4462558938737;533.3253434405481;562.3841893127019;615.7506209984963;618.7415931848788;662.8110988368388;665.710415969055;7888.7633370998965;8225.95887020573;8257.42198046143;8362.832743345221;8464.830703385898;422.15990179543104;633.3002032753741;638.8434833465831;650.7884937395365;731.4550659758407;3788.677962373229;3897.785621790829;3978.6574016627374;3987.601239875989;4025.8389664413094;54493.182602261;56884.715576421855;57061.71469142628;57512.71243643755;57567.712161438925;46845.53154468412;47417.392043437256;47759.761201193774;47913;49219.50780492149;45083.77458112688;45196;45382.77308613502;45546.316805247945;45995.31007034897;7717.498362606637;7854.607269636381;7999.800004999922;8090.1909809018625;8102.7569172924905;32463.513047304783;33134.17164570905;33202.5019624701;33667.83166084154;34234;39462.80268598639;39748.80125599354;43286.56713432825;44301.11397772091;44712;10114.443705596263;10226;10305.227107966783;10350.941489941191;10478.895211047791;10578.523966421684;10610.628627997983;10717.571297148026;10720;10764.46177691128;10336.689899303034;10500.527476263434;10582.206334525095;10810;10875.891241087487;10473.738156546147;10525.736856578647;10554.155667546424;10576.524056417325;10691;10306.948465257627;10837.13302935779;11024.944875275572;11032.779344413228;11051.944740276247;8880.911190888008;9152.679656212;9186.219171370509;9316.34785565004;9745.805083898424;8356.373272004746;8613.22480976715;8629.482231066157;9158.542072896462;9262.861057084285 19:19:28 INFO - PROCESS | 21125 | __end_tp_report 19:19:28 INFO - PROCESS | 21125 | __start_cc_report 19:19:28 INFO - PROCESS | 21125 | _x_x_mozilla_cycle_collect,333 19:19:28 INFO - PROCESS | 21125 | __end_cc_report 19:19:28 INFO - PROCESS | 21125 | __startTimestamp1457147968394__endTimestamp 19:19:28 INFO - PROCESS | 21125 | 19:19:28 INFO - PROCESS | 21125 | ------- Summary: start ------- 19:19:28 INFO - PROCESS | 21125 | Number of tests: 6 19:19:28 INFO - PROCESS | 21125 | 19:19:28 INFO - PROCESS | 21125 | [#0] dojo.html Cycles:165 Average:5154.77 Median:5325.57 stddev:567.59 (10.7%) stddev-sans-first:546.27 19:19:28 INFO - PROCESS | 21125 | Values: 3113.4 3147.1 3155.9 3171.7 3191.3 4999.6 5036.2 5036.6 5042.7 5054.4 5024.9 5089.5 5185.6 5204.1 5211.6 4679.1 4718.9 4763.9 4783.0 4888.5 4675.8 4679.8 4714.5 4730.6 4735.8 4669.8 4731.1 4741.0 4772.1 4788.0 4717.3 4725.3 4739.2 4758.1 4758.9 4602.2 4673.7 4728.4 4734.2 4734.7 5015.5 5016.2 5031.3 5068.8 5087.7 5528.3 5529.9 5532.1 5532.5 5582.5 5425.3 5574.1 5584.8 5585.1 5627.9 5286.9 5301.9 5304.7 5313.9 5325.6 5713.4 5714.6 5732.4 5738.4 5769.9 5305.5 5447.4 5513.9 5514.8 5575.8 5431.6 5453.1 5578.4 5587.6 5596.5 5535.5 5578.1 5579.6 5586.2 5626.2 5408.4 5445.7 5470.9 5482.8 5576.5 4229.3 4236.3 4237.2 4274.6 4292.4 3814.5 3826.1 3830.1 3860.1 3882.7 5108.7 5151.9 5226.1 5258.2 5289.4 5520.4 5567.6 5596.8 5617.1 5618.1 5291.9 5300.8 5307.8 5307.9 5327.5 4614.5 4687.5 4738.1 4783.6 4792.1 5753.3 5797.6 5828.5 5828.5 5831.4 5532.6 5534.6 5557.0 5567.1 5567.6 5547.4 5772.9 5796.6 5845.8 5858.7 5436.4 5467.3 5471.7 5474.1 5493.8 5288.6 5431.8 5453.5 5484.4 5557.2 5307.5 5378.5 5388.8 5422.4 5432.0 5406.2 5406.7 5443.9 5461.5 5469.8 5206.8 5346.9 5348.4 5359.4 5419.2 5438.0 5440.3 5495.5 5503.7 5518.5 5249.5 5274.0 5299.6 5309.8 5315.4 19:19:28 INFO - PROCESS | 21125 | 19:19:28 INFO - PROCESS | 21125 | [#1] ext.html Cycles:180 Average:41970.82 Median:3600.04 stddev:68596.86 (1905.4%) stddev-sans-first:68718.67 19:19:28 INFO - PROCESS | 21125 | Values: 514.2 527.4 539.1 559.0 569.2 36347.0 36678.1 36707.1 36709.3 36976.0 40014.0 40468.0 40557.6 40582.8 40633.8 8341.2 8531.1 8539.3 8552.8 8564.3 8321.8 8443.2 8522.5 8655.8 8722.2 8697.7 8718.0 8721.4 8732.0 8740.6 8568.4 8632.4 8636.1 8710.3 8715.8 8551.6 8752.5 8804.7 8812.6 8831.6 39368.8 39684.6 39788.6 39794.0 39837.2 2747.6 3161.4 3215.7 3268.1 3599.5 26829.6 27188.0 27219.9 27479.2 27914.6 3461.8 3600.6 3627.5 3656.3 3741.0 179134.0 179823.0 181429.0 182401.1 182430.0 41236.8 41725.4 41803.0 55850.4 56498.6 40011.0 40021.2 40094.0 40243.8 40513.2 12808.6 12860.2 12899.3 12906.2 12912.9 10522.8 10639.2 10640.9 10641.6 10670.7 14197.8 14359.7 14376.5 14387.4 14395.5 5688.3 5718.5 5792.3 5820.3 5884.0 940.7 1043.8 1044.0 1068.2 1096.2 28294.7 29042.4 29092.6 29212.7 29242.1 1043.3 1050.4 1100.1 1138.1 1151.2 14963.4 15000.9 15273.2 15384.2 15563.4 324059.0 326124.0 327840.0 328623.0 330087.0 52186.0 52242.5 52543.0 52618.0 52625.0 1244.9 1278.0 1310.7 1344.5 1357.3 27621.0 28943.9 29014.3 29030.7 29301.4 46707.0 46782.8 46794.0 46805.5 47019.3 254165.0 257440.0 257645.0 258604.0 259301.0 31874.0 32455.2 32592.2 32664.5 32700.5 43207.1 44095.3 44097.0 44140.8 44770.3 35183.8 35286.0 35362.5 35646.6 35922.8 37089.4 37313.4 37515.1 37576.0 38321.2 34032.7 37394.4 37960.2 38247.6 38868.8 30146.5 31331.7 31385.7 31387.2 31392.5 25335.2 25497.7 25501.9 25531.6 25792.5 19:19:28 INFO - PROCESS | 21125 | 19:19:28 INFO - PROCESS | 21125 | [#2] jquery.html Cycles:180 Average:25086.88 Median:24769.52 stddev:72194.86 (291.5%) stddev-sans-first:72373.48 19:19:28 INFO - PROCESS | 21125 | Values: 345.6 356.5 357.3 369.2 369.5 16453.5 16598.6 17730.6 17770.9 17843.0 16503.4 16857.3 16949.7 17010.6 17065.8 5238.3 5271.2 5499.2 5533.8 5543.9 5449.5 5457.3 5485.3 5492.2 5503.4 5465.4 5471.6 5556.7 5739.3 5797.6 5031.6 5720.3 5734.6 5756.0 5789.8 5006.8 5027.4 5062.8 5073.5 5082.7 11862.6 11947.1 11964.2 12537.5 19002.8 1981.2 2041.6 2188.0 2743.8 2851.0 8830.6 9144.2 9270.9 9334.7 9512.1 1785.6 1818.1 1836.9 1892.3 1893.2 58864.0 62206.4 63010.0 63051.7 63630.4 9883.5 10086.3 10334.8 10363.6 10404.6 13580.5 13631.8 13642.0 13676.1 13722.9 7049.4 7097.8 7163.4 7196.4 7206.1 6751.3 6791.9 6880.0 6925.2 6931.5 4462.8 4482.5 4484.7 4491.7 4569.6 1875.6 1924.3 1926.9 1930.6 1964.8 881.0 891.4 902.9 951.4 970.6 14905.9 16716.0 16732.0 16938.2 17048.6 912.0 926.1 928.0 933.9 951.9 9420.2 9585.0 9597.3 9622.2 9739.7 432485.0 437347.0 438757.0 444112.0 448264.0 63929.0 68127.7 76887.0 77119.6 78986.2 1019.7 1035.4 1063.3 1066.3 1067.1 15678.8 15755.6 15854.0 15874.1 16100.8 33973.8 34634.1 34712.0 35042.8 35061.6 45047.3 47575.3 48842.0 48911.5 49358.5 7732.3 7744.9 7921.5 7974.0 8007.6 7154.8 9137.7 9161.2 10928.7 11541.3 10708.0 10926.8 10993.2 11215.4 11240.6 9961.4 10939.1 11041.7 11296.1 11306.3 5874.1 8101.3 9794.3 10850.1 11229.5 7836.2 7891.0 7899.9 8108.9 8132.9 10045.5 10947.9 11139.9 11286.5 11321.1 19:19:28 INFO - PROCESS | 21125 | 19:19:28 INFO - PROCESS | 21125 | [#3] mootools.html Cycles:180 Average:5230.12 Median:6359.35 stddev:2729.20 (42.9%) stddev-sans-first:2722.22 19:19:28 INFO - PROCESS | 21125 | Values: 1469.4 1501.5 1652.9 1762.7 1805.0 6241.7 7132.8 7436.0 7566.0 7618.3 7208.8 7214.0 7230.6 7251.2 7332.9 2218.7 2226.5 2242.8 2244.5 2251.7 2190.1 2224.1 2245.4 2250.7 2252.7 2199.7 2205.9 2208.2 2216.4 2286.0 2188.1 2213.9 2218.6 2225.0 2230.6 2168.1 2171.9 2180.6 2182.1 2191.0 7493.9 7502.3 7540.4 7547.3 7551.6 4463.2 4527.2 4552.1 4552.6 4588.8 2763.2 2835.4 2842.3 2853.9 2859.5 957.9 962.6 968.9 975.5 1010.7 10220.1 10254.0 10263.8 10274.5 10288.6 4163.3 4165.4 4198.7 4291.4 4295.2 8790.4 8816.3 8822.6 8822.9 8834.3 4464.8 4488.8 4496.1 4507.6 4509.4 4024.3 4061.5 4066.2 4139.0 4155.4 3448.6 3455.9 3460.8 3466.5 3502.2 1037.2 1040.4 1050.8 1055.9 1104.1 980.1 993.5 997.6 1096.9 1296.2 6921.6 6955.0 6972.0 6990.9 7001.3 476.1 486.9 492.5 494.5 497.0 5460.5 5480.4 5510.0 5519.1 5530.1 8889.5 9017.5 9082.6 9136.2 9199.0 8823.7 8891.5 8966.5 8980.6 8994.4 7146.2 7189.0 7211.7 7223.4 7270.4 6677.3 6750.7 6791.7 6827.0 6827.8 7803.5 7891.2 7945.8 7961.7 7979.7 7881.1 8098.2 8143.8 8208.9 8229.1 7065.0 7143.4 7188.5 7199.3 7225.9 7166.2 7257.2 7270.4 7277.0 7300.9 6202.1 6368.9 6373.8 6443.6 6520.7 6331.3 6395.0 6421.1 6493.6 6641.1 6784.1 6832.3 6890.5 6900.6 6906.3 6181.4 6242.4 6350.1 6383.9 6385.6 6303.4 6325.8 6368.6 6413.7 6432.3 19:19:28 INFO - PROCESS | 21125 | 19:19:28 INFO - PROCESS | 21125 | [#4] prototype.html Cycles:180 Average:5495.56 Median:6271.55 stddev:1687.25 (26.9%) stddev-sans-first:1647.06 19:19:28 INFO - PROCESS | 21125 | Values: 342.5 345.7 348.6 350.2 354.6 6204.1 6232.3 6265.5 6271.1 6281.2 6150.6 6154.5 6159.2 6162.3 6178.1 4590.2 4664.1 4690.5 4694.9 4799.0 4668.5 4671.8 4678.3 4691.8 4708.3 4619.1 4627.4 4665.7 4666.6 4684.0 4635.7 4658.3 4671.1 4685.6 4707.1 4027.2 4057.9 4063.3 4063.7 4070.1 5773.0 5831.2 5883.6 5899.2 5904.8 5156.1 5362.5 5415.9 5433.8 5451.7 6492.5 6524.5 6528.4 6531.6 6548.3 4460.5 4461.7 4462.4 4476.9 4485.5 6767.4 6826.9 6839.3 6843.9 6846.8 4637.5 4637.6 4643.3 4643.3 4651.6 4497.0 4639.7 4649.7 4656.1 4685.1 5373.6 5408.7 5435.7 5453.5 5486.0 6528.7 6579.0 6598.1 6629.2 6634.7 1634.2 1662.4 1663.6 1664.3 1665.0 1061.4 1079.7 1081.6 1096.7 1106.3 6241.8 6272.0 6287.4 6302.1 6312.9 6695.7 6702.6 6706.7 6736.2 6743.6 6193.8 6272.2 6372.7 6378.4 6383.8 3676.6 3682.7 3686.0 3697.6 3704.1 7222.9 7250.4 7253.3 7269.1 7269.7 6984.3 6985.8 6987.4 6989.2 7007.7 7031.9 7210.2 7210.4 7236.1 7263.7 6757.0 6771.4 6771.8 6826.4 6835.3 6733.3 6770.5 6774.2 6780.5 6788.4 7153.0 7212.4 7212.9 7224.8 7233.4 4431.0 4478.8 4545.6 4547.0 4564.0 6663.7 6812.1 6837.6 6843.9 6845.8 6534.8 6575.4 6586.3 6609.6 6620.4 6512.0 6527.3 6534.6 6608.3 6612.3 6386.4 6448.2 6459.1 6488.2 6531.2 6569.5 6620.7 6622.1 6636.7 6655.2 6466.6 6489.7 6502.1 6502.5 6514.6 19:19:28 INFO - PROCESS | 21125 | 19:19:28 INFO - PROCESS | 21125 | [#5] yui.html Cycles:180 Average:13349.81 Median:45289.39 stddev:15483.47 (34.2%) stddev-sans-first:15497.79 19:19:28 INFO - PROCESS | 21125 | Values: 706.4 724.1 776.9 787.6 800.0 13768.5 13772.1 13906.8 13931.3 13943.9 12668.9 12739.7 12793.0 12841.3 12889.2 671.3 814.2 820.1 822.4 840.9 824.7 826.7 830.3 830.7 830.9 869.9 874.1 875.1 878.4 881.0 858.7 860.9 861.9 866.9 869.9 636.2 638.2 639.2 639.6 639.9 12735.9 12759.6 12779.4 12831.2 12865.9 12194.4 12263.5 12303.9 12482.8 12492.8 9953.8 9958.1 10120.1 10140.8 10154.9 3384.9 3453.9 3463.6 3564.1 3580.6 47454.0 47942.3 48781.8 48819.3 48956.3 10318.1 10325.2 10370.3 10480.5 10735.4 17763.4 17779.1 17808.7 17821.8 17897.1 7769.8 7813.7 7958.3 8071.8 8122.9 4244.6 4273.4 4282.4 4302.2 4484.6 2941.3 2991.7 2994.2 3000.1 3007.5 516.4 521.0 527.6 532.4 533.3 562.4 615.8 618.7 662.8 665.7 7888.8 8226.0 8257.4 8362.8 8464.8 422.2 633.3 638.8 650.8 731.5 3788.7 3897.8 3978.7 3987.6 4025.8 54493.2 56884.7 57061.7 57512.7 57567.7 46845.5 47417.4 47759.8 47913.0 49219.5 45083.8 45196.0 45382.8 45546.3 45995.3 7717.5 7854.6 7999.8 8090.2 8102.8 32463.5 33134.2 33202.5 33667.8 34234.0 39462.8 39748.8 43286.6 44301.1 44712.0 10114.4 10226.0 10305.2 10350.9 10478.9 10578.5 10610.6 10717.6 10720.0 10764.5 10336.7 10500.5 10582.2 10810.0 10875.9 10473.7 10525.7 10554.2 10576.5 10691.0 10306.9 10837.1 11024.9 11032.8 11051.9 8880.9 9152.7 9186.2 9316.3 9745.8 8356.4 8613.2 8629.5 9158.5 9262.9 19:19:28 INFO - PROCESS | 21125 | -------- Summary: end -------- 19:19:28 INFO - PROCESS | 21125 | 19:19:29 INFO - TEST-INFO | 21125: exit 0 19:19:29 INFO - TEST-OK | dromaeo_css | took 1111411ms 19:19:29 INFO - TEST-START | kraken 19:19:29 INFO - operating with platform_type : linux_ 19:19:29 INFO - Initialising browser for kraken test... 19:19:29 INFO - TEST-INFO | started process 21366 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJt6XTd/profile http://localhost:47625/getInfo.html) 19:19:32 INFO - PROCESS | 21366 | 19:19:32 INFO - PROCESS | 21366 | (process:21436): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:19:33 INFO - PROCESS | 21366 | __metrics Screen width/height:1600/1200 19:19:33 INFO - PROCESS | 21366 | colorDepth:24 19:19:33 INFO - PROCESS | 21366 | Browser inner width/height: 1024/697 19:19:33 INFO - PROCESS | 21366 | __metrics 19:19:34 ERROR - PROCESS | 21366 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:19:35 INFO - TEST-INFO | 21366: exit 0 19:19:35 INFO - Browser initialized. 19:19:35 INFO - Running cycle 1/1 for kraken test... 19:19:35 INFO - TEST-INFO | started process 21487 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJt6XTd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:37 INFO - PROCESS | 21487 | 19:19:37 INFO - PROCESS | 21487 | (process:21554): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:19:47 INFO - PROCESS | 21487 | RSS: Main: 164728832 19:19:47 INFO - PROCESS | 21487 | 19:19:49 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47625/tests/kraken/driver.html?testName=audio-beat-detection) 19:19:50 INFO - PROCESS | 21487 | RSS: Main: 169586688 19:19:50 INFO - PROCESS | 21487 | 19:19:53 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47625/tests/kraken/driver.html?testName=audio-dft) 19:19:53 INFO - PROCESS | 21487 | RSS: Main: 172818432 19:19:53 INFO - PROCESS | 21487 | 19:19:56 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47625/tests/kraken/driver.html?testName=audio-fft) 19:19:57 INFO - PROCESS | 21487 | RSS: Main: 165769216 19:19:57 INFO - PROCESS | 21487 | 19:19:59 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47625/tests/kraken/driver.html?testName=audio-oscillator) 19:19:59 INFO - PROCESS | 21487 | RSS: Main: 165163008 19:19:59 INFO - PROCESS | 21487 | 19:20:01 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:20:02 INFO - PROCESS | 21487 | RSS: Main: 167440384 19:20:02 INFO - PROCESS | 21487 | 19:20:05 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47625/tests/kraken/driver.html?testName=imaging-darkroom) 19:20:06 INFO - PROCESS | 21487 | RSS: Main: 167211008 19:20:06 INFO - PROCESS | 21487 | 19:20:09 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47625/tests/kraken/driver.html?testName=imaging-desaturate) 19:20:10 INFO - PROCESS | 21487 | RSS: Main: 166010880 19:20:10 INFO - PROCESS | 21487 | 19:20:13 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47625/tests/kraken/driver.html?testName=json-parse-financial) 19:20:13 INFO - PROCESS | 21487 | RSS: Main: 168136704 19:20:13 INFO - PROCESS | 21487 | 19:20:15 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:20:15 INFO - PROCESS | 21487 | RSS: Main: 169005056 19:20:15 INFO - PROCESS | 21487 | 19:20:17 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:18 INFO - PROCESS | 21487 | RSS: Main: 167882752 19:20:18 INFO - PROCESS | 21487 | 19:20:20 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:20 INFO - PROCESS | 21487 | RSS: Main: 168497152 19:20:20 INFO - PROCESS | 21487 | 19:20:23 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:23 INFO - PROCESS | 21487 | RSS: Main: 168615936 19:20:23 INFO - PROCESS | 21487 | 19:20:26 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:27 INFO - PROCESS | 21487 | RSS: Main: 168247296 19:20:27 INFO - PROCESS | 21487 | 19:20:28 INFO - PROCESS | 21487 | Cycle 1(1): loaded http://localhost:47625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47625/tests/kraken/driver.html?testName=ai-astar) 19:20:29 INFO - PROCESS | 21487 | RSS: Main: 169848832 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | __start_tp_report 19:20:29 INFO - PROCESS | 21487 | _x_x_mozilla_page_load 19:20:29 INFO - PROCESS | 21487 | _x_x_mozilla_page_load_details 19:20:29 INFO - PROCESS | 21487 | |i|pagename|runs| 19:20:29 INFO - PROCESS | 21487 | |0;ai-astar;112;109;115;112;116;126;113;113;112;112 19:20:29 INFO - PROCESS | 21487 | |1;audio-beat-detection;160;127;158;168;144;159;156;129;181;128 19:20:29 INFO - PROCESS | 21487 | |2;audio-dft;163;163;162;161;162;162;166;173;167;162 19:20:29 INFO - PROCESS | 21487 | |3;audio-fft;73;76;77;77;74;75;76;75;156;75 19:20:29 INFO - PROCESS | 21487 | |4;audio-oscillator;93;94;140;95;96;94;137;93;95;136 19:20:29 INFO - PROCESS | 21487 | |5;imaging-gaussian-blur;118;118;118;118;118;118;117;118;117;117 19:20:29 INFO - PROCESS | 21487 | |6;imaging-darkroom;147;146;148;147;146;146;148;149;151;146 19:20:29 INFO - PROCESS | 21487 | |7;imaging-desaturate;96;96;96;98;97;96;97;97;96;97 19:20:29 INFO - PROCESS | 21487 | |8;json-parse-financial;64;61;58;69;58;58;59;58;56;55 19:20:29 INFO - PROCESS | 21487 | |9;json-stringify-tinderbox;68;69;67;67;68;67;68;67;68;67 19:20:29 INFO - PROCESS | 21487 | |10;stanford-crypto-aes;82;93;84;82;83;84;82;84;82;83 19:20:29 INFO - PROCESS | 21487 | |11;stanford-crypto-ccm;118;121;127;127;117;118;117;118;122;136 19:20:29 INFO - PROCESS | 21487 | |12;stanford-crypto-pbkdf2;151;163;156;152;140;143;168;158;157;142 19:20:29 INFO - PROCESS | 21487 | |13;stanford-crypto-sha256-iterative;72;72;73;71;73;69;72;70;71;69 19:20:29 INFO - PROCESS | 21487 | __end_tp_report 19:20:29 INFO - PROCESS | 21487 | __start_cc_report 19:20:29 INFO - PROCESS | 21487 | _x_x_mozilla_cycle_collect,806 19:20:29 INFO - PROCESS | 21487 | __end_cc_report 19:20:29 INFO - PROCESS | 21487 | __startTimestamp1457148029194__endTimestamp 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | ------- Summary: start ------- 19:20:29 INFO - PROCESS | 21487 | Number of tests: 14 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#0] ai-astar Cycles:10 Average:114.00 Median:113.00 stddev:4.62 (4.1%) stddev-sans-first:4.84 19:20:29 INFO - PROCESS | 21487 | Values: 112.0 109.0 115.0 112.0 116.0 126.0 113.0 113.0 112.0 112.0 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:158.50 stddev:18.40 (11.6%) stddev-sans-first:19.22 19:20:29 INFO - PROCESS | 21487 | Values: 160.0 127.0 158.0 168.0 144.0 159.0 156.0 129.0 181.0 128.0 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.00 stddev:3.67 (2.2%) stddev-sans-first:3.87 19:20:29 INFO - PROCESS | 21487 | Values: 163.0 163.0 162.0 161.0 162.0 162.0 166.0 173.0 167.0 162.0 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.50 stddev:25.54 (33.8%) stddev-sans-first:26.81 19:20:29 INFO - PROCESS | 21487 | Values: 73.0 76.0 77.0 77.0 74.0 75.0 76.0 75.0 156.0 75.0 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.00 stddev:21.00 (22.3%) stddev-sans-first:21.62 19:20:29 INFO - PROCESS | 21487 | Values: 93.0 94.0 140.0 95.0 96.0 94.0 137.0 93.0 95.0 136.0 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:20:29 INFO - PROCESS | 21487 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 117.0 117.0 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:1.65 (1.1%) stddev-sans-first:1.74 19:20:29 INFO - PROCESS | 21487 | Values: 147.0 146.0 148.0 147.0 146.0 146.0 148.0 149.0 151.0 146.0 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 19:20:29 INFO - PROCESS | 21487 | Values: 96.0 96.0 96.0 98.0 97.0 96.0 97.0 97.0 96.0 97.0 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:58.50 stddev:4.14 (7.1%) stddev-sans-first:4.08 19:20:29 INFO - PROCESS | 21487 | Values: 64.0 61.0 58.0 69.0 58.0 58.0 59.0 58.0 56.0 55.0 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 19:20:29 INFO - PROCESS | 21487 | Values: 68.0 69.0 67.0 67.0 68.0 67.0 68.0 67.0 68.0 67.0 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:3.31 (4.0%) stddev-sans-first:3.44 19:20:29 INFO - PROCESS | 21487 | Values: 82.0 93.0 84.0 82.0 83.0 84.0 82.0 84.0 82.0 83.0 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:121.50 stddev:6.19 (5.1%) stddev-sans-first:6.39 19:20:29 INFO - PROCESS | 21487 | Values: 118.0 121.0 127.0 127.0 117.0 118.0 117.0 118.0 122.0 136.0 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:156.50 stddev:9.25 (5.9%) stddev-sans-first:9.78 19:20:29 INFO - PROCESS | 21487 | Values: 151.0 163.0 156.0 152.0 140.0 143.0 168.0 158.0 157.0 142.0 19:20:29 INFO - PROCESS | 21487 | 19:20:29 INFO - PROCESS | 21487 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:72.00 stddev:1.48 (2.0%) stddev-sans-first:1.54 19:20:29 INFO - PROCESS | 21487 | Values: 72.0 72.0 73.0 71.0 73.0 69.0 72.0 70.0 71.0 69.0 19:20:29 INFO - PROCESS | 21487 | -------- Summary: end -------- 19:20:29 INFO - PROCESS | 21487 | 19:20:30 INFO - TEST-INFO | 21487: exit 0 19:20:30 INFO - TEST-OK | kraken | took 61074ms 19:20:30 INFO - SUITE-END | took 1172s 19:20:30 INFO - Completed test suite (00:19:32) 19:20:30 INFO - javascript benchmark 19:20:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3113.424016556937, 3147.0873446700457, 3155.9368812623743, 3171.730402915752, 3191.3138675184846, 4999.550040496355, 5036.2445633155, 5036.571891389227, 5042.672226305288, 5054.418741844689, 5024.899502009957, 5089.491050894909, 5185.611079169068, 5204.115300398932, 5211.609129315298, 4679.1343601433755, 4718.90562188756, 4763.919655524309, 4783.043391321732, 4888.462269150391, 4675.812967481296, 4679.789409476582, 4714.528547145275, 4730.645201609876, 4735.810567577293, 4669.789859456333, 4731.124741922738, 4740.952590474086, 4772.117158325721, 4787.976060119712, 4717.315989181584, 4725.31482934976, 4739.170645137087, 4758.143534163849, 4758.881027974294, 4602.240630295997, 4673.696209746356, 4728.38530990969, 4734.171519984024, 4734.668573199878, 5015.523525265094, 5016.247562865563, 5031.345925029759, 5068.82259120929, 5087.720175390352, 5528.281323427969, 5529.944700552983, 5532.114861622121, 5532.474414930575, 5582.525485333752, 5425.321834770653, 5574.10814269719, 5584.776608935678, 5585.134304182858, 5627.8593035174035, 5286.867828304285, 5301.860100078463, 5304.655197412233, 5313.920291195635, 5325.573954083664, 5713.400092990176, 5714.599978001583, 5732.369439361667, 5738.368779434259, 5769.913451298234, 5305.522502974673, 5447.373552041487, 5513.889722205534, 5514.834554963358, 5575.776968921279, 5431.619786614899, 5453.127499600045, 5578.414266501959, 5587.608867379326, 5596.524295434933, 5535.474129957647, 5578.107502799533, 5579.581531385163, 5586.245856809279, 5626.1842032905, 5408.432114627986, 5445.727713614304, 5470.9179362308805, 5482.780688772405, 5576.525995290364, 4229.3444516099435, 4236.322188449833, 4237.173751118502, 4274.615284624337, 4292.377605247284, 3814.4659747635355, 3826.1391186983265, 3830.138218900725, 3860.0542866997203, 3882.6699730522655, 5108.66793658411, 5151.948480515147, 5226.137687281632, 5258.158694608845, 5289.418164001957, 5520.420355862657, 5567.582431317586, 5596.776128954878, 5617.101263797773, 5618.101103823368, 5291.867703307371, 5300.814471493479, 5307.761150748225, 5307.893842123136, 5327.467253274642, 4614.538546145426, 4687.484376718558, 4738.076075165379, 4783.641226907996, 4792.113459010095, 5753.338366087954, 5797.623154495029, 5828.504577110908, 5828.5337173026055, 5831.446012628793, 5532.557395408277, 5534.612577119563, 5556.9719601873785, 5567.109262517978, 5567.582431317586, 5547.389787123332, 5772.94227057724, 5796.565257605612, 5845.795397161079, 5858.7070646468355, 5436.374816896107, 5467.289252397163, 5471.72641367922, 5474.124140137718, 5493.835184944458, 5288.550473209666, 5431.8098866539485, 5453.454654534674, 5484.396716361117, 5557.166425036277, 5307.52232299095, 5378.489043540857, 5388.811391601275, 5422.430644782241, 5432.049391356576, 5406.162044883049, 5406.7296635167295, 5443.918341224964, 5461.481159289861, 5469.75386107634, 5206.765695543634, 5346.866328341823, 5348.438413966477, 5359.356877174764, 5419.160030195326, 5438.048341540294, 5440.347158341025, 5495.505404513613, 5503.697296648723, 5518.530924871431, 5249.501297376743, 5273.973630131978, 5299.6290259681455, 5309.761060752198, 5315.364041899732], "unit": "score", "name": "dojo.html", "value": 5118.65089916626}, {"lowerIsBetter": false, "replicates": [514.2106865960751, 527.4066674990636, 539.1319974840507, 559.0300828063309, 569.2485918587464, 36347.0, 36678.083047923814, 36707.08232294194, 36709.26581468369, 36976.0, 40014.0, 40468.0, 40557.59442405575, 40582.79708601453, 40633.796831015876, 8341.249287564118, 8531.146885311451, 8539.274161696263, 8552.828943421158, 8564.314854811631, 8321.750347489586, 8443.15568443157, 8522.531260780655, 8655.783605409884, 8722.21500064994, 8697.652093916236, 8718.0, 8721.433106848066, 8731.95634021829, 8740.562971851383, 8568.443051201682, 8632.438891472035, 8636.093210212963, 8710.303175745925, 8715.825683486295, 8551.615177316973, 8752.518611476366, 8804.735857924272, 8812.559372031374, 8831.60257788401, 39368.80315598432, 39684.60315396838, 39788.60211397878, 39794.0, 39837.20325593501, 2747.5603903375363, 3161.4151381994407, 3215.7105860472434, 3268.1176082457605, 3599.4960705501253, 26829.597556036675, 27188.0, 27219.863900680568, 27479.17562473129, 27914.581281280593, 3461.7576769626135, 3600.5859326177565, 3627.4740162676526, 3656.2504686539196, 3740.9625903740884, 179134.0, 179823.0, 181429.0, 182401.0879945605, 182430.0, 41236.79381603073, 41725.37411938823, 41803.0, 55850.44149558452, 56498.58753531195, 40011.0, 40021.199576008315, 40094.0, 40243.798781005906, 40513.1897362057, 12808.551700690432, 12860.164089334163, 12899.290539020256, 12906.161099528501, 12912.935435322763, 10522.789544209227, 10639.202059845542, 10640.946795265974, 10641.627543036111, 10670.66616672916, 14197.78703319451, 14359.712805744035, 14376.496822611367, 14387.352569134415, 14395.496157634432, 5688.260526131577, 5718.485336319751, 5792.275965504312, 5820.30156381237, 5883.970580147072, 940.7036783413203, 1043.838205078214, 1043.994780026095, 1068.2255364860414, 1096.2326371539793, 28294.717052829208, 29042.41915161685, 29092.563611545844, 29212.707872921423, 29242.122736317946, 1043.2592859069994, 1050.4065203160342, 1100.1418893263267, 1138.1463902073444, 1151.2459339132881, 14963.401463941538, 15000.924995375171, 15273.159976201194, 15384.230788460532, 15563.377464901503, 324059.0, 326124.0, 327840.0, 328623.0, 330087.0, 52186.0, 52242.47757522376, 52543.0, 52618.0, 52625.0, 1244.9315287659265, 1277.9903875938091, 1310.7313000834806, 1344.4823742858873, 1357.3077730357588, 27621.0, 28943.855280723463, 29014.27464313409, 29030.7096929028, 29301.41397172087, 46707.0, 46782.76608617071, 46794.0, 46805.531944680115, 47019.294710580056, 254165.0, 257440.0, 257645.0, 258604.0, 259301.0, 31874.0, 32455.188620284684, 32592.185195370304, 32664.51003234906, 32700.50949235811, 43207.135857283305, 44095.33856992212, 44097.0, 44140.7792961046, 44770.328445074, 35183.82408087943, 35286.0, 35362.46956295709, 35646.64353356433, 35922.8203858979, 37089.44365834461, 37313.44029839609, 37515.06212344604, 37576.0, 38321.23357532889, 34032.65967340295, 37394.43908341431, 37960.240795184494, 38247.61752382552, 38868.80565597154, 30146.54780178343, 31331.68668313379, 31385.686143139188, 31387.215319617193, 31392.529112063796, 25335.239942801745, 25497.745022549538, 25501.872490637426, 25531.617025744257, 25792.484150317265], "unit": "score", "name": "ext.html", "value": 17359.923064233564}, {"lowerIsBetter": false, "replicates": [345.59047528678514, 356.45996315581897, 357.26225344663277, 369.1804194687796, 369.549150036955, 16453.506394808144, 16598.585035374123, 17730.556736081606, 17770.911145444286, 17843.0, 16503.422380216696, 16857.325706971707, 16949.745753813702, 17010.574735631617, 17065.82934170658, 5238.292830467895, 5271.182966640177, 5499.202615620733, 5533.750981205855, 5543.861403464905, 5449.455054494559, 5457.263269458632, 5485.286912701344, 5492.231087647732, 5503.449655034485, 5465.371482279529, 5471.5896307776875, 5556.666600003992, 5739.311282646088, 5797.594168408213, 5031.572316353115, 5720.3135623725, 5734.598578099534, 5755.971220143893, 5789.8263052108505, 5006.774695138727, 5027.371578552681, 5062.848114556569, 5073.492650734934, 5082.745862706887, 11862.576490821071, 11947.103967202494, 11964.1625086244, 12537.498500059986, 19002.809971900242, 1981.2372236688834, 2041.5916816636732, 2187.9671804922777, 2743.8490883001427, 2851.0, 8830.621608263486, 9144.222741067017, 9270.907290927073, 9334.71995840126, 9512.1439070484, 1785.5625371783867, 1818.1182126668687, 1836.917338719761, 1892.3376818113688, 1893.2237782509105, 58864.0, 62206.37793622051, 63010.0, 63051.68474157646, 63630.36369636337, 9883.50582470888, 10086.344387614781, 10334.844977325347, 10363.63727269557, 10404.635837745642, 13580.45678172862, 13631.795523067161, 13642.0, 13676.111052781538, 13722.862771372158, 7049.400800931876, 7097.822554436078, 7163.391111755455, 7196.352328290374, 7206.099237595301, 6751.25736169021, 6791.898121528181, 6880.0, 6925.168979722465, 6931.514793964374, 4462.821487140543, 4482.484514280834, 4484.663650226246, 4491.708038977456, 4569.588737013684, 1875.5967466994662, 1924.2969971575258, 1926.9325573604856, 1930.5849242412949, 1964.79369666183, 880.9779755506164, 891.3537685178194, 902.9142231487998, 951.3530799056708, 970.5535453691381, 14905.925470372578, 16715.97853814766, 16732.0, 16938.15309234558, 17048.57378565521, 911.9954400227956, 926.0693003531408, 927.9814403712023, 933.8552524358599, 951.9190868776093, 9420.19928306088, 9584.952075239578, 9597.280203984728, 9622.182114520205, 9739.74038619173, 432485.0, 437347.0, 438757.0, 444112.0, 448264.0, 63929.0, 68127.65936170386, 76887.0, 77119.61440192876, 78986.21013789788, 1019.7246743379246, 1035.3942943378058, 1063.2716589136312, 1066.3495267886583, 1067.0609863320383, 15678.764818527503, 15755.606109847346, 15854.023332336317, 15874.10127196956, 16100.758488622914, 33973.83013084919, 34634.13414664553, 34712.0, 35042.824785875906, 35061.649383505835, 45047.32429013633, 47575.28637070516, 48842.0, 48911.5108848907, 49358.506414936826, 7732.265434783687, 7744.883826742491, 7921.485103468256, 7974.0, 8007.55958422269, 7154.785356439315, 9137.680181193626, 9161.221296189899, 10928.672139835817, 11541.307521548733, 10708.0, 10926.836097458385, 10993.175511836484, 11215.439228038402, 11240.55037798479, 9961.352512086982, 10939.07017903487, 11041.668749937515, 11296.096312294832, 11306.321620702784, 5874.089516125007, 8101.311388531805, 9794.314397992071, 10850.131989440668, 11229.49467273991, 7836.216378362118, 7891.0, 7899.881501777593, 8108.878366824384, 8132.87800683002, 10045.547950342398, 10947.890521094687, 11139.94430027877, 11286.548538058385, 11321.094312455149], "unit": "score", "name": "jquery.html", "value": 8220.115762803498}, {"lowerIsBetter": false, "replicates": [1469.3828591991362, 1501.4969985055009, 1652.8760342974272, 1762.6650936322105, 1805.0072460146923, 6241.687915604224, 7132.786016419503, 7436.0, 7565.962170189148, 7618.276263754941, 7208.783736487901, 7214.0, 7230.60231687257, 7251.238619944896, 7332.8900066499045, 2218.744844342897, 2226.521297920947, 2242.7532971373134, 2244.461329280969, 2251.6960210371635, 2190.123950419837, 2224.1103558576538, 2245.38251980705, 2250.673652320421, 2252.707148070757, 2199.736031676201, 2205.900734466945, 2208.205046183373, 2216.3794137641485, 2286.0284379138884, 2188.081005977477, 2213.922512712047, 2218.6450167973126, 2225.043231410493, 2230.631945728953, 2168.0785666091847, 2171.9022643981057, 2180.585688719154, 2182.1053368118996, 2190.9890450547805, 7493.925060749377, 7502.324790768803, 7540.396768258526, 7547.28300811422, 7551.584662843541, 4463.174312752151, 4527.185106680796, 4552.135094332067, 4552.590266875997, 4588.7935042923145, 2763.1848604661673, 2835.3620435402077, 2842.346260360108, 2853.857307134656, 2859.513882639956, 957.9185769209626, 962.6101428921298, 968.9224862011022, 975.4537459022899, 1010.7473131717071, 10220.131288840457, 10254.0, 10263.846042309371, 10274.48627568626, 10288.639897603623, 4163.3130533461635, 4165.396017577435, 4198.748075115503, 4291.399204111427, 4295.205387003414, 8790.428622139669, 8816.250618697482, 8822.647094116164, 8822.911770882209, 8834.337424693174, 4464.799084041226, 4488.775561221991, 4496.145732310851, 4507.57178068083, 4509.436320459942, 4024.2555127301544, 4061.4923134608175, 4066.2070896175555, 4139.048018955657, 4155.355919832431, 3448.5516882805578, 3455.930881382358, 3460.7923524588605, 3466.5146879436898, 3502.2120022994623, 1037.2065369991963, 1040.4381633917599, 1050.81610718124, 1055.8680164979378, 1104.0725790336155, 980.1129977370491, 993.4833886379042, 997.586001809241, 1096.9048422641017, 1296.1898813241723, 6921.550099243533, 6955.0, 6971.965140174267, 6990.860182796316, 7001.334873187039, 476.1334371444008, 486.88558188825596, 492.45829587454233, 494.48820470813257, 497.0, 5460.535854452337, 5480.3971563128025, 5510.035743744908, 5519.061759500894, 5530.115181570929, 8889.4666320021, 9017.549122543847, 9082.636694532144, 9136.177744003071, 9199.03410141939, 8823.735287941372, 8891.510966896753, 8966.506842123616, 8980.55097245135, 8994.415363001384, 7146.178189508169, 7188.964055179796, 7211.71153153868, 7223.386012188917, 7270.382017528569, 6677.29888361715, 6750.6624668767345, 6791.72833086671, 6827.0, 6827.761028363983, 7803.492772969966, 7891.210878912063, 7945.761627151194, 7961.72133975308, 7979.680812767424, 7881.093674227537, 8098.230668086522, 8143.75568732939, 8208.876866847122, 8229.094799572162, 7065.0, 7143.428525717826, 7188.5327453715345, 7199.316064973819, 7225.927740722525, 7166.211716711054, 7257.237990010973, 7270.418366530559, 7277.0, 7300.853982920418, 6202.100695399232, 6368.904466432915, 6373.776917807854, 6443.645599491885, 6520.706568204348, 6331.303556608677, 6394.968025159845, 6421.101045853491, 6493.577917435352, 6641.070250165078, 6784.05023296729, 6832.316768323128, 6890.517663763489, 6900.585964842126, 6906.274841141809, 6181.443670069715, 6242.375762423721, 6350.079238510482, 6383.872322553616, 6385.584936979081, 6303.432691057827, 6325.810225693236, 6368.617882926854, 6413.71138298787, 6432.324605916311], "unit": "score", "name": "mootools.html", "value": 4224.250392292387}, {"lowerIsBetter": false, "replicates": [342.525602041173, 345.7372396978296, 348.59737003760665, 350.18581797321235, 354.5851353915918, 6204.100405441209, 6232.2832874219475, 6265.467435267997, 6271.122042913996, 6281.246250449946, 6150.569460137792, 6154.476869466101, 6159.23009623797, 6162.291336496304, 6178.104174894637, 4590.196715574778, 4664.113818374515, 4690.530946905316, 4694.90610187796, 4798.952010479894, 4668.533146685321, 4671.789769460365, 4678.345031695565, 4691.765411729417, 4708.317293992386, 4619.099275641252, 4627.375304333922, 4665.673402861801, 4666.580007799297, 4683.953160468386, 4635.6523260755575, 4658.324542941272, 4671.135839869635, 4685.62514998801, 4707.082118986799, 4027.194561087794, 4057.9188416231805, 4063.309237429644, 4063.654589359878, 4070.104576993057, 5772.9711351442975, 5831.183634291203, 5883.588148829584, 5899.233099697055, 5904.793332233351, 5156.123459011939, 5362.544183744387, 5415.862668839549, 5433.782648694087, 5451.672899625995, 6492.513061520358, 6524.543281970264, 6528.37980391862, 6531.608103513757, 6548.345165483413, 4460.464744230713, 4461.687681862271, 4462.352958820953, 4476.8880777980485, 4485.529019452943, 6767.3571010754395, 6826.863462730767, 6839.316068393121, 6843.863122737567, 6846.760363387258, 4637.466691330473, 4637.6289896808175, 4643.257078867365, 4643.349931009661, 4651.5813576778255, 4496.955030449719, 4639.721616703008, 4649.67452278344, 4656.115338085753, 4685.062987402465, 5373.570114390839, 5408.702521361363, 5435.728213589305, 5453.454654534515, 5485.9725701371235, 6528.738850446024, 6579.0, 6598.10925525048, 6629.171353580802, 6634.734610615618, 1634.1502418742425, 1662.3599914032943, 1663.6340005198838, 1664.25108701085, 1664.9583760406088, 1061.368485750977, 1079.6976846482996, 1081.5565618096543, 1096.7093720164162, 1106.31961343773, 6241.75032998684, 6271.96864015677, 6287.434130928238, 6302.149209856702, 6312.936870631235, 6695.665216739144, 6702.597844129368, 6706.698198581075, 6736.157980252468, 6743.5953842769595, 6193.81418557444, 6272.2473303203, 6372.7132279047555, 6378.362163783585, 6383.776567820104, 3676.632336766302, 3682.6869716074434, 3686.0416291764336, 3697.574778900407, 3704.148045949447, 7222.927770722225, 7250.383717384081, 7253.347198752138, 7269.127704675473, 7269.6728647211, 6984.3364880336285, 6985.79042628722, 6987.371136597731, 6989.231184569693, 7007.684654190573, 7031.8593628127155, 7210.1708303545765, 7210.351068403869, 7236.131664200225, 7263.709451621876, 6757.0, 6771.356721111487, 6771.796846094625, 6826.351496607815, 6835.282295358916, 6733.259341472336, 6770.4922130839395, 6774.187097548326, 6780.457563395015, 6788.422984046411, 7152.962820391118, 7212.4230061596, 7212.908256605736, 7224.783256502314, 7233.421326293778, 4430.977845110754, 4478.820847166076, 4545.568171023748, 4547.0, 4563.954360456353, 6663.666816659051, 6812.114425124702, 6837.589744615339, 6843.931560684528, 6845.794626161223, 6534.8366290843105, 6575.408213260829, 6586.341365863375, 6609.603423794588, 6620.437262832713, 6511.967440162769, 6527.314631963765, 6534.575252608755, 6608.339166083353, 6612.338766123542, 6386.361363863576, 6448.2262128543, 6459.128017717548, 6488.188976377953, 6531.150950376421, 6569.507286953593, 6620.66896655175, 6622.10601568782, 6636.668166591555, 6655.23464801554, 6466.61200327963, 6489.707963141575, 6502.057201705632, 6502.544821862424, 6514.6416947068365], "unit": "score", "name": "prototype.html", "value": 4946.412473483362}, {"lowerIsBetter": false, "replicates": [706.3995603736824, 724.0623392706447, 776.8951191589135, 787.5943888897219, 800.0039950261925, 13768.518101866437, 13772.104813187148, 13906.791398129011, 13931.303434828256, 13943.930280348597, 12668.936655316711, 12739.681507962305, 12793.0, 12841.29372884491, 12889.2266464012, 671.3018460800762, 814.1858141858127, 820.1429506166071, 822.3914303415489, 840.920112589303, 824.7360844529753, 826.6817275348974, 830.3149901331426, 830.7092517618815, 830.9459885107449, 869.8999615044256, 874.1040433555625, 875.1423604867234, 878.4202426398579, 880.9603567839463, 858.6651206029653, 860.8837806896051, 861.8922634670666, 866.9133086691344, 869.9173578510031, 636.1983900285627, 638.1767519899324, 639.1563136659611, 639.6098379988204, 639.8560323927126, 12735.872641273561, 12759.553415630502, 12779.424925878266, 12831.230126192459, 12865.871341286562, 12194.39028048594, 12263.467066616673, 12303.876961230362, 12482.838842376908, 12492.81260781089, 9953.800923981553, 9958.103770660602, 10120.139788118018, 10140.797184056351, 10154.9492252539, 3384.8646054157803, 3453.913652158691, 3463.6363181866045, 3564.091156755011, 3580.5524309461316, 47454.0, 47942.28086578669, 48781.75609121967, 48819.267710984364, 48956.26565601519, 10318.122959548522, 10325.225608079425, 10370.319021989466, 10480.47597620116, 10735.35587864715, 17763.378281760335, 17779.111044447727, 17808.732869006973, 17821.841580297238, 17897.105144742713, 7769.805754856174, 7813.687452501837, 7958.3235424989525, 8071.798205044921, 8122.9187708123345, 4244.596763307481, 4273.423087883159, 4282.407407407385, 4302.182585308781, 4484.573965473275, 2941.3087924337765, 2991.670916199216, 2994.191568276553, 3000.0999700090324, 3007.473692103873, 516.4164494121694, 520.9869753256199, 527.5542166868989, 532.4462558938737, 533.3253434405481, 562.3841893127019, 615.7506209984963, 618.7415931848788, 662.8110988368388, 665.710415969055, 7888.7633370998965, 8225.95887020573, 8257.42198046143, 8362.832743345221, 8464.830703385898, 422.15990179543104, 633.3002032753741, 638.8434833465831, 650.7884937395365, 731.4550659758407, 3788.677962373229, 3897.785621790829, 3978.6574016627374, 3987.601239875989, 4025.8389664413094, 54493.182602261, 56884.715576421855, 57061.71469142628, 57512.71243643755, 57567.712161438925, 46845.53154468412, 47417.392043437256, 47759.761201193774, 47913.0, 49219.50780492149, 45083.77458112688, 45196.0, 45382.77308613502, 45546.316805247945, 45995.31007034897, 7717.498362606637, 7854.607269636381, 7999.800004999922, 8090.1909809018625, 8102.7569172924905, 32463.513047304783, 33134.17164570905, 33202.5019624701, 33667.83166084154, 34234.0, 39462.80268598639, 39748.80125599354, 43286.56713432825, 44301.11397772091, 44712.0, 10114.443705596263, 10226.0, 10305.227107966783, 10350.941489941191, 10478.895211047791, 10578.523966421684, 10610.628627997983, 10717.571297148026, 10720.0, 10764.46177691128, 10336.689899303034, 10500.527476263434, 10582.206334525095, 10810.0, 10875.891241087487, 10473.738156546147, 10525.736856578647, 10554.155667546424, 10576.524056417325, 10691.0, 10306.948465257627, 10837.13302935779, 11024.944875275572, 11032.779344413228, 11051.944740276247, 8880.911190888008, 9152.679656212, 9186.219171370509, 9316.34785565004, 9745.805083898424, 8356.373272004746, 8613.22480976715, 8629.482231066157, 9158.542072896462, 9262.861057084285], "unit": "score", "name": "yui.html", "value": 6126.605797003237}], "name": "dromaeo_css", "value": 6737.204987893741}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 115.0, 112.0, 116.0, 126.0, 113.0, 113.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 114.0}, {"lowerIsBetter": true, "replicates": [160.0, 127.0, 158.0, 168.0, 144.0, 159.0, 156.0, 129.0, 181.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 151.0}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 162.0, 161.0, 162.0, 162.0, 166.0, 173.0, 167.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 77.0, 77.0, 74.0, 75.0, 76.0, 75.0, 156.0, 75.0], "unit": "score", "name": "audio-fft", "value": 83.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 140.0, 95.0, 96.0, 94.0, 137.0, 93.0, 95.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 147.0, 146.0, 146.0, 148.0, 149.0, 151.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 98.0, 97.0, 96.0, 97.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [64.0, 61.0, 58.0, 69.0, 58.0, 58.0, 59.0, 58.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [82.0, 93.0, 84.0, 82.0, 83.0, 84.0, 82.0, 84.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [118.0, 121.0, 127.0, 127.0, 117.0, 118.0, 117.0, 118.0, 122.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.1}, {"lowerIsBetter": true, "replicates": [151.0, 163.0, 156.0, 152.0, 140.0, 143.0, 168.0, 158.0, 157.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 71.0, 73.0, 69.0, 72.0, 70.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.2}], "name": "kraken", "value": 1538.8999999999999}]} 19:20:30 INFO - Return code: 0 19:20:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:20:30 ERROR - # TBPL SUCCESS # 19:20:30 INFO - Running post-action listener: _resource_record_post_action 19:20:30 INFO - Running post-run listener: _resource_record_post_run 19:20:31 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 532783104; Read time: 652; Write time: 909612 19:20:31 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 240762880; Read time: 280; Write time: 482084 19:20:31 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291905536; Read time: 372; Write time: 426984 19:20:31 INFO - Running post-run listener: _upload_blobber_files 19:20:31 INFO - Blob upload gear active. 19:20:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:20:31 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:20:31 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-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:20:31 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-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:20:32 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:20:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:20:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:32 INFO - (blobuploader) - INFO - Done attempting. 19:20:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:20:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:20:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:33 INFO - (blobuploader) - INFO - Done attempting. 19:20:33 INFO - (blobuploader) - INFO - Iteration through files over. 19:20:33 INFO - Return code: 0 19:20:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:20:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:20:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/03c471389c78bc89fbad4f573c1766d8350bce482ab7e35f83e7d113127cdbd01ad281f1676891bd1cb6e57546af147db81b49bed611d33d4e605db41138b6e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6bd4045ef5a7eeb9a863ea18ee4820713d7be0b9b89db48190cce175d367e7a98e8f3cb9cacc41e2272653018bcbb4b018706760739091be8f1b808c22ab9f03"} 19:20:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:20:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:20:33 INFO - Contents: 19:20:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/03c471389c78bc89fbad4f573c1766d8350bce482ab7e35f83e7d113127cdbd01ad281f1676891bd1cb6e57546af147db81b49bed611d33d4e605db41138b6e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6bd4045ef5a7eeb9a863ea18ee4820713d7be0b9b89db48190cce175d367e7a98e8f3cb9cacc41e2272653018bcbb4b018706760739091be8f1b808c22ab9f03"} 19:20:33 INFO - Running post-run listener: copy_logs_to_upload_dir 19:20:33 INFO - Copying logs to upload dir... 19:20:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:20:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.866870 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-04 19:20:33.287065) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 19:20:33.290446) ========= 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=52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726 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-Inbound/sha512/03c471389c78bc89fbad4f573c1766d8350bce482ab7e35f83e7d113127cdbd01ad281f1676891bd1cb6e57546af147db81b49bed611d33d4e605db41138b6e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6bd4045ef5a7eeb9a863ea18ee4820713d7be0b9b89db48190cce175d367e7a98e8f3cb9cacc41e2272653018bcbb4b018706760739091be8f1b808c22ab9f03"} build_url:https://queue.taskcluster.net/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/XpLuoZccRDKgptyFn0cvGQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/03c471389c78bc89fbad4f573c1766d8350bce482ab7e35f83e7d113127cdbd01ad281f1676891bd1cb6e57546af147db81b49bed611d33d4e605db41138b6e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6bd4045ef5a7eeb9a863ea18ee4820713d7be0b9b89db48190cce175d367e7a98e8f3cb9cacc41e2272653018bcbb4b018706760739091be8f1b808c22ab9f03"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 19:20:33.315335) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 19:20:33.315679) ========= 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=52faae308a556c440401f8e5000001e8-1457140920.293308-2040045726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 19:20:33.399662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 19:20:33.399984) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 19:20:33.400291) ========= ========= Total master_lag: 0.25 =========