builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1459908138.02 results: success (0) buildid: 20160405163806 builduid: de203f7bea8b40f08ff9ff56622aff74 revision: bdce1c532b56d098c956c6dcd9a8259407e12125 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.016075) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.017096) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.017885) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006357 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.045128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.045642) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.070555) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.071212) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009307 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.121314) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.121615) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.122039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.122367) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-05 19:02:18-- 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% 111M=0s 2016-04-05 19:02:18 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170154 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.306324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.306663) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.047153 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.397385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.397741) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bdce1c532b56d098c956c6dcd9a8259407e12125 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bdce1c532b56d098c956c6dcd9a8259407e12125 --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=b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-05 19:02:18,550 truncating revision to first 12 chars 2016-04-05 19:02:18,550 Setting DEBUG logging. 2016-04-05 19:02:18,550 attempt 1/10 2016-04-05 19:02:18,550 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bdce1c532b56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 19:02:18,814 unpacking tar archive at: mozilla-aurora-bdce1c532b56/testing/mozharness/ program finished with exit code 0 elapsedTime=0.537201 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.948793) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.949171) ========= echo bdce1c532b56d098c956c6dcd9a8259407e12125 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bdce1c532b56d098c956c6dcd9a8259407e12125'] 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=b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False bdce1c532b56d098c956c6dcd9a8259407e12125 program finished with exit code 0 elapsedTime=0.003706 script_repo_revision: 'bdce1c532b56d098c956c6dcd9a8259407e12125' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.997368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:18.997698) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 19:02:19.007517) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-05 19:02:19.007857) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:02:19 INFO - MultiFileLogger online at 20160405 19:02:19 in /builds/slave/test-pgo 19:02:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:02:19 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:02:19 INFO - {'append_to_log': False, 19:02:19 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:02:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:02:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:02:19 INFO - 'branch': 'Mozilla-Aurora', 19:02:19 INFO - 'buildbot_json_path': 'buildprops.json', 19:02:19 INFO - 'config_files': ('talos/linux_config.py',), 19:02:19 INFO - 'default_actions': ('clobber', 19:02:19 INFO - 'read-buildbot-config', 19:02:19 INFO - 'download-and-extract', 19:02:19 INFO - 'populate-webroot', 19:02:19 INFO - 'create-virtualenv', 19:02:19 INFO - 'install', 19:02:19 INFO - 'run-tests'), 19:02:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:02:19 INFO - 'download_minidump_stackwalk': True, 19:02:19 INFO - 'download_symbols': 'ondemand', 19:02:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:02:19 INFO - 'tooltool.py': '/tools/tooltool.py', 19:02:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:02:19 INFO - '/tools/misc-python/virtualenv.py')}, 19:02:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:02:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:02:19 INFO - 'installer_path': 'installer.exe', 19:02:19 INFO - 'log_level': 'info', 19:02:19 INFO - 'log_name': 'talos', 19:02:19 INFO - 'log_to_console': True, 19:02:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:02:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:02:19 INFO - 'opt_config_files': (), 19:02:19 INFO - 'pip_index': False, 19:02:19 INFO - 'sps_profile': False, 19:02:19 INFO - 'sps_profile_interval': 0, 19:02:19 INFO - 'suite': 'dromaeojs-e10s', 19:02:19 INFO - 'system_bits': '32', 19:02:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:02:19 INFO - 'title': 'talos-linux64-ix-007', 19:02:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:02:19 INFO - 'use_talos_json': True, 19:02:19 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:02:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:02:19 INFO - 'work_dir': 'build'} 19:02:19 INFO - ##### 19:02:19 INFO - ##### Running clobber step. 19:02:19 INFO - ##### 19:02:19 INFO - Running pre-action listener: _resource_record_pre_action 19:02:19 INFO - Running main action method: clobber 19:02:19 INFO - rmtree: /builds/slave/test-pgo/build 19:02:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:02:23 INFO - Running post-action listener: _resource_record_post_action 19:02:23 INFO - ##### 19:02:23 INFO - ##### Running read-buildbot-config step. 19:02:23 INFO - ##### 19:02:23 INFO - Running pre-action listener: _resource_record_pre_action 19:02:23 INFO - Running main action method: read_buildbot_config 19:02:23 INFO - Using buildbot properties: 19:02:23 INFO - { 19:02:23 INFO - "project": "", 19:02:23 INFO - "product": "firefox", 19:02:23 INFO - "script_repo_revision": "production", 19:02:23 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:02:23 INFO - "repository": "", 19:02:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:02:23 INFO - "buildid": "20160405163806", 19:02:23 INFO - "pgo_build": "True", 19:02:23 INFO - "basedir": "/builds/slave/test-pgo", 19:02:23 INFO - "buildnumber": 281, 19:02:23 INFO - "slavename": "talos-linux64-ix-007", 19:02:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:02:23 INFO - "platform": "ubuntu64_hw", 19:02:23 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:02:23 INFO - "branch": "mozilla-aurora", 19:02:23 INFO - "repo_path": "releases/mozilla-aurora", 19:02:23 INFO - "revision": "bdce1c532b56d098c956c6dcd9a8259407e12125", 19:02:23 INFO - "stage_platform": "linux64-pgo", 19:02:23 INFO - "builduid": "de203f7bea8b40f08ff9ff56622aff74", 19:02:23 INFO - "slavebuilddir": "test" 19:02:23 INFO - } 19:02:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 19:02:23 INFO - Running post-action listener: _resource_record_post_action 19:02:23 INFO - ##### 19:02:23 INFO - ##### Running download-and-extract step. 19:02:23 INFO - ##### 19:02:23 INFO - Running pre-action listener: _resource_record_pre_action 19:02:23 INFO - Running main action method: download_and_extract 19:02:23 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:02: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:02:23 INFO - https://queue.taskcluster.net/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:02:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 19:02:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 19:02:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 19:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:02:25 INFO - Downloaded 1448 bytes. 19:02:25 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 19:02:25 INFO - Using the following test package requirements: 19:02:25 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 19:02:25 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:02:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:02:25 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:02:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:02:25 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:02:25 INFO - u'jsshell-linux-x86_64.zip'], 19:02:25 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:02:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:02:25 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 19:02:25 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:02:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:02:25 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:02:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:02:25 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:02:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:02:25 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 19:02:25 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 19:02:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:02:25 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:02:25 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:02:25 INFO - https://queue.taskcluster.net/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:02:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 19:02:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 19:02:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 19:02:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:02:28 INFO - Downloaded 23344572 bytes. 19:02:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:02:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:02:29 INFO - Return code: 0 19:02:29 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:02:29 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:02:29 INFO - https://queue.taskcluster.net/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:02:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 19:02:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 19:02:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 19:02:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:02:32 INFO - Downloaded 23344572 bytes. 19:02:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:02:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:02:33 INFO - Return code: 0 19:02: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:02:33 INFO - https://queue.taskcluster.net/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:02:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 19:02:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 19:02:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 19:02:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:02:35 INFO - Downloaded 10845161 bytes. 19:02:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:02:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:02:35 INFO - Return code: 0 19:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:35 INFO - https://queue.taskcluster.net/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:02:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 19:02:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 19:02:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 19:02:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:02:37 INFO - Downloaded 60573976 bytes. 19:02:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 19:02:37 INFO - mkdir: /builds/slave/test-pgo/properties 19:02:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:02:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:02:37 INFO - Contents: 19:02:37 INFO - build_url:https://queue.taskcluster.net/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 19:02:38 INFO - Running post-action listener: _resource_record_post_action 19:02:38 INFO - Running post-action listener: set_extra_try_arguments 19:02:38 INFO - ##### 19:02:38 INFO - ##### Running populate-webroot step. 19:02:38 INFO - ##### 19:02:38 INFO - Running pre-action listener: _resource_record_pre_action 19:02:38 INFO - Running main action method: populate_webroot 19:02:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:02:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:02:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:02:38 INFO - '--tppagecycles', 19:02:38 INFO - '7'], 19:02:38 INFO - 'tests': ['tsvgm']}}, 19:02:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:02:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:02:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:02:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:02:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:02:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:02:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:38 INFO - 'talos_options': ['--e10s'], 19:02:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:38 INFO - 'tests': ['damp', 'tps']}, 19:02:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:38 INFO - 'talos_options': ['--e10s'], 19:02:38 INFO - 'tests': ['damp', 'tps']}, 19:02:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:02:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:02:38 INFO - 'other': {'tests': ['a11yr', 19:02:38 INFO - 'ts_paint', 19:02:38 INFO - 'tpaint', 19:02:38 INFO - 'sessionrestore', 19:02:38 INFO - 'sessionrestore_no_auto_restore', 19:02:38 INFO - 'tabpaint']}, 19:02:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:02:38 INFO - 'tests': ['a11yr', 19:02:38 INFO - 'ts_paint', 19:02:38 INFO - 'tpaint', 19:02:38 INFO - 'sessionrestore', 19:02:38 INFO - 'sessionrestore_no_auto_restore', 19:02:38 INFO - 'tabpaint']}, 19:02:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:02:38 INFO - 'tests': ['a11yr', 19:02:38 INFO - 'ts_paint', 19:02:38 INFO - 'tpaint', 19:02:38 INFO - 'sessionrestore', 19:02:38 INFO - 'sessionrestore_no_auto_restore', 19:02:38 INFO - 'tabpaint']}, 19:02:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:02:38 INFO - 'tests': ['a11yr', 19:02:38 INFO - 'ts_paint', 19:02:38 INFO - 'tpaint', 19:02:38 INFO - 'sessionrestore', 19:02:38 INFO - 'sessionrestore_no_auto_restore', 19:02:38 INFO - 'tabpaint']}, 19:02:38 INFO - 'other_l64': {'tests': ['a11yr', 19:02:38 INFO - 'ts_paint', 19:02:38 INFO - 'tpaint', 19:02:38 INFO - 'sessionrestore', 19:02:38 INFO - 'sessionrestore_no_auto_restore', 19:02:38 INFO - 'tabpaint']}, 19:02:38 INFO - 'other_nol64': {'tests': ['a11yr', 19:02:38 INFO - 'ts_paint', 19:02:38 INFO - 'tpaint', 19:02:38 INFO - 'sessionrestore', 19:02:38 INFO - 'sessionrestore_no_auto_restore', 19:02:38 INFO - 'tabpaint']}, 19:02:38 INFO - 'svgr': {'tests': ['tsvgx', 19:02:38 INFO - 'tsvgr_opacity', 19:02:38 INFO - 'tart', 19:02:38 INFO - 'tscrollx', 19:02:38 INFO - 'cart']}, 19:02:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:02:38 INFO - 'tests': ['tsvgx', 19:02:38 INFO - 'tsvgr_opacity', 19:02:38 INFO - 'tart', 19:02:38 INFO - 'tscrollx', 19:02:38 INFO - 'cart']}, 19:02:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:38 INFO - 'tests': ['tp5o']}, 19:02:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:38 INFO - 'talos_options': ['--e10s'], 19:02:38 INFO - 'tests': ['tp5o']}, 19:02:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:38 INFO - 'talos_options': ['--xperf_path', 19:02:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:38 INFO - 'tests': ['tp5n']}, 19:02:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:38 INFO - 'talos_options': ['--e10s', 19:02:38 INFO - '--xperf_path', 19:02:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:38 INFO - 'tests': ['tp5n']}}, 19:02:38 INFO - 'talos.zip': {'path': '', 19:02:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:02:38 INFO - Running post-action listener: _resource_record_post_action 19:02:38 INFO - ##### 19:02:38 INFO - ##### Running create-virtualenv step. 19:02:38 INFO - ##### 19:02:38 INFO - Running pre-action listener: _resource_record_pre_action 19:02:38 INFO - Running main action method: create_virtualenv 19:02:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:02:38 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:02:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:02:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:02:38 INFO - Using real prefix '/usr' 19:02:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:02:39 INFO - Installing distribute.............................................................................................................................................................................................done. 19:02:41 INFO - Installing pip.................done. 19:02:41 INFO - Return code: 0 19:02:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:41 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 0x7fe299e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22306d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf920>, '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 0x22c0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c0cb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', '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:02:41 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:02:41 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:02:41 INFO - Using env: {'DISPLAY': ':0', 19:02:41 INFO - 'HOME': '/home/cltbld', 19:02:41 INFO - 'LANG': 'en_US.UTF-8', 19:02:41 INFO - 'LANGUAGE': 'en_US:en', 19:02:41 INFO - 'LOGNAME': 'cltbld', 19:02:41 INFO - 'MAIL': '/var/mail/cltbld', 19:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:41 INFO - 'MOZ_NO_REMOTE': '1', 19:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:41 INFO - 'NO_EM_RESTART': '1', 19:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:02:41 INFO - 'PWD': '/builds/slave/test-pgo', 19:02:41 INFO - 'SHELL': '/bin/bash', 19:02:41 INFO - 'SHLVL': '1', 19:02:41 INFO - 'TERM': 'linux', 19:02:41 INFO - 'TMOUT': '86400', 19:02:41 INFO - 'USER': 'cltbld', 19:02:41 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', 19:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:41 INFO - '_': '/tools/buildbot/bin/python'} 19:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:41 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:02:41 INFO - Cleaning up... 19:02:41 INFO - Return code: 0 19:02:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:41 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 0x7fe299e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22306d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf920>, '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 0x22c0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c0cb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', '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:02:41 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:02:41 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:02:41 INFO - Using env: {'DISPLAY': ':0', 19:02:41 INFO - 'HOME': '/home/cltbld', 19:02:41 INFO - 'LANG': 'en_US.UTF-8', 19:02:41 INFO - 'LANGUAGE': 'en_US:en', 19:02:41 INFO - 'LOGNAME': 'cltbld', 19:02:41 INFO - 'MAIL': '/var/mail/cltbld', 19:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:41 INFO - 'MOZ_NO_REMOTE': '1', 19:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:41 INFO - 'NO_EM_RESTART': '1', 19:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:02:41 INFO - 'PWD': '/builds/slave/test-pgo', 19:02:41 INFO - 'SHELL': '/bin/bash', 19:02:41 INFO - 'SHLVL': '1', 19:02:41 INFO - 'TERM': 'linux', 19:02:41 INFO - 'TMOUT': '86400', 19:02:41 INFO - 'USER': 'cltbld', 19:02:41 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', 19:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:41 INFO - '_': '/tools/buildbot/bin/python'} 19:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:41 INFO - Downloading/unpacking psutil>=0.7.1 19:02:41 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:02:41 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:02:41 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:02:41 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:02:41 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:02:41 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:02:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:02:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:43 INFO - Installing collected packages: psutil 19:02:43 INFO - Running setup.py install for psutil 19:02:43 INFO - building 'psutil._psutil_linux' extension 19:02:43 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:02:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:02:43 INFO - building 'psutil._psutil_posix' extension 19:02:43 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:02:44 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:02:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:44 INFO - Successfully installed psutil 19:02:44 INFO - Cleaning up... 19:02:44 INFO - Return code: 0 19:02:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:02:44 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:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:44 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:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:44 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 0x7fe299e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22306d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf920>, '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 0x22c0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c0cb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', '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:02:44 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:02:44 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:02:44 INFO - Using env: {'DISPLAY': ':0', 19:02:44 INFO - 'HOME': '/home/cltbld', 19:02:44 INFO - 'LANG': 'en_US.UTF-8', 19:02:44 INFO - 'LANGUAGE': 'en_US:en', 19:02:44 INFO - 'LOGNAME': 'cltbld', 19:02:44 INFO - 'MAIL': '/var/mail/cltbld', 19:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:44 INFO - 'MOZ_NO_REMOTE': '1', 19:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:44 INFO - 'NO_EM_RESTART': '1', 19:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:02:44 INFO - 'PWD': '/builds/slave/test-pgo', 19:02:44 INFO - 'SHELL': '/bin/bash', 19:02:44 INFO - 'SHLVL': '1', 19:02:44 INFO - 'TERM': 'linux', 19:02:44 INFO - 'TMOUT': '86400', 19:02:44 INFO - 'USER': 'cltbld', 19:02:44 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', 19:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:44 INFO - '_': '/tools/buildbot/bin/python'} 19:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:02:44 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:02:44 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:02:44 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:02:44 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:02:44 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:02:44 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:02:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:02:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:02:46 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:02:46 INFO - Installing collected packages: mozsystemmonitor 19:02:46 INFO - Running setup.py install for mozsystemmonitor 19:02:46 INFO - Successfully installed mozsystemmonitor 19:02:46 INFO - Cleaning up... 19:02:46 INFO - Return code: 0 19:02:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe299e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22306d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf920>, '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 0x22c0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c0cb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', '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:02:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:02:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:02:46 INFO - Using env: {'DISPLAY': ':0', 19:02:46 INFO - 'HOME': '/home/cltbld', 19:02:46 INFO - 'LANG': 'en_US.UTF-8', 19:02:46 INFO - 'LANGUAGE': 'en_US:en', 19:02:46 INFO - 'LOGNAME': 'cltbld', 19:02:46 INFO - 'MAIL': '/var/mail/cltbld', 19:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:46 INFO - 'MOZ_NO_REMOTE': '1', 19:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:46 INFO - 'NO_EM_RESTART': '1', 19:02:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:02:46 INFO - 'PWD': '/builds/slave/test-pgo', 19:02:46 INFO - 'SHELL': '/bin/bash', 19:02:46 INFO - 'SHLVL': '1', 19:02:46 INFO - 'TERM': 'linux', 19:02:46 INFO - 'TMOUT': '86400', 19:02:46 INFO - 'USER': 'cltbld', 19:02:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', 19:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:46 INFO - '_': '/tools/buildbot/bin/python'} 19:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:46 INFO - Downloading/unpacking blobuploader==1.2.4 19:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:48 INFO - Downloading blobuploader-1.2.4.tar.gz 19:02:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:02:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:02:48 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:02:48 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:02:48 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:02:48 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:02:48 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:02:48 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:02:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:02:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:49 INFO - Downloading docopt-0.6.1.tar.gz 19:02:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:02:49 INFO - Installing collected packages: blobuploader, requests, docopt 19:02:49 INFO - Running setup.py install for blobuploader 19:02:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:02:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:02:49 INFO - Running setup.py install for requests 19:02:49 INFO - Running setup.py install for docopt 19:02:49 INFO - Successfully installed blobuploader requests docopt 19:02:49 INFO - Cleaning up... 19:02:50 INFO - Return code: 0 19:02:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:50 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 0x7fe299e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22306d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf920>, '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 0x22c0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c0cb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', '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:02:50 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:02:50 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:02:50 INFO - Using env: {'DISPLAY': ':0', 19:02:50 INFO - 'HOME': '/home/cltbld', 19:02:50 INFO - 'LANG': 'en_US.UTF-8', 19:02:50 INFO - 'LANGUAGE': 'en_US:en', 19:02:50 INFO - 'LOGNAME': 'cltbld', 19:02:50 INFO - 'MAIL': '/var/mail/cltbld', 19:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:50 INFO - 'MOZ_NO_REMOTE': '1', 19:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:50 INFO - 'NO_EM_RESTART': '1', 19:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:02:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:02:50 INFO - 'SHELL': '/bin/bash', 19:02:50 INFO - 'SHLVL': '1', 19:02:50 INFO - 'TERM': 'linux', 19:02:50 INFO - 'TMOUT': '86400', 19:02:50 INFO - 'USER': 'cltbld', 19:02:50 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', 19:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:50 INFO - '_': '/tools/buildbot/bin/python'} 19:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:02:50 INFO - Running setup.py (path:/tmp/pip-Im8IY2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:02:50 INFO - Running setup.py (path:/tmp/pip-D9T3Hr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:02:50 INFO - Running setup.py (path:/tmp/pip-amTxPe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:02:50 INFO - Running setup.py (path:/tmp/pip-0GPrtt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:02:50 INFO - Running setup.py (path:/tmp/pip-kKac1d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:02:50 INFO - Running setup.py (path:/tmp/pip-m0n0Lk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:02:50 INFO - Running setup.py (path:/tmp/pip-mQRRMv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:02:50 INFO - Running setup.py (path:/tmp/pip-14TKSW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:02:50 INFO - Running setup.py (path:/tmp/pip-u8IdUt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:02:50 INFO - Running setup.py (path:/tmp/pip-TzzeFq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:02:50 INFO - Running setup.py (path:/tmp/pip-Wzu1P8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:02:51 INFO - Running setup.py (path:/tmp/pip-F1lTtQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:02:51 INFO - Running setup.py (path:/tmp/pip-G_EED7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:02:51 INFO - Running setup.py (path:/tmp/pip-FUPB9v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:02:51 INFO - Running setup.py (path:/tmp/pip-SFFEei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:02:51 INFO - Running setup.py (path:/tmp/pip-hbxGJH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:02:51 INFO - Running setup.py (path:/tmp/pip-AP0x6j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:02:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:02:51 INFO - Running setup.py install for manifestparser 19:02:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:02:51 INFO - Running setup.py install for mozcrash 19:02:51 INFO - Running setup.py install for mozdebug 19:02:51 INFO - Running setup.py install for mozdevice 19:02:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:02:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:02:51 INFO - Running setup.py install for mozfile 19:02:51 INFO - Running setup.py install for mozhttpd 19:02:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:02:52 INFO - Running setup.py install for mozinfo 19:02:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:02:52 INFO - Running setup.py install for mozInstall 19:02:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:02:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:02:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:02:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:02:52 INFO - Running setup.py install for mozleak 19:02:52 INFO - Running setup.py install for mozlog 19:02:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:02:52 INFO - Running setup.py install for moznetwork 19:02:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:02:52 INFO - Running setup.py install for mozprocess 19:02:52 INFO - Running setup.py install for mozprofile 19:02:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:02:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:02:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:02:52 INFO - Running setup.py install for mozrunner 19:02:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:02:52 INFO - Running setup.py install for mozscreenshot 19:02:52 INFO - Running setup.py install for moztest 19:02:53 INFO - Running setup.py install for mozversion 19:02:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:02:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:02:53 INFO - Cleaning up... 19:02:53 INFO - Return code: 0 19:02:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:02:53 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:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:53 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:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:53 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 0x7fe299e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22306d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf920>, '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 0x22c0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c0cb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', '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:02:53 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:02:53 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:02:53 INFO - Using env: {'DISPLAY': ':0', 19:02:53 INFO - 'HOME': '/home/cltbld', 19:02:53 INFO - 'LANG': 'en_US.UTF-8', 19:02:53 INFO - 'LANGUAGE': 'en_US:en', 19:02:53 INFO - 'LOGNAME': 'cltbld', 19:02:53 INFO - 'MAIL': '/var/mail/cltbld', 19:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:53 INFO - 'MOZ_NO_REMOTE': '1', 19:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:53 INFO - 'NO_EM_RESTART': '1', 19:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:02:53 INFO - 'PWD': '/builds/slave/test-pgo', 19:02:53 INFO - 'SHELL': '/bin/bash', 19:02:53 INFO - 'SHLVL': '1', 19:02:53 INFO - 'TERM': 'linux', 19:02:53 INFO - 'TMOUT': '86400', 19:02:53 INFO - 'USER': 'cltbld', 19:02:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', 19:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:53 INFO - '_': '/tools/buildbot/bin/python'} 19:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:02:53 INFO - Running setup.py (path:/tmp/pip-SHDAID-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:02:53 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:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:02:53 INFO - Running setup.py (path:/tmp/pip-Jy00Ek-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:02:53 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:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:02:53 INFO - Running setup.py (path:/tmp/pip-QjRRUO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:02:53 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:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:02:53 INFO - Running setup.py (path:/tmp/pip-vlzIVA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:02:53 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:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:02:53 INFO - Running setup.py (path:/tmp/pip-YFSkes-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:02:53 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:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:02:53 INFO - Running setup.py (path:/tmp/pip-3vUnZo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:02:53 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:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:02:53 INFO - Running setup.py (path:/tmp/pip-_x2_kY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:02:53 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:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:02:53 INFO - Running setup.py (path:/tmp/pip-H8bMke-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:02:54 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:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:02:54 INFO - Running setup.py (path:/tmp/pip-KRbs9z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:02:54 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:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:02:54 INFO - Running setup.py (path:/tmp/pip-GOs4UQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:02:54 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:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:02:54 INFO - Running setup.py (path:/tmp/pip-BIqDwF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:02:54 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:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:02:54 INFO - Running setup.py (path:/tmp/pip-b1sBVB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:02:54 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:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:02:54 INFO - Running setup.py (path:/tmp/pip-ZiPPLX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:02:54 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:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:02:54 INFO - Running setup.py (path:/tmp/pip-3va6l1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:02:54 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:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:02:54 INFO - Running setup.py (path:/tmp/pip-Y8b0li-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:02:54 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:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:02:54 INFO - Running setup.py (path:/tmp/pip-kIcAgP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:02:54 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:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:02:54 INFO - Running setup.py (path:/tmp/pip-CfPQbC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:02:54 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:02:54 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:02:54 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:02:54 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:02:54 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:02:54 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:02:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:02:54 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:02:54 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:02:54 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:02:54 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:02:54 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:02:54 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:02:56 INFO - Downloading blessings-1.6.tar.gz 19:02:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:02:56 INFO - Installing collected packages: blessings 19:02:56 INFO - Running setup.py install for blessings 19:02:56 INFO - Successfully installed blessings 19:02:56 INFO - Cleaning up... 19:02:56 INFO - Return code: 0 19:02:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:02:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:02:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:02:56 INFO - Reading from file tmpfile_stdout 19:02:56 INFO - Current package versions: 19:02:56 INFO - argparse == 1.2.1 19:02:56 INFO - blessings == 1.6 19:02:56 INFO - blobuploader == 1.2.4 19:02:56 INFO - docopt == 0.6.1 19:02:56 INFO - manifestparser == 1.1 19:02:56 INFO - mozInstall == 1.12 19:02:56 INFO - mozcrash == 0.17 19:02:56 INFO - mozdebug == 0.1 19:02:56 INFO - mozdevice == 0.48 19:02:56 INFO - mozfile == 1.2 19:02:56 INFO - mozhttpd == 0.7 19:02:56 INFO - mozinfo == 0.9 19:02:56 INFO - mozleak == 0.1 19:02:56 INFO - mozlog == 3.1 19:02:56 INFO - moznetwork == 0.27 19:02:56 INFO - mozprocess == 0.22 19:02:56 INFO - mozprofile == 0.28 19:02:56 INFO - mozrunner == 6.11 19:02:56 INFO - mozscreenshot == 0.1 19:02:56 INFO - mozsystemmonitor == 0.0 19:02:56 INFO - moztest == 0.7 19:02:56 INFO - mozversion == 1.4 19:02:56 INFO - psutil == 3.1.1 19:02:56 INFO - requests == 1.2.3 19:02:56 INFO - wsgiref == 0.1.2 19:02:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:02: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:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:56 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 0x7fe299e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22306d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf920>, '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 0x22c0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c0cb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', '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:02:56 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:02:56 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:02:56 INFO - Using env: {'DISPLAY': ':0', 19:02:57 INFO - 'HOME': '/home/cltbld', 19:02:57 INFO - 'LANG': 'en_US.UTF-8', 19:02:57 INFO - 'LANGUAGE': 'en_US:en', 19:02:57 INFO - 'LOGNAME': 'cltbld', 19:02:57 INFO - 'MAIL': '/var/mail/cltbld', 19:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:57 INFO - 'MOZ_NO_REMOTE': '1', 19:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:57 INFO - 'NO_EM_RESTART': '1', 19:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:02:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:02:57 INFO - 'SHELL': '/bin/bash', 19:02:57 INFO - 'SHLVL': '1', 19:02:57 INFO - 'TERM': 'linux', 19:02:57 INFO - 'TMOUT': '86400', 19:02:57 INFO - 'USER': 'cltbld', 19:02:57 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', 19:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:57 INFO - '_': '/tools/buildbot/bin/python'} 19:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:57 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:02:57 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:02:57 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:02:57 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:02:57 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:02:57 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:02:57 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:02:57 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:02:57 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:02:57 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:02:57 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:02:57 INFO - Cleaning up... 19:02:57 INFO - Return code: 0 19:02:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:57 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 0x7fe299e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22306d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf920>, '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 0x22c0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c0cb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', '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:02:57 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:02:57 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:02:57 INFO - Using env: {'DISPLAY': ':0', 19:02:57 INFO - 'HOME': '/home/cltbld', 19:02:57 INFO - 'LANG': 'en_US.UTF-8', 19:02:57 INFO - 'LANGUAGE': 'en_US:en', 19:02:57 INFO - 'LOGNAME': 'cltbld', 19:02:57 INFO - 'MAIL': '/var/mail/cltbld', 19:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:57 INFO - 'MOZ_NO_REMOTE': '1', 19:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:57 INFO - 'NO_EM_RESTART': '1', 19:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:02:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:02:57 INFO - 'SHELL': '/bin/bash', 19:02:57 INFO - 'SHLVL': '1', 19:02:57 INFO - 'TERM': 'linux', 19:02:57 INFO - 'TMOUT': '86400', 19:02:57 INFO - 'USER': 'cltbld', 19:02:57 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', 19:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:57 INFO - '_': '/tools/buildbot/bin/python'} 19:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:57 INFO - Downloading/unpacking jsonschema 19:02:57 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:02:57 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:02:57 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:02:57 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:02:57 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:02:57 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:02:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:02:59 INFO - Downloading/unpacking functools32 (from jsonschema) 19:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:59 INFO - Downloading functools32-3.2.3-2.tar.gz 19:02:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:02:59 INFO - warning: no files found matching '*.txt' 19:02:59 INFO - no previously-included directories found matching 'build' 19:02:59 INFO - no previously-included directories found matching 'dist' 19:02:59 INFO - no previously-included directories found matching '.git*' 19:02:59 INFO - Installing collected packages: jsonschema, functools32 19:02:59 INFO - Running setup.py install for functools32 19:02:59 INFO - warning: no files found matching '*.txt' 19:02:59 INFO - no previously-included directories found matching 'build' 19:02:59 INFO - no previously-included directories found matching 'dist' 19:02:59 INFO - no previously-included directories found matching '.git*' 19:02:59 INFO - Successfully installed jsonschema functools32 19:02:59 INFO - Cleaning up... 19:02:59 INFO - Return code: 0 19:02:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:59 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 0x7fe299e32f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22306d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf920>, '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 0x22c0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c0cb0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', '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:02:59 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:02:59 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:02:59 INFO - Using env: {'DISPLAY': ':0', 19:02:59 INFO - 'HOME': '/home/cltbld', 19:02:59 INFO - 'LANG': 'en_US.UTF-8', 19:02:59 INFO - 'LANGUAGE': 'en_US:en', 19:02:59 INFO - 'LOGNAME': 'cltbld', 19:02:59 INFO - 'MAIL': '/var/mail/cltbld', 19:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:59 INFO - 'MOZ_NO_REMOTE': '1', 19:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:59 INFO - 'NO_EM_RESTART': '1', 19:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:02:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:02:59 INFO - 'SHELL': '/bin/bash', 19:02:59 INFO - 'SHLVL': '1', 19:02:59 INFO - 'TERM': 'linux', 19:02:59 INFO - 'TMOUT': '86400', 19:02:59 INFO - 'USER': 'cltbld', 19:02:59 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', 19:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:59 INFO - '_': '/tools/buildbot/bin/python'} 19:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:59 INFO - Downloading/unpacking flake8 19:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:03:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:03:01 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:03:01 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:03:01 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:03:01 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:03:01 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:03:01 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:03:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:03:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:03:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:03:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:03:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:03:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:03:02 INFO - no previously-included directories found matching 'docs/_build' 19:03:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:03:02 INFO - Running setup.py install for pep8 19:03:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:03:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:03:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:03:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:03:02 INFO - no previously-included directories found matching 'docs/_build' 19:03:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:03:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:03:02 INFO - Cleaning up... 19:03:02 INFO - Return code: 0 19:03:02 INFO - Running post-action listener: _resource_record_post_action 19:03:02 INFO - Running post-action listener: _start_resource_monitoring 19:03:02 INFO - Starting resource monitoring. 19:03:02 INFO - ##### 19:03:02 INFO - ##### Running install step. 19:03:02 INFO - ##### 19:03:02 INFO - Running pre-action listener: _resource_record_pre_action 19:03:02 INFO - Running main action method: install 19:03:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:03:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:03:03 INFO - Reading from file tmpfile_stdout 19:03:03 INFO - Detecting whether we're running mozinstall >=1.0... 19:03:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:03:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:03:03 INFO - Reading from file tmpfile_stdout 19:03:03 INFO - Output received: 19:03:03 INFO - Usage: mozinstall [options] installer 19:03:03 INFO - Options: 19:03:03 INFO - -h, --help show this help message and exit 19:03:03 INFO - -d DEST, --destination=DEST 19:03:03 INFO - Directory to install application into. [default: 19:03:03 INFO - "/builds/slave/test-pgo"] 19:03:03 INFO - --app=APP Application being installed. [default: firefox] 19:03:03 INFO - mkdir: /builds/slave/test-pgo/build/application 19:03:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:03:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:03:18 INFO - Reading from file tmpfile_stdout 19:03:18 INFO - Output received: 19:03:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:03:18 INFO - Running post-action listener: _resource_record_post_action 19:03:18 INFO - ##### 19:03:18 INFO - ##### Running run-tests step. 19:03:18 INFO - ##### 19:03:18 INFO - Running pre-action listener: _resource_record_pre_action 19:03:18 INFO - Running main action method: run_tests 19:03:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:03:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:03:18 INFO - Python 2.7.3 19:03:18 INFO - Return code: 0 19:03:18 INFO - grabbing minidump binary from tooltool 19:03: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:03:18 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 0x22bf920>, '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 0x22c0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c0cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:03:18 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:03:18 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:03:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:03:18 INFO - Return code: 0 19:03:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:03:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:03:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:03:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:03:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:03:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:03:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:03:19 INFO - Return code: 0 19:03:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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:03:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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:03:19 INFO - Using env: {'DISPLAY': ':0', 19:03:19 INFO - 'HOME': '/home/cltbld', 19:03:19 INFO - 'LANG': 'en_US.UTF-8', 19:03:19 INFO - 'LANGUAGE': 'en_US:en', 19:03:19 INFO - 'LOGNAME': 'cltbld', 19:03:19 INFO - 'MAIL': '/var/mail/cltbld', 19:03:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:03:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:19 INFO - 'MOZ_NO_REMOTE': '1', 19:03:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:19 INFO - 'NO_EM_RESTART': '1', 19:03:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:03:19 INFO - 'PWD': '/builds/slave/test-pgo', 19:03:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:03:19 INFO - 'SHELL': '/bin/bash', 19:03:19 INFO - 'SHLVL': '1', 19:03:19 INFO - 'TERM': 'linux', 19:03:19 INFO - 'TMOUT': '86400', 19:03:19 INFO - 'USER': 'cltbld', 19:03:19 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780', 19:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:19 INFO - '_': '/tools/buildbot/bin/python'} 19:03:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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:03:19 INFO - mozversion application_buildid: 20160405163806 19:03:19 INFO - mozversion application_changeset: bdce1c532b56d098c956c6dcd9a8259407e12125 19:03:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:03:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:03:19 INFO - mozversion application_name: Firefox 19:03:19 INFO - mozversion application_remotingname: firefox-dev 19:03:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:03:19 INFO - mozversion application_vendor: Mozilla 19:03:19 INFO - mozversion application_version: 47.0a2 19:03:19 INFO - mozversion platform_buildid: 20160405163806 19:03:19 INFO - mozversion platform_changeset: bdce1c532b56d098c956c6dcd9a8259407e12125 19:03:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:03:19 INFO - mozversion platform_version: 47.0a2 19:03:19 INFO - using testdate: 1459908199 19:03:19 INFO - actual date: 1459908199 19:03:19 INFO - starting webserver on 'localhost:41546' 19:03:19 INFO - SUITE-START | Running 2 tests 19:03:19 INFO - TEST-START | dromaeo_css 19:03:19 INFO - operating with platform_type : linux_ 19:03:19 INFO - Initialising browser for dromaeo_css test... 19:03:19 INFO - TEST-INFO | started process 6308 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb190Yi/profile http://localhost:41546/getInfo.html) 19:03:23 INFO - PROCESS | 6308 | 19:03:23 INFO - PROCESS | 6308 | (process:6385): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:03:24 INFO - PROCESS | 6308 | __metrics Screen width/height:1600/1200 19:03:24 INFO - PROCESS | 6308 | colorDepth:24 19:03:24 INFO - PROCESS | 6308 | Browser inner width/height: 1024/697 19:03:24 INFO - PROCESS | 6308 | __metrics 19:03:25 ERROR - PROCESS | 6308 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:03:26 INFO - TEST-INFO | 6308: exit 0 19:03:26 INFO - Browser initialized. 19:03:26 INFO - Running cycle 1/1 for dromaeo_css test... 19:03:26 INFO - TEST-INFO | started process 6436 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb190Yi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:03:28 INFO - PROCESS | 6436 | 19:03:28 INFO - PROCESS | 6436 | (process:6505): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:03:38 INFO - PROCESS | 6436 | RSS: Main: 151531520 19:03:38 INFO - PROCESS | 6436 | 19:04:27 INFO - PROCESS | 6436 | 1459908267668 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:06:36 INFO - PROCESS | 6436 | Cycle 1(1): loaded http://localhost:41546/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41546/tests/dromaeo/cssquery-ext.html) 19:06:36 INFO - PROCESS | 6436 | RSS: Main: 154271744 19:06:36 INFO - PROCESS | 6436 | 19:09:38 INFO - PROCESS | 6436 | Cycle 1(1): loaded http://localhost:41546/tests/dromaeo/cssquery-ext.html (next: http://localhost:41546/tests/dromaeo/cssquery-jquery.html) 19:09:39 INFO - PROCESS | 6436 | RSS: Main: 153694208 19:09:39 INFO - PROCESS | 6436 | 19:12:40 INFO - PROCESS | 6436 | Cycle 1(1): loaded http://localhost:41546/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41546/tests/dromaeo/cssquery-mootools.html) 19:12:41 INFO - PROCESS | 6436 | RSS: Main: 153509888 19:12:41 INFO - PROCESS | 6436 | 19:15:43 INFO - PROCESS | 6436 | Cycle 1(1): loaded http://localhost:41546/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41546/tests/dromaeo/cssquery-prototype.html) 19:15:43 INFO - PROCESS | 6436 | RSS: Main: 152805376 19:15:43 INFO - PROCESS | 6436 | 19:18:46 INFO - PROCESS | 6436 | Cycle 1(1): loaded http://localhost:41546/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41546/tests/dromaeo/cssquery-yui.html) 19:18:46 INFO - PROCESS | 6436 | RSS: Main: 153538560 19:18:46 INFO - PROCESS | 6436 | 19:21:48 INFO - PROCESS | 6436 | Cycle 1(1): loaded http://localhost:41546/tests/dromaeo/cssquery-yui.html (next: http://localhost:41546/tests/dromaeo/cssquery-dojo.html) 19:21:49 INFO - PROCESS | 6436 | RSS: Main: 155619328 19:21:49 INFO - PROCESS | 6436 | 19:21:49 INFO - PROCESS | 6436 | __start_tp_report 19:21:49 INFO - PROCESS | 6436 | _x_x_mozilla_page_load 19:21:49 INFO - PROCESS | 6436 | _x_x_mozilla_page_load_details 19:21:49 INFO - PROCESS | 6436 | |i|pagename|runs| 19:21:49 INFO - PROCESS | 6436 | |0;dojo.html;3300.108970577944;3362.7646064775477;3378.4425569780988;3394.3211357728446;3408.028711817131;5433.945660543398;5440.483154100359;5447.400785913546;5448.564114870811;5464.617476776627;5435.266239057726;5453.427390124039;5499.532539734118;5501.944980550194;5507.118860982244;4951.752412379385;5011;5069.797208111671;5072;5080.466551012146;4961.578265847407;5009.949900501003;5021.422536408305;5080.64435489514;5101.362329708786;5000.374953130859;5056.216286475602;5056.418511871145;5057.064443078024;5060.316857224265;4909.386326709161;5001.524855138756;5063.265826455144;5068.113080210948;5079.847604571869;4922.852314430573;4930.457649658535;4940.456549779521;4960.454350021495;4993.076280888047;5210.687358758487;5231.084560201949;5233.21501774733;5261.552768014723;5262.789488420497;5746.224259724967;5758.510526605201;5768.711564421762;5787.218725472091;5882.29412470502;5770.538356931477;5794.739236734357;5841.47426731592;5884.323302820145;5910.881782364371;5510.559155267569;5516.641418307797;5523.337199536081;5535.391106978229;5556.6943818089985;6020.337762846083;6028.939710602838;6039.78860739872;6044.788432404933;6070.817875463743;5700.686462244616;5703.230063941398;5746.9712651436475;5761.107028410603;5790.305163380337;5838.824835254949;5841.474267315962;5849.151872978395;5850.2102216200265;5857.941420585825;5701.344345400249;5802.361740208574;5814.563907706939;5825.1844741736195;5838.7080645967535;5739.62692424991;5833.854153646193;5842.970785146047;5847.181394604759;5864.149698293723;4371.519132895379;4415.2935530315;4438.423005009393;4444.333349997526;4455.866324010285;3936.8031598419966;4012.7592344459426;4030.375291829771;4038.495188101487;4047.0489434982755;5559.777608895599;5585.413531579207;5614.905093506727;5624.465675760796;5625.099984002622;5782.421757824184;5828.038373668297;5828.038373668297;5854.560907931922;5878.794242201502;5503.2020357048;5592.189132575753;5598.272224610856;5619.494245517842;5619.7471113799975;4935.654504184745;4976.975115124401;4996.250562415594;4997.700137991732;5005.649604527721;6022.5784195105925;6027.095935609694;6029.366916473795;6034.849128771728;6053.122297266872;5857.092150716646;5868.061110222344;5877.647341159544;5929.822105336847;5963.344032156372;6001.609895356788;6015.548833837567;6053.545984051302;6054.788082417094;6082.057281121433;5767.480926716616;5768.625039372428;5774.82675519735;5782.624129431573;5796.391378905154;5792.21805056312;5798.82603521895;5865.677387743715;5874.06015037609;5884.47039766423;5674.914876276942;5681.517071049007;5690.3456102548735;5710.02929501994;5734.684592347294;5645.209670646195;5690.687012214368;5707.514861236841;5713.542916566747;5736.168255602831;5671.43285671446;5731.484166425042;5733.971330143323;5765.164051212634;5767.452092051249;5642.097264437671;5715.085586306337;5732.71336433185;5788.421157884178;5803.187553742395;5582.330120385417;5621.662700237835;5628.0432326505415;5647.040003199548;5652.773889044557 19:21:49 INFO - PROCESS | 6436 | |1;ext.html;537.6532136771782;541.8347404041771;542.671683631403;566.0885973582533;576.901926672466;31079.223019424524;37720.43419348708;38615;38782.224355512946;38853.611463885354;41628;42012.78993605028;42062.579374206245;42111.36832947508;42448.151036979245;8761.7809554761;8999.955000224989;9000.504972226525;9006.369554131214;9006.459612423276;8742.475451472932;8808.559572021373;8874.689385871496;8890.555472226395;8909.465432074096;8756.649734010633;8912.24245939096;8920.063393343671;8939.061398553124;8970.820583588324;8784.692535761249;8846.203841654282;8850.026497085315;8882.333824963122;8884.15600517953;8744.256738177262;8843.955780221122;8852.291816654651;8914.50970196639;9184.678536251198;41782.58217417818;42184;42301;42467;42475.787621061696;3636.5090712753968;3698.907527311812;3761.1725420407465;3800.619938006205;3858.9421158682644;31804.204894877814;31994;32425;32573.348533029206;32774.50838237428;4166.229247589175;4166.270902592065;4201.117765269297;4221.746485620635;4238.830446782156;294846;295153;296508;297231;299030;44444;45421;45549.7722511392;60802.783944320865;61209.38790612126;43294.56705432968;43375;43409.34885976713;43648.56351436509;43712.3443148353;14486.275686215648;14496.420143194155;14625.78061329081;14658.267086645625;14727.92636036813;11895.821562676567;11977.101717371232;11993.460294286779;12004.099692523096;12020.879791202151;15306.158161301235;15407.383704651913;15441.613959650875;15489.767653485207;15591;6006.789762358297;6007.729652165663;6106.145139680449;6126.632402055891;6134.202553667995;1073.1039581949003;1079.888817362071;1134.886511348875;1153.5501154549731;1164.1559869095008;29779.404411912074;30311.696883031327;30325;30374.240643984078;30437;1134.3420815926743;1186.5431808753692;1222.5965431407615;1228.2109691601331;1250.2810883741704;15419.92290038565;15534.844651553565;15761.29074191664;15930.123843188736;16025.919870400574;334359;749238;760375;767375;769866;59625.40374596199;60278.397216028156;60426.69786651039;60695.393046069854;60757.392426076054;1486.420296084528;1490.4857824050684;1504.74419348711;1509.6527798606162;1514.4169494744604;30904;31345.8432707835;31440.842795785873;31709;31956.840215798773;48864.511354885995;53099.20351194812;54136.729316353165;54384.18423723726;54611.45388546223;311887;314455;317918;318411;318812;45645.77177114226;45824;45918.31122533231;46154.07691846077;46990.29514557216;49472.75263623659;50035;50351.24473132833;50521.24218136804;51289.23066153936;41841.58158418377;42022.1595568093;42248;42383.36424953566;43781.56218437902;41749.37375939303;41983;42302.788486058605;42548.78725606352;42687;36452.45321320235;41156;41718;44458.55541444544;46331.30503042525;37096.44355334618;38268;39478.60521394749;39707.80146099251;40310;26116.216513504627;26642.20073397801;26944.730552694222;27225.31936701598;27235.86382068077 19:21:49 INFO - PROCESS | 6436 | |2;jquery.html;360.5709206044807;362.8639260277396;367.1665319724226;367.9374506333925;375.42934739196437;17137;17900.37348692796;19413.805861941375;19465.610687786237;19501.609967800636;18191.181396837143;18418.815811841876;18507.81492185078;18671.06644667768;18702.438926832216;5544.22380866679;5780.132980052984;5810.186573879639;5824.708764561776;5829.679367634779;4288.635465985395;5637.971810140964;5944.643321400708;6119.173911521954;6153.538484613649;6029.427204415573;6071.848203794896;6083.78706745264;6125.356837532039;6139.263288405397;5830.125481177836;6248.218972628421;6250.937490625081;6275.02737075754;6294.685265736694;5514.145307477347;5538.6122971392015;5546.972265138689;5570.470805273492;5597.468240517144;11818.468168932333;12257.203281786655;12328.75342493145;12329.75340493194;12340.074494412866;2275.2377953385635;2364.337985364101;2496.3509487533192;2582.1866112174794;2628.0212516524866;10431.321964072387;10435.791284174275;10464.63373781914;11266.774664506664;13615.387307571184;1845.6124213915093;1903.5050886769402;1947.4255094747084;1948.6687263165154;1996.5008747813047;62981.37018629847;66031.66984165048;66098.3390166097;67717;68488.31511684919;10062.597496100074;10221.897781022095;10274.434906080238;10327.431991240404;10458.790824183474;13917.373718182705;13948.930255348658;13967.580972570839;14014.089084209494;14081.225532595805;7767.961160194162;7779.805504862424;7904.56524891125;7920.881186782203;7978.6409611567615;7487;7580.279873412017;7628.084629844454;7652.885206721904;7656.923430765621;4501.842435514741;4533.274676051816;4539.818407263739;4548.522405147478;4668.533146685372;1730.3424698614447;1767.7525146479504;1773.645270945816;1798.192816219691;1832.2304632054302;949.928755343352;967.4147140979605;982.1308142294121;987.8962708915604;1073.672529878379;17260;17737.492313153525;17742.91128544349;17965.550861228574;18326.26694932188;1025.9794804103876;1038.2732087538752;1041.401194313273;1044.9059584637419;1080.065743132185;9910.504474776233;10145.188384929188;10206.38761674287;10243.231757618209;10395.532201050972;428352;429318;438653;445293;450667;76515.2348476508;78875.60562197152;79256.20743792603;79316.60341698254;80344;1039.2309690828731;1053.9894601054045;1068.7167900506372;1086.2884810449168;1109.1348747976592;15281.770773438186;15969.007648753168;16041.27814248385;16046.11746353915;16100.597485062499;34694.65305346914;35182.999999998974;35199.47200792041;35229.11927201738;36096.4585531212;50595.49404505908;51049;51388.48611513837;51669;52216.73891630518;8471.32229421657;8479.872801907853;8575.099614540384;8589.914100858912;8618.310535157047;9663;12224;13121.606351809462;13503.932480337535;13677.726445471233;11253.381064041556;11513.59702410445;11552.133589980616;11988.700282492659;12082.154249202824;11573.826392603949;11769;11934.462949167482;12035.819462707892;12100.152989291017;11726.179167458196;11888.227265227733;12094.75810483803;12117.09121815885;12258.570950016707;8410.243078122998;8457.238848503664;8497.532635705096;8546.615402306787;8605.95697021511;11007.394593297446;11727.061835053346;11896.955035288043;12142.939285303517;12441.75116497647 19:21:49 INFO - PROCESS | 6436 | |3;mootools.html;1572.6933248016637;1602.5592961935465;1855.2393518657352;1905.714142878569;1958.383109320563;7167.4982751207435;7733.574653394061;8011.679532818687;8207.630656620451;8208.302294304984;7937.404694647896;8048.114707382198;8119.797005074876;8137.633806478708;8148.10370859205;2364.858108513486;2407.41018450479;2419.6491508731224;2423.466837295792;2425.1875621666763;2346.9530609387803;2408.8675122868235;2438.5366780311683;2448.7061552613714;2464.4578192797558;2396.1373905394044;2402.4834660547976;2408.301592538162;2441.5116976604663;2442.7190873049562;2359.2214569192124;2362.83460157789;2378.2984019714054;2379.8572085674914;2415.178839194682;2390.665306857024;2409.8554086754853;2410.2166795791436;2424.7817696407233;2436.2447641231097;8223.95888020562;8269.421140520166;8270.8345833083;8279.254867061993;8302.045264794566;5058.2412638104215;5148.124818780816;5152.175651895716;5168.586513078944;5174.896502069938;3152.936941261185;3224.0972527692047;3247.318063206729;3288.2108294009504;3292.6378098409155;1018.5569277364297;1022.3661329975389;1052.3790963331594;1063.6968463987803;1081.9513121909533;11198.440077996149;11199.552017919274;11201.383923884183;11223.719407014809;11231.10151187903;4282.164977829356;4395.230834603932;4463.107378524308;4489.708168969007;4495.145922274757;9663.758406039764;9753.609855605839;9782;9813.460259685644;9822.214222862296;5143.408508021551;5175.715335656575;5181.35233095863;5185.559227465632;5190.896182076337;4138.613564455881;4595.1039547287955;4637.698549594265;4667.696599721007;4696.389469369028;3716.5168528091176;3769.8869033929027;3771.321162190832;3794.829232684536;3841.8463261469788;1206.5053328135423;1212.7210741529498;1225.2648410953357;1233.5744168261936;1255.7881644213196;1416.773316269392;1419.991805817881;1422.7154569086224;1433.9498117566043;1467.3030310602378;7565.319121279112;7612.048493938258;7640.121386040565;7642.847143057108;7652.885206721904;472.4425178289651;474.25305144397714;474.40462219913786;478.64580210643874;489.63032910153316;6037.63774173551;6060.121282414026;6086.756529738849;6089.634621922699;6106.4809491192855;9277.67528136512;9984.650537231162;10100.292979491513;10103.494825258707;10146.746331341776;9839;9898.554565044591;9901.504924753734;9978.201743860474;10027.548760305805;7421.851562968711;7569.280918312751;7660.5020673657145;7661.387089032864;7702.768916932501;7521.5111017783665;7573.9242607573215;7628.199039100815;7628.504147230412;7641.808954776175;8866.911330886609;8928.285737140883;8953.641854325753;9094.408863423856;9206.953965230132;9087.954560227157;9129.680461183827;9242.306826988137;9280.303977201602;9377.765555861159;6207.348228435949;6630.966845165936;6782.93217067823;6818.147731533559;6939.306069393222;7573.583452910143;7585.241475852371;7604.163542010485;7604.2395760423515;7693.038370203724;6956.478264130109;7134.1795693495915;7170.318819712119;7203.783886483414;7301;6768.424683901923;6887.242403335729;6915.031895534528;6969.128858892638;7026.508144430045;7211.60336181494;7275.236100209613;7287.526310789782;7308.5614863108385;7328.157261914735;6838.692258848264;6865.588064716133;6872.209695885037;6879.58722476653;6880.58716477013;6964.164300283998;6991.685374158277;6994.895076573754;7035.542689725152;7075.858482830417 19:21:49 INFO - PROCESS | 6436 | |4;prototype.html;359.09149850877276;363.3459772409662;363.4530032301386;365.95425571803526;378.73110091834815;6343.873122537547;6374.904376434357;6404.871902561946;6414.775482858095;6420.903686444707;6238.721062182253;6353.30113687494;6357.11000459936;6365.681715914209;6368.6178829270275;4679.719216846983;4708.74101924394;4714.245720684691;4801.831935882245;4895.902081958358;4807.783649735753;4810.35060266863;4811.951880481185;4813.061453016663;4822.517748225185;4729.739864307462;4768.189407800683;4773.307870358796;4780.545848144421;4782.784774685148;4729.668923175362;4766.547178018082;4783.4977327380475;4787.257975013861;4787.329773831666;4134.586541345841;4158.793949754568;4160.209560183555;4162.646175075122;4170.812313445902;5993.280806303228;6000.549958753068;6000.96999515004;6006.639601623873;6023.247094113236;5309.177077552986;5443.455654434564;5450.754716037748;5463.043967305705;5501.614886957915;6476.838079048014;6484;6484.481241500669;6489.643069631168;6517.055027021102;4555.476120246181;4564.178447879381;4569.109023740372;4580.908381832378;4582.221022426195;6918.238993710688;6918.5502942308585;6930.20302665195;6939.4795390345425;6985.965070174617;4717.95282047182;4729.0541891621815;4750.192467280571;4759.595434388116;4762.64280178988;4613.192691279013;4800.903981920342;4803.5916947059195;4810.6632535722165;4815.398075240595;5543.196236545678;5545.112781954868;5551.777928882881;5572.554195664337;5584.636998595079;6668.733250669919;6701.664916754143;6713.395794378529;6716.597004179765;6728.596284222962;1671.699094163038;1678.211240716861;1683.5286119886453;1685.8735594830437;1688.6707092117165;1092.3882625729616;1112.1047556716921;1114.4539175803798;1123.8145705958589;1139.566964553481;6508.186476690414;6508.186476690414;6514.9674251629385;6518.28298887122;6542.738290468423;6879.415249703731;6905.413039891666;6921.653917304115;6934.791956241321;6936.79189624312;6244.188255526752;6314.4317011468265;6489.67551622417;6573.80278591643;6577.769778057745;3742.8877133686033;3774.981125094357;3777.6788972937607;3781.8676346327748;3787.6401741834484;7220.67506962188;7257.92742072583;7292.8906066409045;7301.2333704961275;7337.449691273176;7123.71505139799;7150.463715221379;7167.498275120795;7189.820254493575;7190.388816950618;7036.683349249296;7294.598797066106;7315.4147668186415;7318.377937875233;7329.157146928172;6988.40598549129;7010.509264351446;7012.824679383056;7014.0531028310525;7027.297270272932;6968.65156742171;6972.6862291196;6975.337342952412;6978.47661425385;6981.162260528769;7222.313880181375;7254.238304977901;7291.927080729125;7306.342429181399;7311.707531698672;4592;4734;4782.904341913073;4796.232602783677;4796.544328288807;6839.760608378683;6894.551854129466;6917.308269173243;6953.096097507291;6955.652217389212;6735.764248251484;6743.920972644353;6757.628330441873;6762.256151823394;6766.8646627068165;6682.498812588978;6699.76550820719;6735.191776986793;6755.898661519983;6771.762988295386;6524.967375163284;6557.573757705733;6618.63597502142;6643;6644;6732.394084532416;6736.4947628929;6766.763163289262;6768.390844823989;6770.559913605797;6532.216134063943;6602.7689030883685;6609.339066093545;6633.469322454289;6644.501662375244 19:21:49 INFO - PROCESS | 6436 | |5;yui.html;795.272325821873;797.178905727101;845.6406027438337;895.3642913531393;917.1791246834082;14427.422903083863;14783.482578109768;14786.630334241636;14788.408463661468;14831.332590033448;14512.201828899406;14591;14651.633709157277;14690.338934747935;14716.6320841979;924.1543987251657;927.9396839205464;936.765808547863;948.4878165790465;955.2071780422233;947.2138125355938;949.4303417949244;950.0499500499501;950.4534892436842;950.8811398575178;988.7478692933328;990.0693348252655;991.3060857399813;991.9156871665917;997.4314640654829;974.814785190815;984.6110786239431;984.8571957066221;987.4815721746069;989.0159291504926;726.96728647211;728.6720975561019;731.5281643340069;731.5391303478827;732.070270756142;13157.342132893413;13180.143290686075;13186.274754888478;13214.141080829715;13231.206127632373;13719.45122195111;13906;13912.860871391258;13968.93015534926;14079.929600351932;10511.369317840954;10573.62992295266;10598.682039538826;10666.573337066508;10705.25063245573;3786.3752480840626;3791.1280405506614;3800.90497737556;3826.827792749333;3869.671077958377;51187.74406127945;51698.483015169746;51720.22419663671;52529.47470525284;52830.47169528294;9955.25335599833;10265.846012309821;10352.120069794002;10518.73703157412;10617.575296988189;19194.712079318822;19644.410667679993;19766.110525026408;19816.504587385432;19823.30618428348;7507;7650.961745191238;7760.417968652374;7784.571848548271;7815.921840781633;4067.5322337930925;4157.397177409319;4198;4264.275073237557;4338.045629961403;3087.027586310305;3088.258817883692;3094.8916787912317;3096.303331750338;3109.4403007458873;570.2956848292356;576.0610205365311;578.2367275196784;582.1500609110661;592.7925226170892;634.8793729191439;658.5028303630728;662.456785435938;685.5989246290876;709.7551344786041;8232.711855085043;8264;8318.12659670738;8587.22714955657;8829.60266787996;605.4369436424167;663.647370073092;678.1895634716467;681.0499353401976;681.3459079283942;3586.2468881534646;3869.2068126034096;3908.6482216600643;3945.467361906106;4046.4132700758814;56343.43656563464;57423.71288143533;58130;58265.70867145637;58280.41719582835;50902.23646645303;51580.22629660558;51815.74092129515;51949.7402512985;51975;44653.77673111614;45515.54484455179;45859.85350366201;48190;48533.5146648536;8239.382046346429;8635.179657932485;8663.48019118855;8802;8803.427777194718;33454.33091338208;34414;34832.30335393328;35515.64484355227;35667.821660892565;38177;39291;42480.57519424766;42873;43541;11150.052245559218;11215.1027917768;11317.660470185907;11372.31766094037;11397.829032564352;11930;12095;12362.072844536875;12369.134160608672;12416;11033.834492482458;11125.276857004268;11412.258203216765;11498.77002459963;11854.94072529632;10480.109190718875;11859.347735874264;12089;12460.190087644274;12725.872741272839;10397.740056498647;10428.895711043097;10621.097206737513;10909.618163364245;11709.473073711873;9316.673916412892;9429.434233945985;9430.858537121812;9488.620455181992;9818;9029.909700902906;9053.637854485747;9187.724368268962;9270.44377337362;9428.575714092745 19:21:49 INFO - PROCESS | 6436 | __end_tp_report 19:21:49 INFO - PROCESS | 6436 | __start_cc_report 19:21:49 INFO - PROCESS | 6436 | _x_x_mozilla_cycle_collect,323 19:21:49 INFO - PROCESS | 6436 | __end_cc_report 19:21:49 INFO - PROCESS | 6436 | __startTimestamp1459909309031__endTimestamp 19:21:49 INFO - PROCESS | 6436 | 19:21:49 INFO - PROCESS | 6436 | ------- Summary: start ------- 19:21:49 INFO - PROCESS | 6436 | Number of tests: 6 19:21:49 INFO - PROCESS | 6436 | 19:21:49 INFO - PROCESS | 6436 | [#0] dojo.html Cycles:165 Average:5441.44 Median:5671.43 stddev:591.45 (10.4%) stddev-sans-first:568.91 19:21:49 INFO - PROCESS | 6436 | Values: 3300.1 3362.8 3378.4 3394.3 3408.0 5433.9 5440.5 5447.4 5448.6 5464.6 5435.3 5453.4 5499.5 5501.9 5507.1 4951.8 5011.0 5069.8 5072.0 5080.5 4961.6 5009.9 5021.4 5080.6 5101.4 5000.4 5056.2 5056.4 5057.1 5060.3 4909.4 5001.5 5063.3 5068.1 5079.8 4922.9 4930.5 4940.5 4960.5 4993.1 5210.7 5231.1 5233.2 5261.6 5262.8 5746.2 5758.5 5768.7 5787.2 5882.3 5770.5 5794.7 5841.5 5884.3 5910.9 5510.6 5516.6 5523.3 5535.4 5556.7 6020.3 6028.9 6039.8 6044.8 6070.8 5700.7 5703.2 5747.0 5761.1 5790.3 5838.8 5841.5 5849.2 5850.2 5857.9 5701.3 5802.4 5814.6 5825.2 5838.7 5739.6 5833.9 5843.0 5847.2 5864.1 4371.5 4415.3 4438.4 4444.3 4455.9 3936.8 4012.8 4030.4 4038.5 4047.0 5559.8 5585.4 5614.9 5624.5 5625.1 5782.4 5828.0 5828.0 5854.6 5878.8 5503.2 5592.2 5598.3 5619.5 5619.7 4935.7 4977.0 4996.3 4997.7 5005.6 6022.6 6027.1 6029.4 6034.8 6053.1 5857.1 5868.1 5877.6 5929.8 5963.3 6001.6 6015.5 6053.5 6054.8 6082.1 5767.5 5768.6 5774.8 5782.6 5796.4 5792.2 5798.8 5865.7 5874.1 5884.5 5674.9 5681.5 5690.3 5710.0 5734.7 5645.2 5690.7 5707.5 5713.5 5736.2 5671.4 5731.5 5734.0 5765.2 5767.5 5642.1 5715.1 5732.7 5788.4 5803.2 5582.3 5621.7 5628.0 5647.0 5652.8 19:21:49 INFO - PROCESS | 6436 | 19:21:49 INFO - PROCESS | 6436 | [#1] ext.html Cycles:180 Average:58954.95 Median:23092.06 stddev:127499.53 (552.1%) stddev-sans-first:127781.76 19:21:49 INFO - PROCESS | 6436 | Values: 537.7 541.8 542.7 566.1 576.9 31079.2 37720.4 38615.0 38782.2 38853.6 41628.0 42012.8 42062.6 42111.4 42448.2 8761.8 9000.0 9000.5 9006.4 9006.5 8742.5 8808.6 8874.7 8890.6 8909.5 8756.6 8912.2 8920.1 8939.1 8970.8 8784.7 8846.2 8850.0 8882.3 8884.2 8744.3 8844.0 8852.3 8914.5 9184.7 41782.6 42184.0 42301.0 42467.0 42475.8 3636.5 3698.9 3761.2 3800.6 3858.9 31804.2 31994.0 32425.0 32573.3 32774.5 4166.2 4166.3 4201.1 4221.7 4238.8 294846.0 295153.0 296508.0 297231.0 299030.0 44444.0 45421.0 45549.8 60802.8 61209.4 43294.6 43375.0 43409.3 43648.6 43712.3 14486.3 14496.4 14625.8 14658.3 14727.9 11895.8 11977.1 11993.5 12004.1 12020.9 15306.2 15407.4 15441.6 15489.8 15591.0 6006.8 6007.7 6106.1 6126.6 6134.2 1073.1 1079.9 1134.9 1153.6 1164.2 29779.4 30311.7 30325.0 30374.2 30437.0 1134.3 1186.5 1222.6 1228.2 1250.3 15419.9 15534.8 15761.3 15930.1 16025.9 334359.0 749238.0 760375.0 767375.0 769866.0 59625.4 60278.4 60426.7 60695.4 60757.4 1486.4 1490.5 1504.7 1509.7 1514.4 30904.0 31345.8 31440.8 31709.0 31956.8 48864.5 53099.2 54136.7 54384.2 54611.5 311887.0 314455.0 317918.0 318411.0 318812.0 45645.8 45824.0 45918.3 46154.1 46990.3 49472.8 50035.0 50351.2 50521.2 51289.2 41841.6 42022.2 42248.0 42383.4 43781.6 41749.4 41983.0 42302.8 42548.8 42687.0 36452.5 41156.0 41718.0 44458.6 46331.3 37096.4 38268.0 39478.6 39707.8 40310.0 26116.2 26642.2 26944.7 27225.3 27235.9 19:21:49 INFO - PROCESS | 6436 | 19:21:49 INFO - PROCESS | 6436 | [#2] jquery.html Cycles:180 Average:25967.17 Median:2430.34 stddev:72018.72 (2963.3%) stddev-sans-first:72195.08 19:21:49 INFO - PROCESS | 6436 | Values: 360.6 362.9 367.2 367.9 375.4 17137.0 17900.4 19413.8 19465.6 19501.6 18191.2 18418.8 18507.8 18671.1 18702.4 5544.2 5780.1 5810.2 5824.7 5829.7 4288.6 5638.0 5944.6 6119.2 6153.5 6029.4 6071.8 6083.8 6125.4 6139.3 5830.1 6248.2 6250.9 6275.0 6294.7 5514.1 5538.6 5547.0 5570.5 5597.5 11818.5 12257.2 12328.8 12329.8 12340.1 2275.2 2364.3 2496.4 2582.2 2628.0 10431.3 10435.8 10464.6 11266.8 13615.4 1845.6 1903.5 1947.4 1948.7 1996.5 62981.4 66031.7 66098.3 67717.0 68488.3 10062.6 10221.9 10274.4 10327.4 10458.8 13917.4 13948.9 13967.6 14014.1 14081.2 7768.0 7779.8 7904.6 7920.9 7978.6 7487.0 7580.3 7628.1 7652.9 7656.9 4501.8 4533.3 4539.8 4548.5 4668.5 1730.3 1767.8 1773.6 1798.2 1832.2 949.9 967.4 982.1 987.9 1073.7 17260.0 17737.5 17742.9 17965.6 18326.3 1026.0 1038.3 1041.4 1044.9 1080.1 9910.5 10145.2 10206.4 10243.2 10395.5 428352.0 429318.0 438653.0 445293.0 450667.0 76515.2 78875.6 79256.2 79316.6 80344.0 1039.2 1054.0 1068.7 1086.3 1109.1 15281.8 15969.0 16041.3 16046.1 16100.6 34694.7 35183.0 35199.5 35229.1 36096.5 50595.5 51049.0 51388.5 51669.0 52216.7 8471.3 8479.9 8575.1 8589.9 8618.3 9663.0 12224.0 13121.6 13503.9 13677.7 11253.4 11513.6 11552.1 11988.7 12082.2 11573.8 11769.0 11934.5 12035.8 12100.2 11726.2 11888.2 12094.8 12117.1 12258.6 8410.2 8457.2 8497.5 8546.6 8606.0 11007.4 11727.1 11897.0 12142.9 12441.8 19:21:49 INFO - PROCESS | 6436 | 19:21:49 INFO - PROCESS | 6436 | [#3] mootools.html Cycles:180 Average:5722.38 Median:6073.44 stddev:2981.47 (49.1%) stddev-sans-first:2973.52 19:21:49 INFO - PROCESS | 6436 | Values: 1572.7 1602.6 1855.2 1905.7 1958.4 7167.5 7733.6 8011.7 8207.6 8208.3 7937.4 8048.1 8119.8 8137.6 8148.1 2364.9 2407.4 2419.6 2423.5 2425.2 2347.0 2408.9 2438.5 2448.7 2464.5 2396.1 2402.5 2408.3 2441.5 2442.7 2359.2 2362.8 2378.3 2379.9 2415.2 2390.7 2409.9 2410.2 2424.8 2436.2 8224.0 8269.4 8270.8 8279.3 8302.0 5058.2 5148.1 5152.2 5168.6 5174.9 3152.9 3224.1 3247.3 3288.2 3292.6 1018.6 1022.4 1052.4 1063.7 1082.0 11198.4 11199.6 11201.4 11223.7 11231.1 4282.2 4395.2 4463.1 4489.7 4495.1 9663.8 9753.6 9782.0 9813.5 9822.2 5143.4 5175.7 5181.4 5185.6 5190.9 4138.6 4595.1 4637.7 4667.7 4696.4 3716.5 3769.9 3771.3 3794.8 3841.8 1206.5 1212.7 1225.3 1233.6 1255.8 1416.8 1420.0 1422.7 1433.9 1467.3 7565.3 7612.0 7640.1 7642.8 7652.9 472.4 474.3 474.4 478.6 489.6 6037.6 6060.1 6086.8 6089.6 6106.5 9277.7 9984.7 10100.3 10103.5 10146.7 9839.0 9898.6 9901.5 9978.2 10027.5 7421.9 7569.3 7660.5 7661.4 7702.8 7521.5 7573.9 7628.2 7628.5 7641.8 8866.9 8928.3 8953.6 9094.4 9207.0 9088.0 9129.7 9242.3 9280.3 9377.8 6207.3 6631.0 6782.9 6818.1 6939.3 7573.6 7585.2 7604.2 7604.2 7693.0 6956.5 7134.2 7170.3 7203.8 7301.0 6768.4 6887.2 6915.0 6969.1 7026.5 7211.6 7275.2 7287.5 7308.6 7328.2 6838.7 6865.6 6872.2 6879.6 6880.6 6964.2 6991.7 6994.9 7035.5 7075.9 19:21:49 INFO - PROCESS | 6436 | 19:21:49 INFO - PROCESS | 6436 | [#4] prototype.html Cycles:180 Average:5613.45 Median:6417.84 stddev:1713.41 (26.7%) stddev-sans-first:1672.21 19:21:49 INFO - PROCESS | 6436 | Values: 359.1 363.3 363.5 366.0 378.7 6343.9 6374.9 6404.9 6414.8 6420.9 6238.7 6353.3 6357.1 6365.7 6368.6 4679.7 4708.7 4714.2 4801.8 4895.9 4807.8 4810.4 4812.0 4813.1 4822.5 4729.7 4768.2 4773.3 4780.5 4782.8 4729.7 4766.5 4783.5 4787.3 4787.3 4134.6 4158.8 4160.2 4162.6 4170.8 5993.3 6000.5 6001.0 6006.6 6023.2 5309.2 5443.5 5450.8 5463.0 5501.6 6476.8 6484.0 6484.5 6489.6 6517.1 4555.5 4564.2 4569.1 4580.9 4582.2 6918.2 6918.6 6930.2 6939.5 6986.0 4718.0 4729.1 4750.2 4759.6 4762.6 4613.2 4800.9 4803.6 4810.7 4815.4 5543.2 5545.1 5551.8 5572.6 5584.6 6668.7 6701.7 6713.4 6716.6 6728.6 1671.7 1678.2 1683.5 1685.9 1688.7 1092.4 1112.1 1114.5 1123.8 1139.6 6508.2 6508.2 6515.0 6518.3 6542.7 6879.4 6905.4 6921.7 6934.8 6936.8 6244.2 6314.4 6489.7 6573.8 6577.8 3742.9 3775.0 3777.7 3781.9 3787.6 7220.7 7257.9 7292.9 7301.2 7337.4 7123.7 7150.5 7167.5 7189.8 7190.4 7036.7 7294.6 7315.4 7318.4 7329.2 6988.4 7010.5 7012.8 7014.1 7027.3 6968.7 6972.7 6975.3 6978.5 6981.2 7222.3 7254.2 7291.9 7306.3 7311.7 4592.0 4734.0 4782.9 4796.2 4796.5 6839.8 6894.6 6917.3 6953.1 6955.7 6735.8 6743.9 6757.6 6762.3 6766.9 6682.5 6699.8 6735.2 6755.9 6771.8 6525.0 6557.6 6618.6 6643.0 6644.0 6732.4 6736.5 6766.8 6768.4 6770.6 6532.2 6602.8 6609.3 6633.5 6644.5 19:21:49 INFO - PROCESS | 6436 | 19:21:49 INFO - PROCESS | 6436 | [#5] yui.html Cycles:180 Average:14012.62 Median:45687.70 stddev:16058.97 (35.1%) stddev-sans-first:16073.34 19:21:49 INFO - PROCESS | 6436 | Values: 795.3 797.2 845.6 895.4 917.2 14427.4 14783.5 14786.6 14788.4 14831.3 14512.2 14591.0 14651.6 14690.3 14716.6 924.2 927.9 936.8 948.5 955.2 947.2 949.4 950.0 950.5 950.9 988.7 990.1 991.3 991.9 997.4 974.8 984.6 984.9 987.5 989.0 727.0 728.7 731.5 731.5 732.1 13157.3 13180.1 13186.3 13214.1 13231.2 13719.5 13906.0 13912.9 13968.9 14079.9 10511.4 10573.6 10598.7 10666.6 10705.3 3786.4 3791.1 3800.9 3826.8 3869.7 51187.7 51698.5 51720.2 52529.5 52830.5 9955.3 10265.8 10352.1 10518.7 10617.6 19194.7 19644.4 19766.1 19816.5 19823.3 7507.0 7651.0 7760.4 7784.6 7815.9 4067.5 4157.4 4198.0 4264.3 4338.0 3087.0 3088.3 3094.9 3096.3 3109.4 570.3 576.1 578.2 582.2 592.8 634.9 658.5 662.5 685.6 709.8 8232.7 8264.0 8318.1 8587.2 8829.6 605.4 663.6 678.2 681.0 681.3 3586.2 3869.2 3908.6 3945.5 4046.4 56343.4 57423.7 58130.0 58265.7 58280.4 50902.2 51580.2 51815.7 51949.7 51975.0 44653.8 45515.5 45859.9 48190.0 48533.5 8239.4 8635.2 8663.5 8802.0 8803.4 33454.3 34414.0 34832.3 35515.6 35667.8 38177.0 39291.0 42480.6 42873.0 43541.0 11150.1 11215.1 11317.7 11372.3 11397.8 11930.0 12095.0 12362.1 12369.1 12416.0 11033.8 11125.3 11412.3 11498.8 11854.9 10480.1 11859.3 12089.0 12460.2 12725.9 10397.7 10428.9 10621.1 10909.6 11709.5 9316.7 9429.4 9430.9 9488.6 9818.0 9029.9 9053.6 9187.7 9270.4 9428.6 19:21:49 INFO - PROCESS | 6436 | -------- Summary: end -------- 19:21:49 INFO - PROCESS | 6436 | 19:21:49 INFO - TEST-INFO | 6436: exit 0 19:21:49 INFO - TEST-OK | dromaeo_css | took 1110172ms 19:21:49 INFO - TEST-START | kraken 19:21:49 INFO - operating with platform_type : linux_ 19:21:49 INFO - Initialising browser for kraken test... 19:21:49 INFO - TEST-INFO | started process 6684 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyQ6DXB/profile http://localhost:41546/getInfo.html) 19:21:53 INFO - PROCESS | 6684 | 19:21:53 INFO - PROCESS | 6684 | (process:6761): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:21:54 INFO - PROCESS | 6684 | __metrics Screen width/height:1600/1200 19:21:54 INFO - PROCESS | 6684 | colorDepth:24 19:21:54 INFO - PROCESS | 6684 | Browser inner width/height: 1024/697 19:21:54 INFO - PROCESS | 6684 | __metrics 19:21:55 ERROR - PROCESS | 6684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:21:55 INFO - TEST-INFO | 6684: exit 0 19:21:55 INFO - Browser initialized. 19:21:55 INFO - Running cycle 1/1 for kraken test... 19:21:55 INFO - TEST-INFO | started process 6812 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyQ6DXB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:21:57 INFO - PROCESS | 6812 | 19:21:57 INFO - PROCESS | 6812 | (process:6880): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:22:07 INFO - PROCESS | 6812 | RSS: Main: 150773760 19:22:07 INFO - PROCESS | 6812 | 19:22:10 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41546/tests/kraken/driver.html?testName=audio-beat-detection) 19:22:10 INFO - PROCESS | 6812 | RSS: Main: 156020736 19:22:10 INFO - PROCESS | 6812 | 19:22:13 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41546/tests/kraken/driver.html?testName=audio-dft) 19:22:14 INFO - PROCESS | 6812 | RSS: Main: 156520448 19:22:14 INFO - PROCESS | 6812 | 19:22:16 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41546/tests/kraken/driver.html?testName=audio-fft) 19:22:17 INFO - PROCESS | 6812 | RSS: Main: 156962816 19:22:17 INFO - PROCESS | 6812 | 19:22:19 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41546/tests/kraken/driver.html?testName=audio-oscillator) 19:22:20 INFO - PROCESS | 6812 | RSS: Main: 156614656 19:22:20 INFO - PROCESS | 6812 | 19:22:22 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41546/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:22:22 INFO - PROCESS | 6812 | RSS: Main: 156667904 19:22:22 INFO - PROCESS | 6812 | 19:22:26 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41546/tests/kraken/driver.html?testName=imaging-darkroom) 19:22:26 INFO - PROCESS | 6812 | RSS: Main: 156852224 19:22:26 INFO - PROCESS | 6812 | 19:22:29 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41546/tests/kraken/driver.html?testName=imaging-desaturate) 19:22:30 INFO - PROCESS | 6812 | RSS: Main: 157151232 19:22:30 INFO - PROCESS | 6812 | 19:22:33 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41546/tests/kraken/driver.html?testName=json-parse-financial) 19:22:34 INFO - PROCESS | 6812 | RSS: Main: 156696576 19:22:34 INFO - PROCESS | 6812 | 19:22:35 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41546/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:22:36 INFO - PROCESS | 6812 | RSS: Main: 156598272 19:22:36 INFO - PROCESS | 6812 | 19:22:37 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41546/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:22:38 INFO - PROCESS | 6812 | RSS: Main: 156585984 19:22:38 INFO - PROCESS | 6812 | 19:22:40 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41546/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:22:41 INFO - PROCESS | 6812 | RSS: Main: 156921856 19:22:41 INFO - PROCESS | 6812 | 19:22:43 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41546/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:22:44 INFO - PROCESS | 6812 | RSS: Main: 157245440 19:22:44 INFO - PROCESS | 6812 | 19:22:46 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41546/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:22:47 INFO - PROCESS | 6812 | RSS: Main: 157175808 19:22:47 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | Cycle 1(1): loaded http://localhost:41546/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41546/tests/kraken/driver.html?testName=ai-astar) 19:22:49 INFO - PROCESS | 6812 | RSS: Main: 158957568 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | __start_tp_report 19:22:49 INFO - PROCESS | 6812 | _x_x_mozilla_page_load 19:22:49 INFO - PROCESS | 6812 | _x_x_mozilla_page_load_details 19:22:49 INFO - PROCESS | 6812 | |i|pagename|runs| 19:22:49 INFO - PROCESS | 6812 | |0;ai-astar;111;104;111;109;110;121;110;112;110;111 19:22:49 INFO - PROCESS | 6812 | |1;audio-beat-detection;170;127;149;167;129;151;158;128;182;131 19:22:49 INFO - PROCESS | 6812 | |2;audio-dft;164;162;163;161;163;162;164;163;165;161 19:22:49 INFO - PROCESS | 6812 | |3;audio-fft;74;73;76;164;77;77;75;77;156;76 19:22:49 INFO - PROCESS | 6812 | |4;audio-oscillator;93;93;140;94;92;93;145;93;93;151 19:22:49 INFO - PROCESS | 6812 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;118;117 19:22:49 INFO - PROCESS | 6812 | |6;imaging-darkroom;147;147;148;146;147;148;147;148;148;147 19:22:49 INFO - PROCESS | 6812 | |7;imaging-desaturate;96;96;96;96;97;96;97;97;96;96 19:22:49 INFO - PROCESS | 6812 | |8;json-parse-financial;54;57;60;55;56;60;55;63;54;57 19:22:49 INFO - PROCESS | 6812 | |9;json-stringify-tinderbox;63;63;63;64;64;65;65;64;65;64 19:22:49 INFO - PROCESS | 6812 | |10;stanford-crypto-aes;79;79;81;81;80;80;79;80;80;78 19:22:49 INFO - PROCESS | 6812 | |11;stanford-crypto-ccm;114;122;127;125;119;120;116;120;121;116 19:22:49 INFO - PROCESS | 6812 | |12;stanford-crypto-pbkdf2;141;146;139;144;148;146;147;141;145;146 19:22:49 INFO - PROCESS | 6812 | |13;stanford-crypto-sha256-iterative;67;67;67;68;68;67;68;72;68;67 19:22:49 INFO - PROCESS | 6812 | __end_tp_report 19:22:49 INFO - PROCESS | 6812 | __start_cc_report 19:22:49 INFO - PROCESS | 6812 | _x_x_mozilla_cycle_collect,855 19:22:49 INFO - PROCESS | 6812 | __end_cc_report 19:22:49 INFO - PROCESS | 6812 | __startTimestamp1459909369333__endTimestamp 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | ------- Summary: start ------- 19:22:49 INFO - PROCESS | 6812 | Number of tests: 14 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:4.18 (3.8%) stddev-sans-first:4.43 19:22:49 INFO - PROCESS | 6812 | Values: 111.0 104.0 111.0 109.0 110.0 121.0 110.0 112.0 110.0 111.0 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:154.50 stddev:19.97 (12.9%) stddev-sans-first:19.71 19:22:49 INFO - PROCESS | 6812 | Values: 170.0 127.0 149.0 167.0 129.0 151.0 158.0 128.0 182.0 131.0 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.32 (0.8%) stddev-sans-first:1.32 19:22:49 INFO - PROCESS | 6812 | Values: 164.0 162.0 163.0 161.0 163.0 162.0 164.0 163.0 165.0 161.0 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#3] audio-fft Cycles:10 Average:92.50 Median:76.00 stddev:35.65 (46.9%) stddev-sans-first:37.18 19:22:49 INFO - PROCESS | 6812 | Values: 74.0 73.0 76.0 164.0 77.0 77.0 75.0 77.0 156.0 76.0 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.00 stddev:25.42 (27.3%) stddev-sans-first:26.32 19:22:49 INFO - PROCESS | 6812 | Values: 93.0 93.0 140.0 94.0 92.0 93.0 145.0 93.0 93.0 151.0 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:22:49 INFO - PROCESS | 6812 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 19:22:49 INFO - PROCESS | 6812 | Values: 147.0 147.0 148.0 146.0 147.0 148.0 147.0 148.0 148.0 147.0 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:22:49 INFO - PROCESS | 6812 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 97.0 97.0 96.0 96.0 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:3.00 (5.3%) stddev-sans-first:2.96 19:22:49 INFO - PROCESS | 6812 | Values: 54.0 57.0 60.0 55.0 56.0 60.0 55.0 63.0 54.0 57.0 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 19:22:49 INFO - PROCESS | 6812 | Values: 63.0 63.0 63.0 64.0 64.0 65.0 65.0 64.0 65.0 64.0 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:0.95 (1.2%) stddev-sans-first:0.97 19:22:49 INFO - PROCESS | 6812 | Values: 79.0 79.0 81.0 81.0 80.0 80.0 79.0 80.0 80.0 78.0 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:120.50 stddev:4.06 (3.4%) stddev-sans-first:3.67 19:22:49 INFO - PROCESS | 6812 | Values: 114.0 122.0 127.0 125.0 119.0 120.0 116.0 120.0 121.0 116.0 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:146.00 stddev:2.98 (2.0%) stddev-sans-first:2.92 19:22:49 INFO - PROCESS | 6812 | Values: 141.0 146.0 139.0 144.0 148.0 146.0 147.0 141.0 145.0 146.0 19:22:49 INFO - PROCESS | 6812 | 19:22:49 INFO - PROCESS | 6812 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.52 (2.2%) stddev-sans-first:1.58 19:22:49 INFO - PROCESS | 6812 | Values: 67.0 67.0 67.0 68.0 68.0 67.0 68.0 72.0 68.0 67.0 19:22:49 INFO - PROCESS | 6812 | -------- Summary: end -------- 19:22:49 INFO - PROCESS | 6812 | 19:22:50 INFO - TEST-INFO | 6812: exit 0 19:22:50 INFO - TEST-OK | kraken | took 60474ms 19:22:50 INFO - SUITE-END | took 1170s 19:22:50 INFO - Completed test suite (00:19:30) 19:22:50 INFO - javascript benchmark 19:22:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3300.108970577944, 3362.7646064775477, 3378.4425569780988, 3394.3211357728446, 3408.028711817131, 5433.945660543398, 5440.483154100359, 5447.400785913546, 5448.564114870811, 5464.617476776627, 5435.266239057726, 5453.427390124039, 5499.532539734118, 5501.944980550194, 5507.118860982244, 4951.752412379385, 5011.0, 5069.797208111671, 5072.0, 5080.466551012146, 4961.578265847407, 5009.949900501003, 5021.422536408305, 5080.64435489514, 5101.362329708786, 5000.374953130859, 5056.216286475602, 5056.418511871145, 5057.064443078024, 5060.316857224265, 4909.386326709161, 5001.524855138756, 5063.265826455144, 5068.113080210948, 5079.847604571869, 4922.852314430573, 4930.457649658535, 4940.456549779521, 4960.454350021495, 4993.076280888047, 5210.687358758487, 5231.084560201949, 5233.21501774733, 5261.552768014723, 5262.789488420497, 5746.224259724967, 5758.510526605201, 5768.711564421762, 5787.218725472091, 5882.29412470502, 5770.538356931477, 5794.739236734357, 5841.47426731592, 5884.323302820145, 5910.881782364371, 5510.559155267569, 5516.641418307797, 5523.337199536081, 5535.391106978229, 5556.6943818089985, 6020.337762846083, 6028.939710602838, 6039.78860739872, 6044.788432404933, 6070.817875463743, 5700.686462244616, 5703.230063941398, 5746.9712651436475, 5761.107028410603, 5790.305163380337, 5838.824835254949, 5841.474267315962, 5849.151872978395, 5850.2102216200265, 5857.941420585825, 5701.344345400249, 5802.361740208574, 5814.563907706939, 5825.1844741736195, 5838.7080645967535, 5739.62692424991, 5833.854153646193, 5842.970785146047, 5847.181394604759, 5864.149698293723, 4371.519132895379, 4415.2935530315, 4438.423005009393, 4444.333349997526, 4455.866324010285, 3936.8031598419966, 4012.7592344459426, 4030.375291829771, 4038.495188101487, 4047.0489434982755, 5559.777608895599, 5585.413531579207, 5614.905093506727, 5624.465675760796, 5625.099984002622, 5782.421757824184, 5828.038373668297, 5828.038373668297, 5854.560907931922, 5878.794242201502, 5503.2020357048, 5592.189132575753, 5598.272224610856, 5619.494245517842, 5619.7471113799975, 4935.654504184745, 4976.975115124401, 4996.250562415594, 4997.700137991732, 5005.649604527721, 6022.5784195105925, 6027.095935609694, 6029.366916473795, 6034.849128771728, 6053.122297266872, 5857.092150716646, 5868.061110222344, 5877.647341159544, 5929.822105336847, 5963.344032156372, 6001.609895356788, 6015.548833837567, 6053.545984051302, 6054.788082417094, 6082.057281121433, 5767.480926716616, 5768.625039372428, 5774.82675519735, 5782.624129431573, 5796.391378905154, 5792.21805056312, 5798.82603521895, 5865.677387743715, 5874.06015037609, 5884.47039766423, 5674.914876276942, 5681.517071049007, 5690.3456102548735, 5710.02929501994, 5734.684592347294, 5645.209670646195, 5690.687012214368, 5707.514861236841, 5713.542916566747, 5736.168255602831, 5671.43285671446, 5731.484166425042, 5733.971330143323, 5765.164051212634, 5767.452092051249, 5642.097264437671, 5715.085586306337, 5732.71336433185, 5788.421157884178, 5803.187553742395, 5582.330120385417, 5621.662700237835, 5628.0432326505415, 5647.040003199548, 5652.773889044557], "unit": "score", "name": "dojo.html", "value": 5404.028781945187}, {"lowerIsBetter": false, "replicates": [537.6532136771782, 541.8347404041771, 542.671683631403, 566.0885973582533, 576.901926672466, 31079.223019424524, 37720.43419348708, 38615.0, 38782.224355512946, 38853.611463885354, 41628.0, 42012.78993605028, 42062.579374206245, 42111.36832947508, 42448.151036979245, 8761.7809554761, 8999.955000224989, 9000.504972226525, 9006.369554131214, 9006.459612423276, 8742.475451472932, 8808.559572021373, 8874.689385871496, 8890.555472226395, 8909.465432074096, 8756.649734010633, 8912.24245939096, 8920.063393343671, 8939.061398553124, 8970.820583588324, 8784.692535761249, 8846.203841654282, 8850.026497085315, 8882.333824963122, 8884.15600517953, 8744.256738177262, 8843.955780221122, 8852.291816654651, 8914.50970196639, 9184.678536251198, 41782.58217417818, 42184.0, 42301.0, 42467.0, 42475.787621061696, 3636.5090712753968, 3698.907527311812, 3761.1725420407465, 3800.619938006205, 3858.9421158682644, 31804.204894877814, 31994.0, 32425.0, 32573.348533029206, 32774.50838237428, 4166.229247589175, 4166.270902592065, 4201.117765269297, 4221.746485620635, 4238.830446782156, 294846.0, 295153.0, 296508.0, 297231.0, 299030.0, 44444.0, 45421.0, 45549.7722511392, 60802.783944320865, 61209.38790612126, 43294.56705432968, 43375.0, 43409.34885976713, 43648.56351436509, 43712.3443148353, 14486.275686215648, 14496.420143194155, 14625.78061329081, 14658.267086645625, 14727.92636036813, 11895.821562676567, 11977.101717371232, 11993.460294286779, 12004.099692523096, 12020.879791202151, 15306.158161301235, 15407.383704651913, 15441.613959650875, 15489.767653485207, 15591.0, 6006.789762358297, 6007.729652165663, 6106.145139680449, 6126.632402055891, 6134.202553667995, 1073.1039581949003, 1079.888817362071, 1134.886511348875, 1153.5501154549731, 1164.1559869095008, 29779.404411912074, 30311.696883031327, 30325.0, 30374.240643984078, 30437.0, 1134.3420815926743, 1186.5431808753692, 1222.5965431407615, 1228.2109691601331, 1250.2810883741704, 15419.92290038565, 15534.844651553565, 15761.29074191664, 15930.123843188736, 16025.919870400574, 334359.0, 749238.0, 760375.0, 767375.0, 769866.0, 59625.40374596199, 60278.397216028156, 60426.69786651039, 60695.393046069854, 60757.392426076054, 1486.420296084528, 1490.4857824050684, 1504.74419348711, 1509.6527798606162, 1514.4169494744604, 30904.0, 31345.8432707835, 31440.842795785873, 31709.0, 31956.840215798773, 48864.511354885995, 53099.20351194812, 54136.729316353165, 54384.18423723726, 54611.45388546223, 311887.0, 314455.0, 317918.0, 318411.0, 318812.0, 45645.77177114226, 45824.0, 45918.31122533231, 46154.07691846077, 46990.29514557216, 49472.75263623659, 50035.0, 50351.24473132833, 50521.24218136804, 51289.23066153936, 41841.58158418377, 42022.1595568093, 42248.0, 42383.36424953566, 43781.56218437902, 41749.37375939303, 41983.0, 42302.788486058605, 42548.78725606352, 42687.0, 36452.45321320235, 41156.0, 41718.0, 44458.55541444544, 46331.30503042525, 37096.44355334618, 38268.0, 39478.60521394749, 39707.80146099251, 40310.0, 26116.216513504627, 26642.20073397801, 26944.730552694222, 27225.31936701598, 27235.86382068077], "unit": "score", "name": "ext.html", "value": 19738.540913414974}, {"lowerIsBetter": false, "replicates": [360.5709206044807, 362.8639260277396, 367.1665319724226, 367.9374506333925, 375.42934739196437, 17137.0, 17900.37348692796, 19413.805861941375, 19465.610687786237, 19501.609967800636, 18191.181396837143, 18418.815811841876, 18507.81492185078, 18671.06644667768, 18702.438926832216, 5544.22380866679, 5780.132980052984, 5810.186573879639, 5824.708764561776, 5829.679367634779, 4288.635465985395, 5637.971810140964, 5944.643321400708, 6119.173911521954, 6153.538484613649, 6029.427204415573, 6071.848203794896, 6083.78706745264, 6125.356837532039, 6139.263288405397, 5830.125481177836, 6248.218972628421, 6250.937490625081, 6275.02737075754, 6294.685265736694, 5514.145307477347, 5538.6122971392015, 5546.972265138689, 5570.470805273492, 5597.468240517144, 11818.468168932333, 12257.203281786655, 12328.75342493145, 12329.75340493194, 12340.074494412866, 2275.2377953385635, 2364.337985364101, 2496.3509487533192, 2582.1866112174794, 2628.0212516524866, 10431.321964072387, 10435.791284174275, 10464.63373781914, 11266.774664506664, 13615.387307571184, 1845.6124213915093, 1903.5050886769402, 1947.4255094747084, 1948.6687263165154, 1996.5008747813047, 62981.37018629847, 66031.66984165048, 66098.3390166097, 67717.0, 68488.31511684919, 10062.597496100074, 10221.897781022095, 10274.434906080238, 10327.431991240404, 10458.790824183474, 13917.373718182705, 13948.930255348658, 13967.580972570839, 14014.089084209494, 14081.225532595805, 7767.961160194162, 7779.805504862424, 7904.56524891125, 7920.881186782203, 7978.6409611567615, 7487.0, 7580.279873412017, 7628.084629844454, 7652.885206721904, 7656.923430765621, 4501.842435514741, 4533.274676051816, 4539.818407263739, 4548.522405147478, 4668.533146685372, 1730.3424698614447, 1767.7525146479504, 1773.645270945816, 1798.192816219691, 1832.2304632054302, 949.928755343352, 967.4147140979605, 982.1308142294121, 987.8962708915604, 1073.672529878379, 17260.0, 17737.492313153525, 17742.91128544349, 17965.550861228574, 18326.26694932188, 1025.9794804103876, 1038.2732087538752, 1041.401194313273, 1044.9059584637419, 1080.065743132185, 9910.504474776233, 10145.188384929188, 10206.38761674287, 10243.231757618209, 10395.532201050972, 428352.0, 429318.0, 438653.0, 445293.0, 450667.0, 76515.2348476508, 78875.60562197152, 79256.20743792603, 79316.60341698254, 80344.0, 1039.2309690828731, 1053.9894601054045, 1068.7167900506372, 1086.2884810449168, 1109.1348747976592, 15281.770773438186, 15969.007648753168, 16041.27814248385, 16046.11746353915, 16100.597485062499, 34694.65305346914, 35182.999999998974, 35199.47200792041, 35229.11927201738, 36096.4585531212, 50595.49404505908, 51049.0, 51388.48611513837, 51669.0, 52216.73891630518, 8471.32229421657, 8479.872801907853, 8575.099614540384, 8589.914100858912, 8618.310535157047, 9663.0, 12224.0, 13121.606351809462, 13503.932480337535, 13677.726445471233, 11253.381064041556, 11513.59702410445, 11552.133589980616, 11988.700282492659, 12082.154249202824, 11573.826392603949, 11769.0, 11934.462949167482, 12035.819462707892, 12100.152989291017, 11726.179167458196, 11888.227265227733, 12094.75810483803, 12117.09121815885, 12258.570950016707, 8410.243078122998, 8457.238848503664, 8497.532635705096, 8546.615402306787, 8605.95697021511, 11007.394593297446, 11727.061835053346, 11896.955035288043, 12142.939285303517, 12441.75116497647], "unit": "score", "name": "jquery.html", "value": 8782.895761656384}, {"lowerIsBetter": false, "replicates": [1572.6933248016637, 1602.5592961935465, 1855.2393518657352, 1905.714142878569, 1958.383109320563, 7167.4982751207435, 7733.574653394061, 8011.679532818687, 8207.630656620451, 8208.302294304984, 7937.404694647896, 8048.114707382198, 8119.797005074876, 8137.633806478708, 8148.10370859205, 2364.858108513486, 2407.41018450479, 2419.6491508731224, 2423.466837295792, 2425.1875621666763, 2346.9530609387803, 2408.8675122868235, 2438.5366780311683, 2448.7061552613714, 2464.4578192797558, 2396.1373905394044, 2402.4834660547976, 2408.301592538162, 2441.5116976604663, 2442.7190873049562, 2359.2214569192124, 2362.83460157789, 2378.2984019714054, 2379.8572085674914, 2415.178839194682, 2390.665306857024, 2409.8554086754853, 2410.2166795791436, 2424.7817696407233, 2436.2447641231097, 8223.95888020562, 8269.421140520166, 8270.8345833083, 8279.254867061993, 8302.045264794566, 5058.2412638104215, 5148.124818780816, 5152.175651895716, 5168.586513078944, 5174.896502069938, 3152.936941261185, 3224.0972527692047, 3247.318063206729, 3288.2108294009504, 3292.6378098409155, 1018.5569277364297, 1022.3661329975389, 1052.3790963331594, 1063.6968463987803, 1081.9513121909533, 11198.440077996149, 11199.552017919274, 11201.383923884183, 11223.719407014809, 11231.10151187903, 4282.164977829356, 4395.230834603932, 4463.107378524308, 4489.708168969007, 4495.145922274757, 9663.758406039764, 9753.609855605839, 9782.0, 9813.460259685644, 9822.214222862296, 5143.408508021551, 5175.715335656575, 5181.35233095863, 5185.559227465632, 5190.896182076337, 4138.613564455881, 4595.1039547287955, 4637.698549594265, 4667.696599721007, 4696.389469369028, 3716.5168528091176, 3769.8869033929027, 3771.321162190832, 3794.829232684536, 3841.8463261469788, 1206.5053328135423, 1212.7210741529498, 1225.2648410953357, 1233.5744168261936, 1255.7881644213196, 1416.773316269392, 1419.991805817881, 1422.7154569086224, 1433.9498117566043, 1467.3030310602378, 7565.319121279112, 7612.048493938258, 7640.121386040565, 7642.847143057108, 7652.885206721904, 472.4425178289651, 474.25305144397714, 474.40462219913786, 478.64580210643874, 489.63032910153316, 6037.63774173551, 6060.121282414026, 6086.756529738849, 6089.634621922699, 6106.4809491192855, 9277.67528136512, 9984.650537231162, 10100.292979491513, 10103.494825258707, 10146.746331341776, 9839.0, 9898.554565044591, 9901.504924753734, 9978.201743860474, 10027.548760305805, 7421.851562968711, 7569.280918312751, 7660.5020673657145, 7661.387089032864, 7702.768916932501, 7521.5111017783665, 7573.9242607573215, 7628.199039100815, 7628.504147230412, 7641.808954776175, 8866.911330886609, 8928.285737140883, 8953.641854325753, 9094.408863423856, 9206.953965230132, 9087.954560227157, 9129.680461183827, 9242.306826988137, 9280.303977201602, 9377.765555861159, 6207.348228435949, 6630.966845165936, 6782.93217067823, 6818.147731533559, 6939.306069393222, 7573.583452910143, 7585.241475852371, 7604.163542010485, 7604.2395760423515, 7693.038370203724, 6956.478264130109, 7134.1795693495915, 7170.318819712119, 7203.783886483414, 7301.0, 6768.424683901923, 6887.242403335729, 6915.031895534528, 6969.128858892638, 7026.508144430045, 7211.60336181494, 7275.236100209613, 7287.526310789782, 7308.5614863108385, 7328.157261914735, 6838.692258848264, 6865.588064716133, 6872.209695885037, 6879.58722476653, 6880.58716477013, 6964.164300283998, 6991.685374158277, 6994.895076573754, 7035.542689725152, 7075.858482830417], "unit": "score", "name": "mootools.html", "value": 4631.716209263243}, {"lowerIsBetter": false, "replicates": [359.09149850877276, 363.3459772409662, 363.4530032301386, 365.95425571803526, 378.73110091834815, 6343.873122537547, 6374.904376434357, 6404.871902561946, 6414.775482858095, 6420.903686444707, 6238.721062182253, 6353.30113687494, 6357.11000459936, 6365.681715914209, 6368.6178829270275, 4679.719216846983, 4708.74101924394, 4714.245720684691, 4801.831935882245, 4895.902081958358, 4807.783649735753, 4810.35060266863, 4811.951880481185, 4813.061453016663, 4822.517748225185, 4729.739864307462, 4768.189407800683, 4773.307870358796, 4780.545848144421, 4782.784774685148, 4729.668923175362, 4766.547178018082, 4783.4977327380475, 4787.257975013861, 4787.329773831666, 4134.586541345841, 4158.793949754568, 4160.209560183555, 4162.646175075122, 4170.812313445902, 5993.280806303228, 6000.549958753068, 6000.96999515004, 6006.639601623873, 6023.247094113236, 5309.177077552986, 5443.455654434564, 5450.754716037748, 5463.043967305705, 5501.614886957915, 6476.838079048014, 6484.0, 6484.481241500669, 6489.643069631168, 6517.055027021102, 4555.476120246181, 4564.178447879381, 4569.109023740372, 4580.908381832378, 4582.221022426195, 6918.238993710688, 6918.5502942308585, 6930.20302665195, 6939.4795390345425, 6985.965070174617, 4717.95282047182, 4729.0541891621815, 4750.192467280571, 4759.595434388116, 4762.64280178988, 4613.192691279013, 4800.903981920342, 4803.5916947059195, 4810.6632535722165, 4815.398075240595, 5543.196236545678, 5545.112781954868, 5551.777928882881, 5572.554195664337, 5584.636998595079, 6668.733250669919, 6701.664916754143, 6713.395794378529, 6716.597004179765, 6728.596284222962, 1671.699094163038, 1678.211240716861, 1683.5286119886453, 1685.8735594830437, 1688.6707092117165, 1092.3882625729616, 1112.1047556716921, 1114.4539175803798, 1123.8145705958589, 1139.566964553481, 6508.186476690414, 6508.186476690414, 6514.9674251629385, 6518.28298887122, 6542.738290468423, 6879.415249703731, 6905.413039891666, 6921.653917304115, 6934.791956241321, 6936.79189624312, 6244.188255526752, 6314.4317011468265, 6489.67551622417, 6573.80278591643, 6577.769778057745, 3742.8877133686033, 3774.981125094357, 3777.6788972937607, 3781.8676346327748, 3787.6401741834484, 7220.67506962188, 7257.92742072583, 7292.8906066409045, 7301.2333704961275, 7337.449691273176, 7123.71505139799, 7150.463715221379, 7167.498275120795, 7189.820254493575, 7190.388816950618, 7036.683349249296, 7294.598797066106, 7315.4147668186415, 7318.377937875233, 7329.157146928172, 6988.40598549129, 7010.509264351446, 7012.824679383056, 7014.0531028310525, 7027.297270272932, 6968.65156742171, 6972.6862291196, 6975.337342952412, 6978.47661425385, 6981.162260528769, 7222.313880181375, 7254.238304977901, 7291.927080729125, 7306.342429181399, 7311.707531698672, 4592.0, 4734.0, 4782.904341913073, 4796.232602783677, 4796.544328288807, 6839.760608378683, 6894.551854129466, 6917.308269173243, 6953.096097507291, 6955.652217389212, 6735.764248251484, 6743.920972644353, 6757.628330441873, 6762.256151823394, 6766.8646627068165, 6682.498812588978, 6699.76550820719, 6735.191776986793, 6755.898661519983, 6771.762988295386, 6524.967375163284, 6557.573757705733, 6618.63597502142, 6643.0, 6644.0, 6732.394084532416, 6736.4947628929, 6766.763163289262, 6768.390844823989, 6770.559913605797, 6532.216134063943, 6602.7689030883685, 6609.339066093545, 6633.469322454289, 6644.501662375244], "unit": "score", "name": "prototype.html", "value": 5058.748206998039}, {"lowerIsBetter": false, "replicates": [795.272325821873, 797.178905727101, 845.6406027438337, 895.3642913531393, 917.1791246834082, 14427.422903083863, 14783.482578109768, 14786.630334241636, 14788.408463661468, 14831.332590033448, 14512.201828899406, 14591.0, 14651.633709157277, 14690.338934747935, 14716.6320841979, 924.1543987251657, 927.9396839205464, 936.765808547863, 948.4878165790465, 955.2071780422233, 947.2138125355938, 949.4303417949244, 950.0499500499501, 950.4534892436842, 950.8811398575178, 988.7478692933328, 990.0693348252655, 991.3060857399813, 991.9156871665917, 997.4314640654829, 974.814785190815, 984.6110786239431, 984.8571957066221, 987.4815721746069, 989.0159291504926, 726.96728647211, 728.6720975561019, 731.5281643340069, 731.5391303478827, 732.070270756142, 13157.342132893413, 13180.143290686075, 13186.274754888478, 13214.141080829715, 13231.206127632373, 13719.45122195111, 13906.0, 13912.860871391258, 13968.93015534926, 14079.929600351932, 10511.369317840954, 10573.62992295266, 10598.682039538826, 10666.573337066508, 10705.25063245573, 3786.3752480840626, 3791.1280405506614, 3800.90497737556, 3826.827792749333, 3869.671077958377, 51187.74406127945, 51698.483015169746, 51720.22419663671, 52529.47470525284, 52830.47169528294, 9955.25335599833, 10265.846012309821, 10352.120069794002, 10518.73703157412, 10617.575296988189, 19194.712079318822, 19644.410667679993, 19766.110525026408, 19816.504587385432, 19823.30618428348, 7507.0, 7650.961745191238, 7760.417968652374, 7784.571848548271, 7815.921840781633, 4067.5322337930925, 4157.397177409319, 4198.0, 4264.275073237557, 4338.045629961403, 3087.027586310305, 3088.258817883692, 3094.8916787912317, 3096.303331750338, 3109.4403007458873, 570.2956848292356, 576.0610205365311, 578.2367275196784, 582.1500609110661, 592.7925226170892, 634.8793729191439, 658.5028303630728, 662.456785435938, 685.5989246290876, 709.7551344786041, 8232.711855085043, 8264.0, 8318.12659670738, 8587.22714955657, 8829.60266787996, 605.4369436424167, 663.647370073092, 678.1895634716467, 681.0499353401976, 681.3459079283942, 3586.2468881534646, 3869.2068126034096, 3908.6482216600643, 3945.467361906106, 4046.4132700758814, 56343.43656563464, 57423.71288143533, 58130.0, 58265.70867145637, 58280.41719582835, 50902.23646645303, 51580.22629660558, 51815.74092129515, 51949.7402512985, 51975.0, 44653.77673111614, 45515.54484455179, 45859.85350366201, 48190.0, 48533.5146648536, 8239.382046346429, 8635.179657932485, 8663.48019118855, 8802.0, 8803.427777194718, 33454.33091338208, 34414.0, 34832.30335393328, 35515.64484355227, 35667.821660892565, 38177.0, 39291.0, 42480.57519424766, 42873.0, 43541.0, 11150.052245559218, 11215.1027917768, 11317.660470185907, 11372.31766094037, 11397.829032564352, 11930.0, 12095.0, 12362.072844536875, 12369.134160608672, 12416.0, 11033.834492482458, 11125.276857004268, 11412.258203216765, 11498.77002459963, 11854.94072529632, 10480.109190718875, 11859.347735874264, 12089.0, 12460.190087644274, 12725.872741272839, 10397.740056498647, 10428.895711043097, 10621.097206737513, 10909.618163364245, 11709.473073711873, 9316.673916412892, 9429.434233945985, 9430.858537121812, 9488.620455181992, 9818.0, 9029.909700902906, 9053.637854485747, 9187.724368268962, 9270.44377337362, 9428.575714092745], "unit": "score", "name": "yui.html", "value": 6545.372862906234}], "name": "dromaeo_css", "value": 7237.211384096343}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 111.0, 109.0, 110.0, 121.0, 110.0, 112.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [170.0, 127.0, 149.0, 167.0, 129.0, 151.0, 158.0, 128.0, 182.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 163.0, 161.0, 163.0, 162.0, 164.0, 163.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 76.0, 164.0, 77.0, 77.0, 75.0, 77.0, 156.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 140.0, 94.0, 92.0, 93.0, 145.0, 93.0, 93.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 146.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 60.0, 55.0, 56.0, 60.0, 55.0, 63.0, 54.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [79.0, 79.0, 81.0, 81.0, 80.0, 80.0, 79.0, 80.0, 80.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [114.0, 122.0, 127.0, 125.0, 119.0, 120.0, 116.0, 120.0, 121.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.0}, {"lowerIsBetter": true, "replicates": [141.0, 146.0, 139.0, 144.0, 148.0, 146.0, 147.0, 141.0, 145.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 68.0, 72.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1517.9}]} 19:22:50 INFO - Return code: 0 19:22:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:22:50 ERROR - # TBPL SUCCESS # 19:22:50 INFO - Running post-action listener: _resource_record_post_action 19:22:50 INFO - Running post-run listener: _resource_record_post_run 19:22:51 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 520192; Write bytes: 250720256; Read time: 264; Write time: 192512 19:22:51 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 638976; Read time: 0; Write time: 48 19:22:51 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 520192; Write bytes: 249483264; Read time: 264; Write time: 192464 19:22:51 INFO - Running post-run listener: _upload_blobber_files 19:22:51 INFO - Blob upload gear active. 19:22:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:22:51 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:22:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:22:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:22:52 INFO - (blobuploader) - INFO - Open directory for files ... 19:22:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:22:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:22:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:52 INFO - (blobuploader) - INFO - Done attempting. 19:22:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:22:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:22:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:53 INFO - (blobuploader) - INFO - Done attempting. 19:22:53 INFO - (blobuploader) - INFO - Iteration through files over. 19:22:54 INFO - Return code: 0 19:22:54 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:22:54 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:22:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a74103e24396c78d747c671f78d65fe00cf798465c1c6464c438dceacc8eb973b306208ccb0f052d9d94025b0b8899891569e7d9a39f097e4d77f12d52dd0c68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17e389d57a8992560b85f2dae3dbd2bf70b6ab502c9c3f08dee62917e0cd92a2a4fc220968479b46a21ea757969f908ae043e4e50b512ed4043734a9c30202fe"} 19:22:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:22:54 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:22:54 INFO - Contents: 19:22:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a74103e24396c78d747c671f78d65fe00cf798465c1c6464c438dceacc8eb973b306208ccb0f052d9d94025b0b8899891569e7d9a39f097e4d77f12d52dd0c68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17e389d57a8992560b85f2dae3dbd2bf70b6ab502c9c3f08dee62917e0cd92a2a4fc220968479b46a21ea757969f908ae043e4e50b512ed4043734a9c30202fe"} 19:22:54 INFO - Running post-run listener: copy_logs_to_upload_dir 19:22:54 INFO - Copying logs to upload dir... 19:22:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:22:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.923367 ========= master_lag: 4.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-05 19:22:58.243317) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 19:22:58.248498) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a74103e24396c78d747c671f78d65fe00cf798465c1c6464c438dceacc8eb973b306208ccb0f052d9d94025b0b8899891569e7d9a39f097e4d77f12d52dd0c68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17e389d57a8992560b85f2dae3dbd2bf70b6ab502c9c3f08dee62917e0cd92a2a4fc220968479b46a21ea757969f908ae043e4e50b512ed4043734a9c30202fe"} build_url:https://queue.taskcluster.net/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/QJXMvsn5T-ufUm26my8uWg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a74103e24396c78d747c671f78d65fe00cf798465c1c6464c438dceacc8eb973b306208ccb0f052d9d94025b0b8899891569e7d9a39f097e4d77f12d52dd0c68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17e389d57a8992560b85f2dae3dbd2bf70b6ab502c9c3f08dee62917e0cd92a2a4fc220968479b46a21ea757969f908ae043e4e50b512ed4043734a9c30202fe"}' ========= master_lag: 0.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 19:22:58.396785) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:22:58.397129) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459907036.109942-911017780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 19:22:58.413793) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 19:22:58.414098) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 19:22:58.414402) ========= ========= Total master_lag: 4.64 =========