builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1459209552.76 results: success (0) buildid: 20160328141409 builduid: 9e7ac608ff2544dfb9ec80eebdf6b991 revision: 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:12.758953) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:12.759422) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:12.759756) ========= 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-1459207941.965837-184654313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006444 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:12.786057) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:12.786394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:12.812731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:12.813016) ========= 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-1459207941.965837-184654313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:12.865379) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:12.865723) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:12.866098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:12.866403) ========= 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-1459207941.965837-184654313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-28 16:59:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.2M=0s 2016-03-28 16:59:13 (38.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093328 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:12.980786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:12.981142) ========= 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-1459207941.965837-184654313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022314 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:13.031540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:13.031923) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 --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 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 --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-1459207941.965837-184654313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-28 16:59:13,176 truncating revision to first 12 chars 2016-03-28 16:59:13,176 Setting DEBUG logging. 2016-03-28 16:59:13,176 attempt 1/10 2016-03-28 16:59:13,176 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8e9a6e6cbacd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-28 16:59:13,435 unpacking tar archive at: mozilla-aurora-8e9a6e6cbacd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571190 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:13.620499) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:13.620853) ========= echo 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244'] 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-1459207941.965837-184654313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 program finished with exit code 0 elapsedTime=0.004607 script_repo_revision: '8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:13.672778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:13.673119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 16:59:13.685357) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-28 16:59:13.685713) ========= /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-1459207941.965837-184654313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:59:13 INFO - MultiFileLogger online at 20160328 16:59:13 in /builds/slave/test-pgo 16:59:13 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 16:59:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:59:13 INFO - {'append_to_log': False, 16:59:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:59:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:59:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:59:13 INFO - 'branch': 'Mozilla-Aurora', 16:59:13 INFO - 'buildbot_json_path': 'buildprops.json', 16:59:13 INFO - 'config_files': ('talos/linux_config.py',), 16:59:13 INFO - 'default_actions': ('clobber', 16:59:13 INFO - 'read-buildbot-config', 16:59:13 INFO - 'download-and-extract', 16:59:13 INFO - 'populate-webroot', 16:59:13 INFO - 'create-virtualenv', 16:59:13 INFO - 'install', 16:59:13 INFO - 'run-tests'), 16:59:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:59:13 INFO - 'download_minidump_stackwalk': True, 16:59:13 INFO - 'download_symbols': 'ondemand', 16:59:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:59:13 INFO - 'tooltool.py': '/tools/tooltool.py', 16:59:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:59:13 INFO - '/tools/misc-python/virtualenv.py')}, 16:59:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:59:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:59:13 INFO - 'installer_path': 'installer.exe', 16:59:13 INFO - 'log_level': 'info', 16:59:13 INFO - 'log_name': 'talos', 16:59:13 INFO - 'log_to_console': True, 16:59:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:59:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:59:13 INFO - 'opt_config_files': (), 16:59:13 INFO - 'pip_index': False, 16:59:13 INFO - 'sps_profile': False, 16:59:13 INFO - 'sps_profile_interval': 0, 16:59:13 INFO - 'suite': 'dromaeojs-e10s', 16:59:13 INFO - 'system_bits': '32', 16:59:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:59:13 INFO - 'title': 'talos-linux64-ix-007', 16:59:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:59:13 INFO - 'use_talos_json': True, 16:59:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:59:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:59:13 INFO - 'work_dir': 'build'} 16:59:13 INFO - ##### 16:59:13 INFO - ##### Running clobber step. 16:59:13 INFO - ##### 16:59:13 INFO - Running pre-action listener: _resource_record_pre_action 16:59:13 INFO - Running main action method: clobber 16:59:13 INFO - rmtree: /builds/slave/test-pgo/build 16:59:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:59:14 INFO - Running post-action listener: _resource_record_post_action 16:59:14 INFO - ##### 16:59:14 INFO - ##### Running read-buildbot-config step. 16:59:14 INFO - ##### 16:59:14 INFO - Running pre-action listener: _resource_record_pre_action 16:59:14 INFO - Running main action method: read_buildbot_config 16:59:14 INFO - Using buildbot properties: 16:59:14 INFO - { 16:59:14 INFO - "project": "", 16:59:14 INFO - "product": "firefox", 16:59:14 INFO - "script_repo_revision": "production", 16:59:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:59:14 INFO - "repository": "", 16:59:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:59:14 INFO - "buildid": "20160328141409", 16:59:14 INFO - "pgo_build": "True", 16:59:14 INFO - "basedir": "/builds/slave/test-pgo", 16:59:14 INFO - "buildnumber": 267, 16:59:14 INFO - "slavename": "talos-linux64-ix-007", 16:59:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:59:14 INFO - "platform": "ubuntu64_hw", 16:59:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:59:14 INFO - "branch": "mozilla-aurora", 16:59:14 INFO - "repo_path": "releases/mozilla-aurora", 16:59:14 INFO - "revision": "8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244", 16:59:14 INFO - "stage_platform": "linux64-pgo", 16:59:14 INFO - "builduid": "9e7ac608ff2544dfb9ec80eebdf6b991", 16:59:14 INFO - "slavebuilddir": "test" 16:59:14 INFO - } 16:59:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 16:59:14 INFO - Running post-action listener: _resource_record_post_action 16:59:14 INFO - ##### 16:59:14 INFO - ##### Running download-and-extract step. 16:59:14 INFO - ##### 16:59:14 INFO - Running pre-action listener: _resource_record_pre_action 16:59:14 INFO - Running main action method: download_and_extract 16:59:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:59:14 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')]} 16:59:14 INFO - https://queue.taskcluster.net/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:59:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:59:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:59:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/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 16:59:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/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 16:59:15 INFO - Downloaded 1448 bytes. 16:59:15 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:59:15 INFO - Using the following test package requirements: 16:59:15 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:59:15 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:59:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:59:15 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:59:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:59:15 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:59:15 INFO - u'jsshell-linux-x86_64.zip'], 16:59:15 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:59:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:59:15 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:59:15 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:59:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:59:15 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:59:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:59:15 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:59:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:59:15 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:59:15 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:59:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:59:15 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:59:15 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')]} 16:59:15 INFO - https://queue.taskcluster.net/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:59:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:59:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:59:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/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 16:59:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/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 16:59:16 INFO - Downloaded 23310732 bytes. 16:59:16 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'] 16:59:16 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 16:59:18 INFO - Return code: 0 16:59:18 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 16:59: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')]} 16:59:18 INFO - https://queue.taskcluster.net/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:59:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:59:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:59:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/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 16:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/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 16:59:30 INFO - Downloaded 23310732 bytes. 16:59:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:59:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:59:31 INFO - Return code: 0 16:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:31 INFO - https://queue.taskcluster.net/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:59:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:59:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:59:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/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 16:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/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 16:59:32 INFO - Downloaded 10845161 bytes. 16:59:32 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'] 16:59:32 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 16:59:32 INFO - Return code: 0 16:59:32 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')]} 16:59:32 INFO - https://queue.taskcluster.net/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:59:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:59:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:59:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/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 16:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E0st9XR7R8iVkHxum4rDig/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 16:59:34 INFO - Downloaded 60449072 bytes. 16:59:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:59:34 INFO - mkdir: /builds/slave/test-pgo/properties 16:59:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:59:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:59:34 INFO - Contents: 16:59:34 INFO - build_url:https://queue.taskcluster.net/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:59:35 INFO - Running post-action listener: _resource_record_post_action 16:59:35 INFO - Running post-action listener: set_extra_try_arguments 16:59:35 INFO - ##### 16:59:35 INFO - ##### Running populate-webroot step. 16:59:35 INFO - ##### 16:59:35 INFO - Running pre-action listener: _resource_record_pre_action 16:59:35 INFO - Running main action method: populate_webroot 16:59:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:59:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:59:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:59:35 INFO - '--tppagecycles', 16:59:35 INFO - '7'], 16:59:35 INFO - 'tests': ['tsvgm']}}, 16:59:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:59:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:59:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:59:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:59:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:59:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:59:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:35 INFO - 'talos_options': ['--e10s'], 16:59:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:35 INFO - 'tests': ['damp', 'tps']}, 16:59:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:35 INFO - 'talos_options': ['--e10s'], 16:59:35 INFO - 'tests': ['damp', 'tps']}, 16:59:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:59:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:59:35 INFO - 'other': {'tests': ['a11yr', 16:59:35 INFO - 'ts_paint', 16:59:35 INFO - 'tpaint', 16:59:35 INFO - 'sessionrestore', 16:59:35 INFO - 'sessionrestore_no_auto_restore', 16:59:35 INFO - 'tabpaint']}, 16:59:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:59:35 INFO - 'tests': ['a11yr', 16:59:35 INFO - 'ts_paint', 16:59:35 INFO - 'tpaint', 16:59:35 INFO - 'sessionrestore', 16:59:35 INFO - 'sessionrestore_no_auto_restore', 16:59:35 INFO - 'tabpaint']}, 16:59:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:59:35 INFO - 'tests': ['a11yr', 16:59:35 INFO - 'ts_paint', 16:59:35 INFO - 'tpaint', 16:59:35 INFO - 'sessionrestore', 16:59:35 INFO - 'sessionrestore_no_auto_restore', 16:59:35 INFO - 'tabpaint']}, 16:59:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:59:35 INFO - 'tests': ['a11yr', 16:59:35 INFO - 'ts_paint', 16:59:35 INFO - 'tpaint', 16:59:35 INFO - 'sessionrestore', 16:59:35 INFO - 'sessionrestore_no_auto_restore', 16:59:35 INFO - 'tabpaint']}, 16:59:35 INFO - 'other_l64': {'tests': ['a11yr', 16:59:35 INFO - 'ts_paint', 16:59:35 INFO - 'tpaint', 16:59:35 INFO - 'sessionrestore', 16:59:35 INFO - 'sessionrestore_no_auto_restore', 16:59:35 INFO - 'tabpaint']}, 16:59:35 INFO - 'other_nol64': {'tests': ['a11yr', 16:59:35 INFO - 'ts_paint', 16:59:35 INFO - 'tpaint', 16:59:35 INFO - 'sessionrestore', 16:59:35 INFO - 'sessionrestore_no_auto_restore', 16:59:35 INFO - 'tabpaint']}, 16:59:35 INFO - 'svgr': {'tests': ['tsvgx', 16:59:35 INFO - 'tsvgr_opacity', 16:59:35 INFO - 'tart', 16:59:35 INFO - 'tscrollx', 16:59:35 INFO - 'cart']}, 16:59:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:59:35 INFO - 'tests': ['tsvgx', 16:59:35 INFO - 'tsvgr_opacity', 16:59:35 INFO - 'tart', 16:59:35 INFO - 'tscrollx', 16:59:35 INFO - 'cart']}, 16:59:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:35 INFO - 'tests': ['tp5o']}, 16:59:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:35 INFO - 'talos_options': ['--e10s'], 16:59:35 INFO - 'tests': ['tp5o']}, 16:59:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:35 INFO - 'talos_options': ['--xperf_path', 16:59:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:35 INFO - 'tests': ['tp5n']}, 16:59:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:35 INFO - 'talos_options': ['--e10s', 16:59:35 INFO - '--xperf_path', 16:59:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:35 INFO - 'tests': ['tp5n']}}, 16:59:35 INFO - 'talos.zip': {'path': '', 16:59:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:59:35 INFO - Running post-action listener: _resource_record_post_action 16:59:35 INFO - ##### 16:59:35 INFO - ##### Running create-virtualenv step. 16:59:35 INFO - ##### 16:59:35 INFO - Running pre-action listener: _resource_record_pre_action 16:59:35 INFO - Running main action method: create_virtualenv 16:59:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:59:35 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 16:59:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:59:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:59:35 INFO - Using real prefix '/usr' 16:59:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:59:35 INFO - Installing distribute.............................................................................................................................................................................................done. 16:59:37 INFO - Installing pip.................done. 16:59:37 INFO - Return code: 0 16:59:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:37 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 0x7f200aafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0920>, '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 0x2af1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cb0>, '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-1459207941.965837-184654313', '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 16:59:37 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 16:59:37 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 16:59:37 INFO - Using env: {'DISPLAY': ':0', 16:59:37 INFO - 'HOME': '/home/cltbld', 16:59:37 INFO - 'LANG': 'en_US.UTF-8', 16:59:37 INFO - 'LANGUAGE': 'en_US:en', 16:59:37 INFO - 'LOGNAME': 'cltbld', 16:59:37 INFO - 'MAIL': '/var/mail/cltbld', 16:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:37 INFO - 'MOZ_NO_REMOTE': '1', 16:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:37 INFO - 'NO_EM_RESTART': '1', 16:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:37 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:37 INFO - 'SHELL': '/bin/bash', 16:59:37 INFO - 'SHLVL': '1', 16:59:37 INFO - 'TERM': 'linux', 16:59:37 INFO - 'TMOUT': '86400', 16:59:37 INFO - 'USER': 'cltbld', 16:59:37 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459207941.965837-184654313', 16:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:37 INFO - '_': '/tools/buildbot/bin/python'} 16:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:37 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 16:59:37 INFO - Cleaning up... 16:59:37 INFO - Return code: 0 16:59:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:37 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 0x7f200aafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0920>, '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 0x2af1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cb0>, '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-1459207941.965837-184654313', '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 16:59:37 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 16:59:37 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 16:59:37 INFO - Using env: {'DISPLAY': ':0', 16:59:37 INFO - 'HOME': '/home/cltbld', 16:59:37 INFO - 'LANG': 'en_US.UTF-8', 16:59:37 INFO - 'LANGUAGE': 'en_US:en', 16:59:37 INFO - 'LOGNAME': 'cltbld', 16:59:37 INFO - 'MAIL': '/var/mail/cltbld', 16:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:37 INFO - 'MOZ_NO_REMOTE': '1', 16:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:37 INFO - 'NO_EM_RESTART': '1', 16:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:37 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:37 INFO - 'SHELL': '/bin/bash', 16:59:37 INFO - 'SHLVL': '1', 16:59:37 INFO - 'TERM': 'linux', 16:59:37 INFO - 'TMOUT': '86400', 16:59:37 INFO - 'USER': 'cltbld', 16:59:37 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459207941.965837-184654313', 16:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:37 INFO - '_': '/tools/buildbot/bin/python'} 16:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:38 INFO - Downloading/unpacking psutil>=0.7.1 16:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:59:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:40 INFO - Installing collected packages: psutil 16:59:40 INFO - Running setup.py install for psutil 16:59:40 INFO - building 'psutil._psutil_linux' extension 16:59:40 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 16:59:40 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 16:59:40 INFO - building 'psutil._psutil_posix' extension 16:59:40 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 16:59:40 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 16:59:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:40 INFO - Successfully installed psutil 16:59:40 INFO - Cleaning up... 16:59:40 INFO - Return code: 0 16:59:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f200aafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0920>, '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 0x2af1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cb0>, '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-1459207941.965837-184654313', '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 16:59:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:59:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:59:40 INFO - Using env: {'DISPLAY': ':0', 16:59:40 INFO - 'HOME': '/home/cltbld', 16:59:40 INFO - 'LANG': 'en_US.UTF-8', 16:59:40 INFO - 'LANGUAGE': 'en_US:en', 16:59:40 INFO - 'LOGNAME': 'cltbld', 16:59:40 INFO - 'MAIL': '/var/mail/cltbld', 16:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:40 INFO - 'MOZ_NO_REMOTE': '1', 16:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:40 INFO - 'NO_EM_RESTART': '1', 16:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:40 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:40 INFO - 'SHELL': '/bin/bash', 16:59:40 INFO - 'SHLVL': '1', 16:59:40 INFO - 'TERM': 'linux', 16:59:40 INFO - 'TMOUT': '86400', 16:59:40 INFO - 'USER': 'cltbld', 16:59:40 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459207941.965837-184654313', 16:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:40 INFO - '_': '/tools/buildbot/bin/python'} 16:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:59:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:59:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:59:42 INFO - Installing collected packages: mozsystemmonitor 16:59:42 INFO - Running setup.py install for mozsystemmonitor 16:59:42 INFO - Successfully installed mozsystemmonitor 16:59:42 INFO - Cleaning up... 16:59:42 INFO - Return code: 0 16:59:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:59:42 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')]} 16:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:42 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')]} 16:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:42 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 0x7f200aafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0920>, '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 0x2af1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cb0>, '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-1459207941.965837-184654313', '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 16:59:42 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 16:59:42 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 16:59:42 INFO - Using env: {'DISPLAY': ':0', 16:59:42 INFO - 'HOME': '/home/cltbld', 16:59:42 INFO - 'LANG': 'en_US.UTF-8', 16:59:42 INFO - 'LANGUAGE': 'en_US:en', 16:59:42 INFO - 'LOGNAME': 'cltbld', 16:59:42 INFO - 'MAIL': '/var/mail/cltbld', 16:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:42 INFO - 'MOZ_NO_REMOTE': '1', 16:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:42 INFO - 'NO_EM_RESTART': '1', 16:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:42 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:42 INFO - 'SHELL': '/bin/bash', 16:59:42 INFO - 'SHLVL': '1', 16:59:42 INFO - 'TERM': 'linux', 16:59:42 INFO - 'TMOUT': '86400', 16:59:42 INFO - 'USER': 'cltbld', 16:59:42 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459207941.965837-184654313', 16:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:42 INFO - '_': '/tools/buildbot/bin/python'} 16:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:43 INFO - Downloading/unpacking blobuploader==1.2.4 16:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:45 INFO - Downloading blobuploader-1.2.4.tar.gz 16:59:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:59:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:59:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:46 INFO - Downloading docopt-0.6.1.tar.gz 16:59:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:59:46 INFO - Installing collected packages: blobuploader, requests, docopt 16:59:46 INFO - Running setup.py install for blobuploader 16:59:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:59:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:59:46 INFO - Running setup.py install for requests 16:59:46 INFO - Running setup.py install for docopt 16:59:46 INFO - Successfully installed blobuploader requests docopt 16:59:46 INFO - Cleaning up... 16:59:46 INFO - Return code: 0 16:59:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:59: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')]} 16:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:46 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 0x7f200aafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0920>, '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 0x2af1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cb0>, '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-1459207941.965837-184654313', '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 16:59:46 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 16:59:46 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 16:59:46 INFO - Using env: {'DISPLAY': ':0', 16:59:46 INFO - 'HOME': '/home/cltbld', 16:59:46 INFO - 'LANG': 'en_US.UTF-8', 16:59:46 INFO - 'LANGUAGE': 'en_US:en', 16:59:46 INFO - 'LOGNAME': 'cltbld', 16:59:46 INFO - 'MAIL': '/var/mail/cltbld', 16:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:46 INFO - 'MOZ_NO_REMOTE': '1', 16:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:46 INFO - 'NO_EM_RESTART': '1', 16:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:46 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:46 INFO - 'SHELL': '/bin/bash', 16:59:46 INFO - 'SHLVL': '1', 16:59:46 INFO - 'TERM': 'linux', 16:59:46 INFO - 'TMOUT': '86400', 16:59:46 INFO - 'USER': 'cltbld', 16:59:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459207941.965837-184654313', 16:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:46 INFO - '_': '/tools/buildbot/bin/python'} 16:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:59:46 INFO - Running setup.py (path:/tmp/pip-Q3Y0_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:59:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:59:46 INFO - Running setup.py (path:/tmp/pip-bZ5Am5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:59:47 INFO - Running setup.py (path:/tmp/pip-JvCRCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:59:47 INFO - Running setup.py (path:/tmp/pip-mXhQUR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:59:47 INFO - Running setup.py (path:/tmp/pip-ZdGdFK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:59:47 INFO - Running setup.py (path:/tmp/pip-F4aQC3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:59:47 INFO - Running setup.py (path:/tmp/pip-x2k1lU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:59:47 INFO - Running setup.py (path:/tmp/pip-YVvnVK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:59:47 INFO - Running setup.py (path:/tmp/pip-7GnA0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:59:47 INFO - Running setup.py (path:/tmp/pip-XUUpkx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:59:47 INFO - Running setup.py (path:/tmp/pip-fYF4B2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:59:47 INFO - Running setup.py (path:/tmp/pip-5kkHzs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:59:47 INFO - Running setup.py (path:/tmp/pip-BlQNZ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:59:47 INFO - Running setup.py (path:/tmp/pip-yrls02-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:59:47 INFO - Running setup.py (path:/tmp/pip-0hZzfF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:59:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:59:47 INFO - Running setup.py (path:/tmp/pip-O3xNVN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:59:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:59:48 INFO - Running setup.py (path:/tmp/pip-4VOKt_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:59:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:59:48 INFO - Running setup.py install for manifestparser 16:59:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:59:48 INFO - Running setup.py install for mozcrash 16:59:48 INFO - Running setup.py install for mozdebug 16:59:48 INFO - Running setup.py install for mozdevice 16:59:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:59:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:59:48 INFO - Running setup.py install for mozfile 16:59:48 INFO - Running setup.py install for mozhttpd 16:59:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:59:48 INFO - Running setup.py install for mozinfo 16:59:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:59:48 INFO - Running setup.py install for mozInstall 16:59:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:59:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:59:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:59:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:59:48 INFO - Running setup.py install for mozleak 16:59:49 INFO - Running setup.py install for mozlog 16:59:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:59:49 INFO - Running setup.py install for moznetwork 16:59:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:59:49 INFO - Running setup.py install for mozprocess 16:59:49 INFO - Running setup.py install for mozprofile 16:59:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:59:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:59:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:59:49 INFO - Running setup.py install for mozrunner 16:59:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:59:49 INFO - Running setup.py install for mozscreenshot 16:59:49 INFO - Running setup.py install for moztest 16:59:49 INFO - Running setup.py install for mozversion 16:59:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:59:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:59:49 INFO - Cleaning up... 16:59:49 INFO - Return code: 0 16:59:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:49 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 0x7f200aafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0920>, '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 0x2af1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cb0>, '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-1459207941.965837-184654313', '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 16:59:49 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 16:59:49 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 16:59:49 INFO - Using env: {'DISPLAY': ':0', 16:59:49 INFO - 'HOME': '/home/cltbld', 16:59:49 INFO - 'LANG': 'en_US.UTF-8', 16:59:49 INFO - 'LANGUAGE': 'en_US:en', 16:59:49 INFO - 'LOGNAME': 'cltbld', 16:59:49 INFO - 'MAIL': '/var/mail/cltbld', 16:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:49 INFO - 'MOZ_NO_REMOTE': '1', 16:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:49 INFO - 'NO_EM_RESTART': '1', 16:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:49 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:49 INFO - 'SHELL': '/bin/bash', 16:59:49 INFO - 'SHLVL': '1', 16:59:49 INFO - 'TERM': 'linux', 16:59:49 INFO - 'TMOUT': '86400', 16:59:49 INFO - 'USER': 'cltbld', 16:59:49 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459207941.965837-184654313', 16:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:49 INFO - '_': '/tools/buildbot/bin/python'} 16:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:59:50 INFO - Running setup.py (path:/tmp/pip-f5JJFy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:59:50 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)) 16:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:59:50 INFO - Running setup.py (path:/tmp/pip-oPb994-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:59:50 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)) 16:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:59:50 INFO - Running setup.py (path:/tmp/pip-9FYSfY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:59:50 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)) 16:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:59:50 INFO - Running setup.py (path:/tmp/pip-Qp7jBo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:59:50 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)) 16:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:59:50 INFO - Running setup.py (path:/tmp/pip-BNHZjk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:59:50 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)) 16:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:59:50 INFO - Running setup.py (path:/tmp/pip-Mgor_J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:59:50 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)) 16:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:59:50 INFO - Running setup.py (path:/tmp/pip-a3A4KY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:59:50 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)) 16:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:59:50 INFO - Running setup.py (path:/tmp/pip-YCsq0l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:59:50 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)) 16:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:59:50 INFO - Running setup.py (path:/tmp/pip-gCI5A4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:59:50 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)) 16:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:59:50 INFO - Running setup.py (path:/tmp/pip-TEKmMw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:59:50 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)) 16:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:59:50 INFO - Running setup.py (path:/tmp/pip-JVt48F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:59:50 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)) 16:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:59:50 INFO - Running setup.py (path:/tmp/pip-5qcfP7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:59:50 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)) 16:59:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:59:50 INFO - Running setup.py (path:/tmp/pip-J7wAeo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:59:51 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)) 16:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:59:51 INFO - Running setup.py (path:/tmp/pip-R_c9WP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:59:51 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)) 16:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:59:51 INFO - Running setup.py (path:/tmp/pip-NJC9Tn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:59:51 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)) 16:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:59:51 INFO - Running setup.py (path:/tmp/pip-Vr5amQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:59:51 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)) 16:59:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:59:51 INFO - Running setup.py (path:/tmp/pip-sAVSDJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:59:51 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)) 16:59:51 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)) 16:59:51 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)) 16:59:51 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)) 16:59:51 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)) 16:59:51 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)) 16:59:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:53 INFO - Downloading blessings-1.6.tar.gz 16:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:59:53 INFO - Installing collected packages: blessings 16:59:53 INFO - Running setup.py install for blessings 16:59:53 INFO - Successfully installed blessings 16:59:53 INFO - Cleaning up... 16:59:53 INFO - Return code: 0 16:59:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:59:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:59:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:59:53 INFO - Reading from file tmpfile_stdout 16:59:53 INFO - Current package versions: 16:59:53 INFO - argparse == 1.2.1 16:59:53 INFO - blessings == 1.6 16:59:53 INFO - blobuploader == 1.2.4 16:59:53 INFO - docopt == 0.6.1 16:59:53 INFO - manifestparser == 1.1 16:59:53 INFO - mozInstall == 1.12 16:59:53 INFO - mozcrash == 0.17 16:59:53 INFO - mozdebug == 0.1 16:59:53 INFO - mozdevice == 0.48 16:59:53 INFO - mozfile == 1.2 16:59:53 INFO - mozhttpd == 0.7 16:59:53 INFO - mozinfo == 0.9 16:59:53 INFO - mozleak == 0.1 16:59:53 INFO - mozlog == 3.1 16:59:53 INFO - moznetwork == 0.27 16:59:53 INFO - mozprocess == 0.22 16:59:53 INFO - mozprofile == 0.28 16:59:53 INFO - mozrunner == 6.11 16:59:53 INFO - mozscreenshot == 0.1 16:59:53 INFO - mozsystemmonitor == 0.0 16:59:53 INFO - moztest == 0.7 16:59:53 INFO - mozversion == 1.4 16:59:53 INFO - psutil == 3.1.1 16:59:53 INFO - requests == 1.2.3 16:59:53 INFO - wsgiref == 0.1.2 16:59:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:59: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')]} 16:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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/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 0x7f200aafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0920>, '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 0x2af1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cb0>, '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-1459207941.965837-184654313', '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 16:59:53 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 16:59:53 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 16:59:53 INFO - Using env: {'DISPLAY': ':0', 16:59:53 INFO - 'HOME': '/home/cltbld', 16:59:53 INFO - 'LANG': 'en_US.UTF-8', 16:59:53 INFO - 'LANGUAGE': 'en_US:en', 16:59:53 INFO - 'LOGNAME': 'cltbld', 16:59:53 INFO - 'MAIL': '/var/mail/cltbld', 16:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:53 INFO - 'MOZ_NO_REMOTE': '1', 16:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:53 INFO - 'NO_EM_RESTART': '1', 16:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:53 INFO - 'SHELL': '/bin/bash', 16:59:53 INFO - 'SHLVL': '1', 16:59:53 INFO - 'TERM': 'linux', 16:59:53 INFO - 'TMOUT': '86400', 16:59:53 INFO - 'USER': 'cltbld', 16:59:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459207941.965837-184654313', 16:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:53 INFO - '_': '/tools/buildbot/bin/python'} 16:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:53 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)) 16:59:53 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)) 16:59:53 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)) 16:59:53 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)) 16:59:53 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)) 16:59:53 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)) 16:59:53 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)) 16:59:53 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)) 16:59:53 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)) 16:59:53 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)) 16:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:59:53 INFO - Cleaning up... 16:59:53 INFO - Return code: 0 16:59:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:59: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')]} 16:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:53 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 0x7f200aafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0920>, '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 0x2af1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cb0>, '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-1459207941.965837-184654313', '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 16:59:53 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 16:59:53 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 16:59:53 INFO - Using env: {'DISPLAY': ':0', 16:59:53 INFO - 'HOME': '/home/cltbld', 16:59:53 INFO - 'LANG': 'en_US.UTF-8', 16:59:53 INFO - 'LANGUAGE': 'en_US:en', 16:59:53 INFO - 'LOGNAME': 'cltbld', 16:59:53 INFO - 'MAIL': '/var/mail/cltbld', 16:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:53 INFO - 'MOZ_NO_REMOTE': '1', 16:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:53 INFO - 'NO_EM_RESTART': '1', 16:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:53 INFO - 'SHELL': '/bin/bash', 16:59:53 INFO - 'SHLVL': '1', 16:59:53 INFO - 'TERM': 'linux', 16:59:53 INFO - 'TMOUT': '86400', 16:59:53 INFO - 'USER': 'cltbld', 16:59:53 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459207941.965837-184654313', 16:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:53 INFO - '_': '/tools/buildbot/bin/python'} 16:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:54 INFO - Downloading/unpacking jsonschema 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:59:56 INFO - Downloading/unpacking functools32 (from jsonschema) 16:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:56 INFO - Downloading functools32-3.2.3-2.tar.gz 16:59:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:59:56 INFO - warning: no files found matching '*.txt' 16:59:56 INFO - no previously-included directories found matching 'build' 16:59:56 INFO - no previously-included directories found matching 'dist' 16:59:56 INFO - no previously-included directories found matching '.git*' 16:59:56 INFO - Installing collected packages: jsonschema, functools32 16:59:56 INFO - Running setup.py install for functools32 16:59:56 INFO - warning: no files found matching '*.txt' 16:59:56 INFO - no previously-included directories found matching 'build' 16:59:56 INFO - no previously-included directories found matching 'dist' 16:59:56 INFO - no previously-included directories found matching '.git*' 16:59:56 INFO - Successfully installed jsonschema functools32 16:59:56 INFO - Cleaning up... 16:59:56 INFO - Return code: 0 16:59:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:59: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')]} 16:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:56 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 0x7f200aafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a616d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0920>, '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 0x2af1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cb0>, '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-1459207941.965837-184654313', '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 16:59:56 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 16:59:56 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 16:59:56 INFO - Using env: {'DISPLAY': ':0', 16:59:56 INFO - 'HOME': '/home/cltbld', 16:59:56 INFO - 'LANG': 'en_US.UTF-8', 16:59:56 INFO - 'LANGUAGE': 'en_US:en', 16:59:56 INFO - 'LOGNAME': 'cltbld', 16:59:56 INFO - 'MAIL': '/var/mail/cltbld', 16:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:56 INFO - 'MOZ_NO_REMOTE': '1', 16:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:56 INFO - 'NO_EM_RESTART': '1', 16:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:56 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:56 INFO - 'SHELL': '/bin/bash', 16:59:56 INFO - 'SHLVL': '1', 16:59:56 INFO - 'TERM': 'linux', 16:59:56 INFO - 'TMOUT': '86400', 16:59:56 INFO - 'USER': 'cltbld', 16:59:56 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459207941.965837-184654313', 16:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:56 INFO - '_': '/tools/buildbot/bin/python'} 16:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:56 INFO - Downloading/unpacking flake8 16:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:59:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:59:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:59:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:59:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:59:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:59:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:59:59 INFO - no previously-included directories found matching 'docs/_build' 16:59:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:59:59 INFO - Running setup.py install for pep8 16:59:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:59:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:59:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:59:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:59:59 INFO - no previously-included directories found matching 'docs/_build' 16:59:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:59:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:59:59 INFO - Cleaning up... 16:59:59 INFO - Return code: 0 16:59:59 INFO - Running post-action listener: _resource_record_post_action 16:59:59 INFO - Running post-action listener: _start_resource_monitoring 16:59:59 INFO - Starting resource monitoring. 16:59:59 INFO - ##### 16:59:59 INFO - ##### Running install step. 16:59:59 INFO - ##### 16:59:59 INFO - Running pre-action listener: _resource_record_pre_action 16:59:59 INFO - Running main action method: install 16:59:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:59:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:59:59 INFO - Reading from file tmpfile_stdout 16:59:59 INFO - Detecting whether we're running mozinstall >=1.0... 16:59:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:59:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:59:59 INFO - Reading from file tmpfile_stdout 16:59:59 INFO - Output received: 16:59:59 INFO - Usage: mozinstall [options] installer 16:59:59 INFO - Options: 16:59:59 INFO - -h, --help show this help message and exit 16:59:59 INFO - -d DEST, --destination=DEST 16:59:59 INFO - Directory to install application into. [default: 16:59:59 INFO - "/builds/slave/test-pgo"] 16:59:59 INFO - --app=APP Application being installed. [default: firefox] 16:59:59 INFO - mkdir: /builds/slave/test-pgo/build/application 16:59:59 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'] 16:59:59 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 17:00:15 INFO - Reading from file tmpfile_stdout 17:00:15 INFO - Output received: 17:00:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:00:15 INFO - Running post-action listener: _resource_record_post_action 17:00:15 INFO - ##### 17:00:15 INFO - ##### Running run-tests step. 17:00:15 INFO - ##### 17:00:15 INFO - Running pre-action listener: _resource_record_pre_action 17:00:15 INFO - Running main action method: run_tests 17:00:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:00:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:00:15 INFO - Python 2.7.3 17:00:15 INFO - Return code: 0 17:00:15 INFO - grabbing minidump binary from tooltool 17:00:15 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')]} 17:00:15 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 0x2af0920>, '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 0x2af1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:00:15 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 17:00:15 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 17:00:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:00:15 INFO - Return code: 0 17:00:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:00:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:00:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:00:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:00:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:00:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:00:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:00:16 INFO - Return code: 0 17:00:16 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/E0st9XR7R8iVkHxum4rDig/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 17:00:16 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/E0st9XR7R8iVkHxum4rDig/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 17:00:16 INFO - Using env: {'DISPLAY': ':0', 17:00:16 INFO - 'HOME': '/home/cltbld', 17:00:16 INFO - 'LANG': 'en_US.UTF-8', 17:00:16 INFO - 'LANGUAGE': 'en_US:en', 17:00:16 INFO - 'LOGNAME': 'cltbld', 17:00:16 INFO - 'MAIL': '/var/mail/cltbld', 17:00:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:00:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:16 INFO - 'MOZ_NO_REMOTE': '1', 17:00:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:16 INFO - 'NO_EM_RESTART': '1', 17:00:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:16 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:00:16 INFO - 'SHELL': '/bin/bash', 17:00:16 INFO - 'SHLVL': '1', 17:00:16 INFO - 'TERM': 'linux', 17:00:16 INFO - 'TMOUT': '86400', 17:00:16 INFO - 'USER': 'cltbld', 17:00:16 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459207941.965837-184654313', 17:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:16 INFO - '_': '/tools/buildbot/bin/python'} 17:00:16 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/E0st9XR7R8iVkHxum4rDig/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 17:00:16 INFO - mozversion application_buildid: 20160328141409 17:00:16 INFO - mozversion application_changeset: 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 17:00:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:00:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:00:16 INFO - mozversion application_name: Firefox 17:00:16 INFO - mozversion application_remotingname: firefox-dev 17:00:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:00:16 INFO - mozversion application_vendor: Mozilla 17:00:16 INFO - mozversion application_version: 47.0a2 17:00:16 INFO - mozversion platform_buildid: 20160328141409 17:00:16 INFO - mozversion platform_changeset: 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 17:00:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:00:16 INFO - mozversion platform_version: 47.0a2 17:00:16 INFO - using testdate: 1459209616 17:00:16 INFO - actual date: 1459209616 17:00:16 INFO - starting webserver on 'localhost:58336' 17:00:16 INFO - SUITE-START | Running 2 tests 17:00:16 INFO - TEST-START | dromaeo_css 17:00:16 INFO - operating with platform_type : linux_ 17:00:16 INFO - Initialising browser for dromaeo_css test... 17:00:16 INFO - TEST-INFO | started process 4472 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmuJqph/profile http://localhost:58336/getInfo.html) 17:00:20 INFO - PROCESS | 4472 | 17:00:20 INFO - PROCESS | 4472 | (process:4550): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:00:21 INFO - PROCESS | 4472 | __metrics Screen width/height:1600/1200 17:00:21 INFO - PROCESS | 4472 | colorDepth:24 17:00:21 INFO - PROCESS | 4472 | Browser inner width/height: 1024/697 17:00:21 INFO - PROCESS | 4472 | __metrics 17:00:22 ERROR - PROCESS | 4472 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:00:22 INFO - TEST-INFO | 4472: exit 0 17:00:22 INFO - Browser initialized. 17:00:22 INFO - Running cycle 1/1 for dromaeo_css test... 17:00:22 INFO - TEST-INFO | started process 4601 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmuJqph/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:24 INFO - PROCESS | 4601 | 17:00:24 INFO - PROCESS | 4601 | (process:4668): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:00:34 INFO - PROCESS | 4601 | RSS: Main: 154746880 17:00:34 INFO - PROCESS | 4601 | 17:01:24 INFO - PROCESS | 4601 | 1459209684317 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] 17:03:32 INFO - PROCESS | 4601 | Cycle 1(1): loaded http://localhost:58336/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58336/tests/dromaeo/cssquery-ext.html) 17:03:33 INFO - PROCESS | 4601 | RSS: Main: 156700672 17:03:33 INFO - PROCESS | 4601 | 17:06:35 INFO - PROCESS | 4601 | Cycle 1(1): loaded http://localhost:58336/tests/dromaeo/cssquery-ext.html (next: http://localhost:58336/tests/dromaeo/cssquery-jquery.html) 17:06:36 INFO - PROCESS | 4601 | RSS: Main: 156631040 17:06:36 INFO - PROCESS | 4601 | 17:09:37 INFO - PROCESS | 4601 | Cycle 1(1): loaded http://localhost:58336/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58336/tests/dromaeo/cssquery-mootools.html) 17:09:38 INFO - PROCESS | 4601 | RSS: Main: 154886144 17:09:38 INFO - PROCESS | 4601 | 17:12:40 INFO - PROCESS | 4601 | Cycle 1(1): loaded http://localhost:58336/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58336/tests/dromaeo/cssquery-prototype.html) 17:12:40 INFO - PROCESS | 4601 | RSS: Main: 155496448 17:12:40 INFO - PROCESS | 4601 | 17:15:42 INFO - PROCESS | 4601 | Cycle 1(1): loaded http://localhost:58336/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58336/tests/dromaeo/cssquery-yui.html) 17:15:43 INFO - PROCESS | 4601 | RSS: Main: 155779072 17:15:43 INFO - PROCESS | 4601 | 17:18:45 INFO - PROCESS | 4601 | Cycle 1(1): loaded http://localhost:58336/tests/dromaeo/cssquery-yui.html (next: http://localhost:58336/tests/dromaeo/cssquery-dojo.html) 17:18:45 INFO - PROCESS | 4601 | RSS: Main: 157786112 17:18:45 INFO - PROCESS | 4601 | 17:18:45 INFO - PROCESS | 4601 | __start_tp_report 17:18:45 INFO - PROCESS | 4601 | _x_x_mozilla_page_load 17:18:45 INFO - PROCESS | 4601 | _x_x_mozilla_page_load_details 17:18:45 INFO - PROCESS | 4601 | |i|pagename|runs| 17:18:45 INFO - PROCESS | 4601 | |0;dojo.html;3309.1396236978385;3395.9830200849;3410.67598578135;3424.982875085624;3433.914152146196;5454.836354909349;5456.972715136424;5492.313460817398;5492.890142197154;5548.250986116873;5458.699771512565;5504.2018907258425;5507.421720719327;5517.475839795223;5532.529734972532;5046.167382381903;5047.621428392867;5105.081085404626;5105.2086926526445;5126.410462796789;4967.304577359173;5050.419201791786;5083.7712302946275;5196.662216955905;5240.2401651760665;5016.47327030662;5034.697918124924;5087.923681144785;5123.974380128094;5141.1003074462005;5132.435432102466;5135.486451354872;5144.819931302386;5147;5147.871303217412;4905.558499735005;4918.213085906238;5124.205748109049;5131.307273518065;5161.4322424533275;5295.417504074549;5332.280142180794;5334.91997620036;5351.946480535223;5352.4915133062295;5841.532677385799;5854.356020837705;5870.530357571384;5902.527797776168;5915.822525324247;5807.506361959238;5928.318243402021;5972.880542389128;6023.608465449775;6068.696565171768;5567.081431563787;5626.127950167731;5627.718614069321;5633.915491267634;5635.267415235993;6093.482054025458;6106.267247930276;6107.603005804608;6114.877702446015;6123;5690.317161940511;5892.6759028253855;5924.7333869975955;5929.6145750526075;5980.880382392328;5950.404959504015;5962.34414214436;5981.910271345933;5991.370906054802;6006.099085137264;5718.628289161275;5901.970490147608;5905.291365036223;5945.078512830518;5953.672548009815;5953.404659534099;6015.969920150371;6024.277086749618;6026.939730602726;6057.121717350959;4512.503624601291;4513.796879140446;4539.773011349485;4550.089982003613;4578.9542104579195;3996.2806694795217;4034.253663072341;4037.818298176589;4068.105016896278;4081.428599996003;5521.779128834882;5573.693446860461;5584.497395234448;5714.514266287412;5845.678487683133;5942.762289508458;5943.108533719977;5986.07215881539;6010.338862725097;6032.607880487842;5650.180723795027;5662.8301150965535;5677.14842773579;5683.8010669626365;5725.055365864669;4907.9263811042865;4980.203167493184;4985.426675932242;5028.5977121830165;5094.057599344133;6210.782622608187;6223.471004964538;6272.18461599989;6280.466160376419;6291.622502649856;6030.276366836008;6055.455009049207;6057.848553786191;6061.939380606137;6063.727132279147;5938.851528711644;6123.173371594956;6134.681512609229;6199.783007594712;6244.875102498016;5865.794697185578;5870.972579798433;5894.734736936763;5901.173835663097;5939;5952.553558483044;5984.401559843981;6023.48800351975;6024.969875150597;6031.185789918305;5685.0335442973965;5812.564057695605;5838.94161058384;5843.386444423444;5911.645301281937;5794.362620111869;5818.418158184148;5840.737166827588;5841.153032810304;5857.033589457692;5725.885482290414;5775.537956963349;5784.739686714024;5786.566007549366;5798;5733.8566535836935;5845.064789633639;5857.179994800646;5885.205497257815;5966.76132954677;5659.886802264014;5673;5685.687287199078;5691.487766100905;5702 17:18:45 INFO - PROCESS | 4601 | |1;ext.html;552.7346873500719;555.8036350507825;571.4571157400469;593.1666009256995;649.7985624456416;38670.419943700865;40347.394789078186;40347.79826100869;40357.394639080434;40414;41715.539956101544;42472.787636061774;42499.57500424995;42600.57399426005;42613.57386426142;8766.211041006323;8863.02506724263;8866.778330541723;8920.687775927843;8924.910750892506;8744.125587441269;9019.188273055424;9052.366334356564;9102.317326200528;9108.908910910906;9061.728148155566;9062.501562414065;9162.35863489556;9184.173424391804;9197.080291970782;9022.142896424863;9120.908790912106;9129.863052054225;9134.862977055349;9172.770680732969;9052;9121.726348209564;9140.954295228548;9167.083291670846;9169.954150229207;35350.46974295388;40922;41790.373144402554;41801;41807;3507.7369197310304;3811.1615444602144;4055.5944405559503;4542.568455996675;4584.977075114603;29211.269718257;29331.853340733374;29680.70319296801;29723.554146687817;29882.70117298821;3946.427767973628;4027.6979226557833;4059.254992128803;4087.4890638670167;4137.358709400048;265610;266500;268667;268745;269786;46964;47531.5246847534;65625.67187164034;65643.34356656468;66023.66988165029;45604.771976139906;45621.5437845624;46041.53958460373;46059.53940460619;46107.077858442644;16261.593460163354;16525.173741313127;16568;16589.336426543043;16621.83378166227;13411.061225714302;13451.394687239097;13459.528916487876;13496;13501.324933753272;15688.76466852998;16178.83821161797;16200.51398458048;16263.837361626232;16274;6313.210848643919;6371.39471750183;6484.383983521558;6550.541462097703;6568.67156642166;1070.539667942792;1083.5070043130356;1101.5208384352832;1132.6828488023366;1154.9595764148214;30272.271792722047;30774.384512310076;30847.61185746647;30952.535711964338;31320.21699457532;1182.8403165572538;1183.2959389163434;1205.3129716061935;1225.307701148848;1301.4143635364123;15698;15743.44897928567;16010.679786404207;16185.595360115856;16202.108884011492;582728;588937;589871;591242;919708;65141.34858651353;65625.67187164129;66165.33834661687;66241.66879165573;66288.33711662918;1479.9926000369928;1483.5994281544138;1494.2976800903557;1500.294861415133;1501.594569466238;32429;32655.836720816245;32843.671563284064;32976;33861.153471163416;52257;53087.73456132694;53209.46790532045;53212;53276.200856987954;328478;332609;332961;333481;333989;36196.81901590581;36697;49923.500764991884;50604.49395505998;50717.746411267704;46014.539854601026;48972.75513622409;49576.256356155405;49622.4744585811;50041.74979125081;39856.60143398529;40987.59012409957;41361.58638413698;41459.585404145575;41680.58319416767;40724;40873.795631021654;41621.583784162984;41723.1655366897;41965.790171048946;40646.59353406546;40664;40931.59068409397;41350.586494135874;41484.17031659289;35157.648423515435;35761.28477430489;36063.819680901426;36264.27471450504;36333.45499817452;27484.725152749015;27862.860685696443;28220.717792821808;28300.15099547017;28318.150455486368 17:18:45 INFO - PROCESS | 4601 | |2;jquery.html;385.68566618206154;386.05416729013905;386.17166178547035;395.77045313718037;397.8189923584769;17712.822871771277;19934.700979485282;20533.178672853086;20570.89714551429;20602.793972060274;18305;18963.43109706711;19122.521936951583;19267.710984335212;19330.03349832506;5681.119426488901;5842.737076831531;5865.149553314767;5887.028640274371;5890.322612899528;4326.394304797331;6229.314775374705;6431.260405053432;6458.483321334282;6471.061696054069;6379.74481020761;6392.360763923593;6396.680165991682;6401.487880969535;6821.351971562718;7082.610456424894;7085.89371159433;7115.8221044473785;7117.110361204849;7123.145222573298;6755.527113102035;6778.728850845961;6814.671139127872;6816.863662726767;6828.2488926218075;22952.88523557388;23124.42188945273;24242.636360454606;24552.140675076287;24644.630330545056;2479.8884050217785;2535.29011876673;2586.456844062749;2592.7666510014187;3152.4640811062172;14368.425262989467;14407.207603581799;14739.631509212248;15504.922475387664;15728.056316620925;2069.5653912678204;2093.7592176899548;2106.368089573122;2119.459537817862;2159.416957421503;81093;81110.59444702798;84945.57527212324;85528;86023.99999999937;16937.745933811002;17561.209745561224;17648.735268970977;17659.73510397345;17695.911520442314;27927.30181745432;28087.157385278475;28264.15207543777;28426.147215583565;28495.28761780972;10174;10499.370037797757;10526.578936842441;10546.314489558154;10618.522166502526;9122.361434699507;9140;9178.265738740885;9243;9249.306302027375;8408.495490270603;8628.317478091712;8709.390342675952;8739.51932643698;8746.125387461203;1900.1259420666647;1964.3910387779833;1974.19058186143;1976.1305025788606;1992.611440769036;953.2802733935835;999.4702807512031;1016.6136867990116;1027.5838285494237;1114.3982249585295;17633.7354939676;17818.376356827448;18126.365577204735;18204.36284730028;18535.907320463582;1009.9040591143829;1050.6637875879644;1074.231924174219;1077.466654006272;1118.2731224704007;10215.846762298572;10353.171746260281;10429.895701043044;10585.894141058645;10623.043926046694;455539;461919;462167;467411;470364;75381;77511;77608.22391776124;78286.21713782904;79074.60462697764;1043.2019505078622;1048.156234231451;1050.033968748753;1056.3556230699267;1077.7197928538637;16261.51215463538;16264.3494260233;16478.505644830675;16481.505554832893;16817.243224054702;33476.33047339088;34437.48343774795;35711.28577428489;36006.279874401844;36236.27527449383;49657.75171124121;49803.75098124486;50227;50570.49429505658;50868.49131508637;8328.375371847256;8473.78815529592;8488.10874858131;8526.701565445179;8531.786705332417;9802.65690700822;12199.87800122023;12596.118271720892;12662.303573303188;12692.111552191627;10759.623413180501;10894.400807955639;10971.890281097087;10990.835137473105;11087;10583.94708026455;10669.626563070255;10858.91011196632;10905.291156074829;10936.945315273373;11004.174686898354;11163.274387164809;11181.72045698864;11282.323060616389;11354;7538.924610753822;8072.798180045545;8131.593420328842;8209.58952052383;8544;8360.28937540316;10107.393556386347;10970.835437468604;11120.555177792798;11346.262492937933 17:18:45 INFO - PROCESS | 4601 | |3;mootools.html;1583.8020247469067;1616.0303817709375;1886.9811301886978;1936.9709454358197;1988.482994421451;7499.100107987049;7838.490498117619;8158.306543943764;8352.457090289134;8362.749117526477;8088.514689118657;8153.062397824237;8162.510249385041;8173.632186551605;8180.181981801817;2484.043643197373;2494.451220731436;2515.5220508103494;2515.63523289123;2519.962200566993;2410.192585483865;2474.134053081425;2479.727230004698;2488.8631125288102;2500.712418071918;2460.3972026853444;2461.027893981885;2470.839395439291;2471.1721573272976;2486.7140278867982;2429.3683642253054;2431.878406079698;2458.3731148557094;2495.3262619092925;2499.7250302466714;2436.7197772256063;2463.81521385895;2466.580681284186;2468.543319485901;2497.8126640501855;8298;8340.958295208546;8345.41582089254;8393.874091888627;8397.496150231005;5210.687358758487;5312.9734351328;5318.707471089088;5361.249425080492;5409.24270602116;3069.7237248647507;3093.0102367242494;3165.699258570432;3178.2372230664705;3197.520371944204;954.3939598355025;960.8174446855076;974.3958745577717;993.4486360070158;994.1251698505341;11574.6527604172;11581.594644187497;11589.30464172144;11606.24559403636;11618.883811161864;4540.659450541222;4649.814007439664;4669.976650116728;4705.435347758223;4784.760761961888;9844.507774611384;9875.209983201326;9879.160271377013;9924.652637157666;9976.700698979042;5190.532852043334;5210.505002024802;5222;5222.1383471727495;5222.190560463135;4305.483341998917;4597.4712908015335;4624.722516649012;4627.398438203079;4742.359781429463;4051.311277082903;4072.3687828386646;4106.7535947842625;4112.09533902541;4153.439285696392;1261.3251910228169;1263.128441375448;1277.552856500236;1286.1382873474795;1297.4226469221105;1462.751332273516;1480.3486465954945;1492.55969489001;1509.3208056374676;1530.013141523711;8064.112947575762;8141.837163256701;8169.305609023299;8177.386695997705;8187.38594605407;553.3221803290936;556.7021643420751;557.8075563930438;563.2593140020941;563.3493315220926;6085.482733967662;6087.8478038048515;6115.6330620162935;6118.847028824226;6150.415710507495;9581.664641737645;10219;10244.02681745233;10279.486025698685;10337.328073675188;10097;10116;10137;10178.745531361776;10217.080462758388;7770.300672939463;7878.330341920886;7901.960490197513;7962.522248665098;7992.36061115121;8025.197480251928;8055.033395992518;8081.434299598972;8120.106788253405;8179.059408167899;8957.641694332415;8984.685536006209;9039.45763254207;9100.817983640423;9105.180533751995;8843.690470833748;9037.954810225907;9463.763405914908;9552.90447095548;9645.565949532147;6628.105205797348;6872.41584465326;7065.470089743187;7150.249223831631;7290.9635451822405;8075.232852878967;8120.75637730869;8145.79635509117;8151.673933042612;8161.183881611792;7234.6744396501235;7491.625418729151;7501.737439189602;7524.398048156025;7571.3564347031115;7057.7176912922905;7058.153021637437;7091.184513780981;7136;7160.427165826617;7516.436267279866;7551.093868735567;7552.962235188789;7566.167721550735;7581.166071731995;6757.594544327356;6824;6865.450763938773;6868.107146070979;6877.965610171917;6832.829179270558;6877.828054298682;6938.340857618518;6949.270326615632;6972.407345375497 17:18:45 INFO - PROCESS | 4601 | |4;prototype.html;371.7564994928322;377.1589355736709;378.69136653627294;379.2945122072945;384.3542848015333;6322.494200463963;6426.967865160674;6428.935710642898;6454.774082907099;6462.256840463348;6301;6340.334264902188;6340.524460665445;6344.048392741091;6366.363363663631;4719.268513380432;4849.490803465638;4901;4910.042541704369;4925.70445773253;4867.2942423348595;4872.951270487303;4881.072596206727;4882.096812089757;4884.389451318585;4810.639202059842;4812.0375924815;4838.491958344376;4846.806127754886;4848.927266091011;4830.082284365994;4838.540338667838;4841.588464980481;4855.295982082614;4865.78103985318;4229.344451610005;4259.637930775888;4274.273373526508;4274.914501709979;4275.529691733938;5943.197668314765;6058.030715085565;6067.605605635619;6076.726547305382;6079.118527813443;5669.574781891375;5682.261306030189;5685.516731077863;5688.658680479143;5693.459121383462;6688.130543029423;6690.297518760557;6716.798496045127;6729.7308107675635;6754.932450675479;4717.080169366975;4721.24460086388;4722.5513576210205;4723.7874295656775;4729.692569982974;7001.264867188923;7072.823179420504;7077.858442831166;7078.575285482888;7090.361867431956;4729.3683679130645;4811.326414302001;4825.565699087099;4836.443808961944;4855.417349918032;4784.114938736345;4884;4884.780184891689;4887.0714564232685;4923.8276660316715;5590.664560126405;5618.269624948731;5636.351819540805;5638.548916086703;5641.153826925912;6787.762428315084;6788.355106264897;6806.489513286523;6812.62530560814;6837.453003759687;1699.9745003824953;1732.5841797968649;1735.947921562355;1739.0869793358336;1744.2935611077535;1132.1961407400672;1144.6508814811561;1156.4449064448943;1170.6839153428527;1176.053277111916;6518.445932095825;6540.803775886731;6554.7378104876225;6555.475561955032;6584.7695330664155;6914.585124892523;6935.6878940446795;6947.548409353376;6960.199577048705;6979.82550436233;6481.967590162019;6564.80305590833;6683.866322673519;6690.765823196165;6693.531452798257;3779.168582911755;3837.9616203838164;3842.0779013037227;3849.7882616456363;3866.3040652682225;7465;7475.252474752481;7479.289467500579;7479.738209162762;7484.738034168778;7281.05346304977;7294.525855819461;7302.780916572511;7317.634118294171;7338;7262.891056634155;7381.81545461357;7406.55560666351;7443.032405787213;7471.887921681179;7103.893441598277;7119.85760284781;7143.9285607143265;7162.498625096193;7166.390856777024;6953.374196322356;6996.650167491503;6999.6850141742725;7001.334873187039;7008.369246767816;7419.220981796833;7436.92563074384;7443.739469118772;7446.813829654302;7451.478396512192;4685.742284174403;4808.927866081942;4833.226683730586;4834.178189707688;4861.975690121527;7009.369156775914;7036;7041.5775053496955;7047.47143964215;7078.433725302067;6813.454923606;6818.795436136924;6829.6243706596615;6833.794986150423;6839.555428897106;6761.68147211289;6763.661816909036;6764.004618637612;6771.661416929035;6777.423918966943;6589.703463344065;6708.932910670831;6719.428848547928;6736.5958042517605;6749.5612785168805;6797.864042719019;6831.487638427038;6835.521513494008;6850.691718872563;6865.965670171817;6569.146011018537;6630.701618427279;6668;6670.099536562502;6672.5329226953645 17:18:45 INFO - PROCESS | 4601 | |5;yui.html;845.3406343052419;856.1395797223787;925.7361651929201;930.6928713524534;940.2571968145165;14502.492412765556;14554.854451455481;14596.927015364909;14644.853551464483;14651.633709157277;14219.857801421982;14273.78589321161;14292.928535357334;14299.285035748197;14315;786.5320134519951;914.2046419614944;920.2224120618084;928.8049509602992;931.3340961212765;922.40504874356;922.4741897118645;922.6447817590242;927.8097989912052;932.5896605493562;987.377951890308;987.669130841169;989.6635144051021;993.7068564773373;993.7813680990171;980.1864452504476;980.3725615606018;982.5627595719943;983.3460748602171;985.8176237396069;730.8940203670438;733.4499125655758;733.4792297468804;734.6069852628818;735.7388127214869;14997.550073497703;15055.171965542;15083.095014299068;15099.698006039818;15107.622309442242;14233.715325693533;14263.144211347353;14393;14466.638334041629;14628.634284142876;11585.594504192397;11604.535818567332;11742;11792.705182370424;11843.763124737457;3795.3927371620684;3807.2956503047026;3836.731428799985;3857.24783667185;3914.8825535233987;51170;51243;51395.48604513982;52687;53724.92550149014;10994.51265756904;11099.667009989713;11342.489587968395;11374.203805733685;11435.485403156712;20487.38537843867;20519.4870128248;20522.179112835616;20638.174473021212;20709.896450517652;7416.110066791912;7628.771136865903;7682.231776822273;7750.263724946121;7782.338501227459;4016.6184212499766;4075.4294398784195;4094.201630682048;4158.438610787565;4180.268453020709;3397.2016576104597;3401.727861771052;3417.991692450733;3424.126847653832;3437.5359326491102;589.949854262384;609.3510411411833;610.9847253818601;620.6493331267819;620.9472194863487;611.3886113886114;683.6513378177166;691.830501527119;714.7855643306987;743.2196193996282;8981.14679105484;8982.775430614287;9066.818663626822;9118.81762364749;9648.71053868385;745.9888101678479;748.3900620993873;755.8677231484468;759.1004659478535;766.6588368176108;4377.474703035656;4380.080183161508;4402.3836662867225;4474.574915383034;4475.910481790346;55603.72198139064;56530;58252.41747582555;58397;59510.10734838981;50930.490695093315;51795.48204517982;52537;52606.473935260925;52651;46308.5369146311;46549.53450465452;46744.766276168404;47548;48326.27510587344;8409.537475438665;8556.957215213884;8678.479291242546;8785.956070219863;9004.36969412135;35676.46485302774;36163.63836361708;36527.086822828576;37096.44355334618;37131.25737485289;39910.60089399069;40384.1923161541;43407.13185736331;44232.557674422846;45246.321305179794;9863.556139973574;10448.425336606255;11163.441827908735;11191.552337906392;11657.417129143678;10247.231457640557;10418.73953151147;10950.945245273722;11375.488103035217;11633.825492617449;10643.467826608483;11034.172437067413;11304.491297891778;11309.943450282695;11656.358900260568;10333.328333658288;10718.946405267923;10841.241113122322;10969.725756856142;11231.26996745209;10880.45597720095;10969;11327.092401566091;11360.829587556029;11378.886211138113;8946.86579701318;9048.321375896965;9086.909130908607;9120.726378208665;9160.725178244664;8792.868106978529;9081.591328390106;9154.908450915405;9222;9224.538773061455 17:18:45 INFO - PROCESS | 4601 | __end_tp_report 17:18:45 INFO - PROCESS | 4601 | __start_cc_report 17:18:45 INFO - PROCESS | 4601 | _x_x_mozilla_cycle_collect,348 17:18:45 INFO - PROCESS | 4601 | __end_cc_report 17:18:45 INFO - PROCESS | 4601 | __startTimestamp1459210725818__endTimestamp 17:18:45 INFO - PROCESS | 4601 | 17:18:45 INFO - PROCESS | 4601 | ------- Summary: start ------- 17:18:45 INFO - PROCESS | 4601 | Number of tests: 6 17:18:45 INFO - PROCESS | 4601 | 17:18:45 INFO - PROCESS | 4601 | [#0] dojo.html Cycles:165 Average:5536.47 Median:5725.89 stddev:619.66 (10.8%) stddev-sans-first:596.42 17:18:45 INFO - PROCESS | 4601 | Values: 3309.1 3396.0 3410.7 3425.0 3433.9 5454.8 5457.0 5492.3 5492.9 5548.3 5458.7 5504.2 5507.4 5517.5 5532.5 5046.2 5047.6 5105.1 5105.2 5126.4 4967.3 5050.4 5083.8 5196.7 5240.2 5016.5 5034.7 5087.9 5124.0 5141.1 5132.4 5135.5 5144.8 5147.0 5147.9 4905.6 4918.2 5124.2 5131.3 5161.4 5295.4 5332.3 5334.9 5351.9 5352.5 5841.5 5854.4 5870.5 5902.5 5915.8 5807.5 5928.3 5972.9 6023.6 6068.7 5567.1 5626.1 5627.7 5633.9 5635.3 6093.5 6106.3 6107.6 6114.9 6123.0 5690.3 5892.7 5924.7 5929.6 5980.9 5950.4 5962.3 5981.9 5991.4 6006.1 5718.6 5902.0 5905.3 5945.1 5953.7 5953.4 6016.0 6024.3 6026.9 6057.1 4512.5 4513.8 4539.8 4550.1 4579.0 3996.3 4034.3 4037.8 4068.1 4081.4 5521.8 5573.7 5584.5 5714.5 5845.7 5942.8 5943.1 5986.1 6010.3 6032.6 5650.2 5662.8 5677.1 5683.8 5725.1 4907.9 4980.2 4985.4 5028.6 5094.1 6210.8 6223.5 6272.2 6280.5 6291.6 6030.3 6055.5 6057.8 6061.9 6063.7 5938.9 6123.2 6134.7 6199.8 6244.9 5865.8 5871.0 5894.7 5901.2 5939.0 5952.6 5984.4 6023.5 6025.0 6031.2 5685.0 5812.6 5838.9 5843.4 5911.6 5794.4 5818.4 5840.7 5841.2 5857.0 5725.9 5775.5 5784.7 5786.6 5798.0 5733.9 5845.1 5857.2 5885.2 5966.8 5659.9 5673.0 5685.7 5691.5 5702.0 17:18:45 INFO - PROCESS | 4601 | 17:18:45 INFO - PROCESS | 4601 | [#1] ext.html Cycles:180 Average:58370.28 Median:40926.80 stddev:122729.29 (299.9%) stddev-sans-first:122996.81 17:18:45 INFO - PROCESS | 4601 | Values: 552.7 555.8 571.5 593.2 649.8 38670.4 40347.4 40347.8 40357.4 40414.0 41715.5 42472.8 42499.6 42600.6 42613.6 8766.2 8863.0 8866.8 8920.7 8924.9 8744.1 9019.2 9052.4 9102.3 9108.9 9061.7 9062.5 9162.4 9184.2 9197.1 9022.1 9120.9 9129.9 9134.9 9172.8 9052.0 9121.7 9141.0 9167.1 9170.0 35350.5 40922.0 41790.4 41801.0 41807.0 3507.7 3811.2 4055.6 4542.6 4585.0 29211.3 29331.9 29680.7 29723.6 29882.7 3946.4 4027.7 4059.3 4087.5 4137.4 265610.0 266500.0 268667.0 268745.0 269786.0 46964.0 47531.5 65625.7 65643.3 66023.7 45604.8 45621.5 46041.5 46059.5 46107.1 16261.6 16525.2 16568.0 16589.3 16621.8 13411.1 13451.4 13459.5 13496.0 13501.3 15688.8 16178.8 16200.5 16263.8 16274.0 6313.2 6371.4 6484.4 6550.5 6568.7 1070.5 1083.5 1101.5 1132.7 1155.0 30272.3 30774.4 30847.6 30952.5 31320.2 1182.8 1183.3 1205.3 1225.3 1301.4 15698.0 15743.4 16010.7 16185.6 16202.1 582728.0 588937.0 589871.0 591242.0 919708.0 65141.3 65625.7 66165.3 66241.7 66288.3 1480.0 1483.6 1494.3 1500.3 1501.6 32429.0 32655.8 32843.7 32976.0 33861.2 52257.0 53087.7 53209.5 53212.0 53276.2 328478.0 332609.0 332961.0 333481.0 333989.0 36196.8 36697.0 49923.5 50604.5 50717.7 46014.5 48972.8 49576.3 49622.5 50041.7 39856.6 40987.6 41361.6 41459.6 41680.6 40724.0 40873.8 41621.6 41723.2 41965.8 40646.6 40664.0 40931.6 41350.6 41484.2 35157.6 35761.3 36063.8 36264.3 36333.5 27484.7 27862.9 28220.7 28300.2 28318.2 17:18:45 INFO - PROCESS | 4601 | 17:18:45 INFO - PROCESS | 4601 | [#2] jquery.html Cycles:180 Average:28368.56 Median:13562.26 stddev:76091.36 (561.1%) stddev-sans-first:76275.81 17:18:45 INFO - PROCESS | 4601 | Values: 385.7 386.1 386.2 395.8 397.8 17712.8 19934.7 20533.2 20570.9 20602.8 18305.0 18963.4 19122.5 19267.7 19330.0 5681.1 5842.7 5865.1 5887.0 5890.3 4326.4 6229.3 6431.3 6458.5 6471.1 6379.7 6392.4 6396.7 6401.5 6821.4 7082.6 7085.9 7115.8 7117.1 7123.1 6755.5 6778.7 6814.7 6816.9 6828.2 22952.9 23124.4 24242.6 24552.1 24644.6 2479.9 2535.3 2586.5 2592.8 3152.5 14368.4 14407.2 14739.6 15504.9 15728.1 2069.6 2093.8 2106.4 2119.5 2159.4 81093.0 81110.6 84945.6 85528.0 86024.0 16937.7 17561.2 17648.7 17659.7 17695.9 27927.3 28087.2 28264.2 28426.1 28495.3 10174.0 10499.4 10526.6 10546.3 10618.5 9122.4 9140.0 9178.3 9243.0 9249.3 8408.5 8628.3 8709.4 8739.5 8746.1 1900.1 1964.4 1974.2 1976.1 1992.6 953.3 999.5 1016.6 1027.6 1114.4 17633.7 17818.4 18126.4 18204.4 18535.9 1009.9 1050.7 1074.2 1077.5 1118.3 10215.8 10353.2 10429.9 10585.9 10623.0 455539.0 461919.0 462167.0 467411.0 470364.0 75381.0 77511.0 77608.2 78286.2 79074.6 1043.2 1048.2 1050.0 1056.4 1077.7 16261.5 16264.3 16478.5 16481.5 16817.2 33476.3 34437.5 35711.3 36006.3 36236.3 49657.8 49803.8 50227.0 50570.5 50868.5 8328.4 8473.8 8488.1 8526.7 8531.8 9802.7 12199.9 12596.1 12662.3 12692.1 10759.6 10894.4 10971.9 10990.8 11087.0 10583.9 10669.6 10858.9 10905.3 10936.9 11004.2 11163.3 11181.7 11282.3 11354.0 7538.9 8072.8 8131.6 8209.6 8544.0 8360.3 10107.4 10970.8 11120.6 11346.3 17:18:45 INFO - PROCESS | 4601 | 17:18:45 INFO - PROCESS | 4601 | [#3] mootools.html Cycles:180 Average:5873.30 Median:6101.74 stddev:3056.74 (50.1%) stddev-sans-first:3048.31 17:18:45 INFO - PROCESS | 4601 | Values: 1583.8 1616.0 1887.0 1937.0 1988.5 7499.1 7838.5 8158.3 8352.5 8362.7 8088.5 8153.1 8162.5 8173.6 8180.2 2484.0 2494.5 2515.5 2515.6 2520.0 2410.2 2474.1 2479.7 2488.9 2500.7 2460.4 2461.0 2470.8 2471.2 2486.7 2429.4 2431.9 2458.4 2495.3 2499.7 2436.7 2463.8 2466.6 2468.5 2497.8 8298.0 8341.0 8345.4 8393.9 8397.5 5210.7 5313.0 5318.7 5361.2 5409.2 3069.7 3093.0 3165.7 3178.2 3197.5 954.4 960.8 974.4 993.4 994.1 11574.7 11581.6 11589.3 11606.2 11618.9 4540.7 4649.8 4670.0 4705.4 4784.8 9844.5 9875.2 9879.2 9924.7 9976.7 5190.5 5210.5 5222.0 5222.1 5222.2 4305.5 4597.5 4624.7 4627.4 4742.4 4051.3 4072.4 4106.8 4112.1 4153.4 1261.3 1263.1 1277.6 1286.1 1297.4 1462.8 1480.3 1492.6 1509.3 1530.0 8064.1 8141.8 8169.3 8177.4 8187.4 553.3 556.7 557.8 563.3 563.3 6085.5 6087.8 6115.6 6118.8 6150.4 9581.7 10219.0 10244.0 10279.5 10337.3 10097.0 10116.0 10137.0 10178.7 10217.1 7770.3 7878.3 7902.0 7962.5 7992.4 8025.2 8055.0 8081.4 8120.1 8179.1 8957.6 8984.7 9039.5 9100.8 9105.2 8843.7 9038.0 9463.8 9552.9 9645.6 6628.1 6872.4 7065.5 7150.2 7291.0 8075.2 8120.8 8145.8 8151.7 8161.2 7234.7 7491.6 7501.7 7524.4 7571.4 7057.7 7058.2 7091.2 7136.0 7160.4 7516.4 7551.1 7553.0 7566.2 7581.2 6757.6 6824.0 6865.5 6868.1 6878.0 6832.8 6877.8 6938.3 6949.3 6972.4 17:18:45 INFO - PROCESS | 4601 | 17:18:45 INFO - PROCESS | 4601 | [#4] prototype.html Cycles:180 Average:5704.85 Median:6500.21 stddev:1732.64 (26.7%) stddev-sans-first:1690.63 17:18:45 INFO - PROCESS | 4601 | Values: 371.8 377.2 378.7 379.3 384.4 6322.5 6427.0 6428.9 6454.8 6462.3 6301.0 6340.3 6340.5 6344.0 6366.4 4719.3 4849.5 4901.0 4910.0 4925.7 4867.3 4873.0 4881.1 4882.1 4884.4 4810.6 4812.0 4838.5 4846.8 4848.9 4830.1 4838.5 4841.6 4855.3 4865.8 4229.3 4259.6 4274.3 4274.9 4275.5 5943.2 6058.0 6067.6 6076.7 6079.1 5669.6 5682.3 5685.5 5688.7 5693.5 6688.1 6690.3 6716.8 6729.7 6754.9 4717.1 4721.2 4722.6 4723.8 4729.7 7001.3 7072.8 7077.9 7078.6 7090.4 4729.4 4811.3 4825.6 4836.4 4855.4 4784.1 4884.0 4884.8 4887.1 4923.8 5590.7 5618.3 5636.4 5638.5 5641.2 6787.8 6788.4 6806.5 6812.6 6837.5 1700.0 1732.6 1735.9 1739.1 1744.3 1132.2 1144.7 1156.4 1170.7 1176.1 6518.4 6540.8 6554.7 6555.5 6584.8 6914.6 6935.7 6947.5 6960.2 6979.8 6482.0 6564.8 6683.9 6690.8 6693.5 3779.2 3838.0 3842.1 3849.8 3866.3 7465.0 7475.3 7479.3 7479.7 7484.7 7281.1 7294.5 7302.8 7317.6 7338.0 7262.9 7381.8 7406.6 7443.0 7471.9 7103.9 7119.9 7143.9 7162.5 7166.4 6953.4 6996.7 6999.7 7001.3 7008.4 7419.2 7436.9 7443.7 7446.8 7451.5 4685.7 4808.9 4833.2 4834.2 4862.0 7009.4 7036.0 7041.6 7047.5 7078.4 6813.5 6818.8 6829.6 6833.8 6839.6 6761.7 6763.7 6764.0 6771.7 6777.4 6589.7 6708.9 6719.4 6736.6 6749.6 6797.9 6831.5 6835.5 6850.7 6866.0 6569.1 6630.7 6668.0 6670.1 6672.5 17:18:45 INFO - PROCESS | 4601 | 17:18:45 INFO - PROCESS | 4601 | [#5] yui.html Cycles:180 Average:14218.00 Median:46647.15 stddev:16242.76 (34.8%) stddev-sans-first:16257.28 17:18:45 INFO - PROCESS | 4601 | Values: 845.3 856.1 925.7 930.7 940.3 14502.5 14554.9 14596.9 14644.9 14651.6 14219.9 14273.8 14292.9 14299.3 14315.0 786.5 914.2 920.2 928.8 931.3 922.4 922.5 922.6 927.8 932.6 987.4 987.7 989.7 993.7 993.8 980.2 980.4 982.6 983.3 985.8 730.9 733.4 733.5 734.6 735.7 14997.6 15055.2 15083.1 15099.7 15107.6 14233.7 14263.1 14393.0 14466.6 14628.6 11585.6 11604.5 11742.0 11792.7 11843.8 3795.4 3807.3 3836.7 3857.2 3914.9 51170.0 51243.0 51395.5 52687.0 53724.9 10994.5 11099.7 11342.5 11374.2 11435.5 20487.4 20519.5 20522.2 20638.2 20709.9 7416.1 7628.8 7682.2 7750.3 7782.3 4016.6 4075.4 4094.2 4158.4 4180.3 3397.2 3401.7 3418.0 3424.1 3437.5 589.9 609.4 611.0 620.6 620.9 611.4 683.7 691.8 714.8 743.2 8981.1 8982.8 9066.8 9118.8 9648.7 746.0 748.4 755.9 759.1 766.7 4377.5 4380.1 4402.4 4474.6 4475.9 55603.7 56530.0 58252.4 58397.0 59510.1 50930.5 51795.5 52537.0 52606.5 52651.0 46308.5 46549.5 46744.8 47548.0 48326.3 8409.5 8557.0 8678.5 8786.0 9004.4 35676.5 36163.6 36527.1 37096.4 37131.3 39910.6 40384.2 43407.1 44232.6 45246.3 9863.6 10448.4 11163.4 11191.6 11657.4 10247.2 10418.7 10950.9 11375.5 11633.8 10643.5 11034.2 11304.5 11309.9 11656.4 10333.3 10718.9 10841.2 10969.7 11231.3 10880.5 10969.0 11327.1 11360.8 11378.9 8946.9 9048.3 9086.9 9120.7 9160.7 8792.9 9081.6 9154.9 9222.0 9224.5 17:18:45 INFO - PROCESS | 4601 | -------- Summary: end -------- 17:18:45 INFO - PROCESS | 4601 | 17:18:46 INFO - TEST-INFO | 4601: exit 0 17:18:46 INFO - TEST-OK | dromaeo_css | took 1110122ms 17:18:46 INFO - TEST-START | kraken 17:18:46 INFO - operating with platform_type : linux_ 17:18:46 INFO - Initialising browser for kraken test... 17:18:46 INFO - TEST-INFO | started process 4850 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmposZ1bl/profile http://localhost:58336/getInfo.html) 17:18:50 INFO - PROCESS | 4850 | 17:18:50 INFO - PROCESS | 4850 | (process:4923): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:18:51 INFO - PROCESS | 4850 | __metrics Screen width/height:1600/1200 17:18:51 INFO - PROCESS | 4850 | colorDepth:24 17:18:51 INFO - PROCESS | 4850 | Browser inner width/height: 1024/697 17:18:51 INFO - PROCESS | 4850 | __metrics 17:18:51 ERROR - PROCESS | 4850 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:18:52 INFO - TEST-INFO | 4850: exit 0 17:18:52 INFO - Browser initialized. 17:18:52 INFO - Running cycle 1/1 for kraken test... 17:18:52 INFO - TEST-INFO | started process 4974 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmposZ1bl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:54 INFO - PROCESS | 4974 | 17:18:54 INFO - PROCESS | 4974 | (process:5044): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:19:04 INFO - PROCESS | 4974 | RSS: Main: 153600000 17:19:04 INFO - PROCESS | 4974 | 17:19:07 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58336/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:07 INFO - PROCESS | 4974 | RSS: Main: 158216192 17:19:07 INFO - PROCESS | 4974 | 17:19:10 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58336/tests/kraken/driver.html?testName=audio-dft) 17:19:10 INFO - PROCESS | 4974 | RSS: Main: 158597120 17:19:10 INFO - PROCESS | 4974 | 17:19:13 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58336/tests/kraken/driver.html?testName=audio-fft) 17:19:14 INFO - PROCESS | 4974 | RSS: Main: 159141888 17:19:14 INFO - PROCESS | 4974 | 17:19:16 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58336/tests/kraken/driver.html?testName=audio-oscillator) 17:19:17 INFO - PROCESS | 4974 | RSS: Main: 158265344 17:19:17 INFO - PROCESS | 4974 | 17:19:19 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58336/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:19:19 INFO - PROCESS | 4974 | RSS: Main: 158101504 17:19:19 INFO - PROCESS | 4974 | 17:19:22 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58336/tests/kraken/driver.html?testName=imaging-darkroom) 17:19:23 INFO - PROCESS | 4974 | RSS: Main: 159436800 17:19:23 INFO - PROCESS | 4974 | 17:19:26 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58336/tests/kraken/driver.html?testName=imaging-desaturate) 17:19:27 INFO - PROCESS | 4974 | RSS: Main: 159678464 17:19:27 INFO - PROCESS | 4974 | 17:19:30 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58336/tests/kraken/driver.html?testName=json-parse-financial) 17:19:30 INFO - PROCESS | 4974 | RSS: Main: 159715328 17:19:30 INFO - PROCESS | 4974 | 17:19:32 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58336/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:19:33 INFO - PROCESS | 4974 | RSS: Main: 160026624 17:19:33 INFO - PROCESS | 4974 | 17:19:34 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58336/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:19:35 INFO - PROCESS | 4974 | RSS: Main: 158498816 17:19:35 INFO - PROCESS | 4974 | 17:19:37 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58336/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:19:38 INFO - PROCESS | 4974 | RSS: Main: 159141888 17:19:38 INFO - PROCESS | 4974 | 17:19:40 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:19:41 INFO - PROCESS | 4974 | RSS: Main: 158703616 17:19:41 INFO - PROCESS | 4974 | 17:19:43 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:19:44 INFO - PROCESS | 4974 | RSS: Main: 158838784 17:19:44 INFO - PROCESS | 4974 | 17:19:45 INFO - PROCESS | 4974 | Cycle 1(1): loaded http://localhost:58336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58336/tests/kraken/driver.html?testName=ai-astar) 17:19:46 INFO - PROCESS | 4974 | RSS: Main: 160305152 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | __start_tp_report 17:19:46 INFO - PROCESS | 4974 | _x_x_mozilla_page_load 17:19:46 INFO - PROCESS | 4974 | _x_x_mozilla_page_load_details 17:19:46 INFO - PROCESS | 4974 | |i|pagename|runs| 17:19:46 INFO - PROCESS | 4974 | |0;ai-astar;113;106;110;112;112;122;110;112;112;113 17:19:46 INFO - PROCESS | 4974 | |1;audio-beat-detection;154;125;152;167;128;155;156;127;179;128 17:19:46 INFO - PROCESS | 4974 | |2;audio-dft;162;162;161;162;162;160;162;162;168;160 17:19:46 INFO - PROCESS | 4974 | |3;audio-fft;77;76;75;161;75;74;74;76;159;73 17:19:46 INFO - PROCESS | 4974 | |4;audio-oscillator;93;94;146;92;93;93;138;95;94;143 17:19:46 INFO - PROCESS | 4974 | |5;imaging-gaussian-blur;117;118;117;117;117;117;116;117;117;117 17:19:46 INFO - PROCESS | 4974 | |6;imaging-darkroom;147;147;149;146;147;147;146;147;146;146 17:19:46 INFO - PROCESS | 4974 | |7;imaging-desaturate;96;96;96;96;98;96;97;97;97;97 17:19:46 INFO - PROCESS | 4974 | |8;json-parse-financial;58;57;56;57;67;59;57;63;56;56 17:19:46 INFO - PROCESS | 4974 | |9;json-stringify-tinderbox;64;65;64;64;66;69;65;65;65;66 17:19:46 INFO - PROCESS | 4974 | |10;stanford-crypto-aes;79;78;80;81;80;80;79;85;79;78 17:19:46 INFO - PROCESS | 4974 | |11;stanford-crypto-ccm;117;114;111;113;128;116;113;114;117;114 17:19:46 INFO - PROCESS | 4974 | |12;stanford-crypto-pbkdf2;136;143;143;141;148;153;147;134;142;136 17:19:46 INFO - PROCESS | 4974 | |13;stanford-crypto-sha256-iterative;65;69;68;66;67;67;67;67;66;65 17:19:46 INFO - PROCESS | 4974 | __end_tp_report 17:19:46 INFO - PROCESS | 4974 | __start_cc_report 17:19:46 INFO - PROCESS | 4974 | _x_x_mozilla_cycle_collect,828 17:19:46 INFO - PROCESS | 4974 | __end_cc_report 17:19:46 INFO - PROCESS | 4974 | __startTimestamp1459210786078__endTimestamp 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | ------- Summary: start ------- 17:19:46 INFO - PROCESS | 4974 | Number of tests: 14 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:4.02 (3.6%) stddev-sans-first:4.26 17:19:46 INFO - PROCESS | 4974 | Values: 113.0 106.0 110.0 112.0 112.0 122.0 110.0 112.0 112.0 113.0 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:154.50 stddev:19.00 (12.3%) stddev-sans-first:19.99 17:19:46 INFO - PROCESS | 4974 | Values: 154.0 125.0 152.0 167.0 128.0 155.0 156.0 127.0 179.0 128.0 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:2.23 (1.4%) stddev-sans-first:2.37 17:19:46 INFO - PROCESS | 4974 | Values: 162.0 162.0 161.0 162.0 162.0 160.0 162.0 162.0 168.0 160.0 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#3] audio-fft Cycles:10 Average:92.00 Median:75.00 stddev:35.86 (47.8%) stddev-sans-first:37.62 17:19:46 INFO - PROCESS | 4974 | Values: 77.0 76.0 75.0 161.0 75.0 74.0 74.0 76.0 159.0 73.0 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:93.00 stddev:23.71 (25.5%) stddev-sans-first:24.51 17:19:46 INFO - PROCESS | 4974 | Values: 93.0 94.0 146.0 92.0 93.0 93.0 138.0 95.0 94.0 143.0 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 17:19:46 INFO - PROCESS | 4974 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 17:19:46 INFO - PROCESS | 4974 | Values: 147.0 147.0 149.0 146.0 147.0 147.0 146.0 147.0 146.0 146.0 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 17:19:46 INFO - PROCESS | 4974 | Values: 96.0 96.0 96.0 96.0 98.0 96.0 97.0 97.0 97.0 97.0 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:57.50 stddev:3.63 (6.3%) stddev-sans-first:3.84 17:19:46 INFO - PROCESS | 4974 | Values: 58.0 57.0 56.0 57.0 67.0 59.0 57.0 63.0 56.0 56.0 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:1.49 (2.3%) stddev-sans-first:1.51 17:19:46 INFO - PROCESS | 4974 | Values: 64.0 65.0 64.0 64.0 66.0 69.0 65.0 65.0 65.0 66.0 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:2.02 (2.5%) stddev-sans-first:2.12 17:19:46 INFO - PROCESS | 4974 | Values: 79.0 78.0 80.0 81.0 80.0 80.0 79.0 85.0 79.0 78.0 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:115.00 stddev:4.72 (4.1%) stddev-sans-first:4.98 17:19:46 INFO - PROCESS | 4974 | Values: 117.0 114.0 111.0 113.0 128.0 116.0 113.0 114.0 117.0 114.0 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:143.00 stddev:5.96 (4.2%) stddev-sans-first:5.87 17:19:46 INFO - PROCESS | 4974 | Values: 136.0 143.0 143.0 141.0 148.0 153.0 147.0 134.0 142.0 136.0 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - PROCESS | 4974 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.17 17:19:46 INFO - PROCESS | 4974 | Values: 65.0 69.0 68.0 66.0 67.0 67.0 67.0 67.0 66.0 65.0 17:19:46 INFO - PROCESS | 4974 | -------- Summary: end -------- 17:19:46 INFO - PROCESS | 4974 | 17:19:46 INFO - TEST-INFO | 4974: exit 0 17:19:47 INFO - TEST-OK | kraken | took 60523ms 17:19:47 INFO - SUITE-END | took 1170s 17:19:47 INFO - Completed test suite (00:19:30) 17:19:47 INFO - javascript benchmark 17:19:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3309.1396236978385, 3395.9830200849, 3410.67598578135, 3424.982875085624, 3433.914152146196, 5454.836354909349, 5456.972715136424, 5492.313460817398, 5492.890142197154, 5548.250986116873, 5458.699771512565, 5504.2018907258425, 5507.421720719327, 5517.475839795223, 5532.529734972532, 5046.167382381903, 5047.621428392867, 5105.081085404626, 5105.2086926526445, 5126.410462796789, 4967.304577359173, 5050.419201791786, 5083.7712302946275, 5196.662216955905, 5240.2401651760665, 5016.47327030662, 5034.697918124924, 5087.923681144785, 5123.974380128094, 5141.1003074462005, 5132.435432102466, 5135.486451354872, 5144.819931302386, 5147.0, 5147.871303217412, 4905.558499735005, 4918.213085906238, 5124.205748109049, 5131.307273518065, 5161.4322424533275, 5295.417504074549, 5332.280142180794, 5334.91997620036, 5351.946480535223, 5352.4915133062295, 5841.532677385799, 5854.356020837705, 5870.530357571384, 5902.527797776168, 5915.822525324247, 5807.506361959238, 5928.318243402021, 5972.880542389128, 6023.608465449775, 6068.696565171768, 5567.081431563787, 5626.127950167731, 5627.718614069321, 5633.915491267634, 5635.267415235993, 6093.482054025458, 6106.267247930276, 6107.603005804608, 6114.877702446015, 6123.0, 5690.317161940511, 5892.6759028253855, 5924.7333869975955, 5929.6145750526075, 5980.880382392328, 5950.404959504015, 5962.34414214436, 5981.910271345933, 5991.370906054802, 6006.099085137264, 5718.628289161275, 5901.970490147608, 5905.291365036223, 5945.078512830518, 5953.672548009815, 5953.404659534099, 6015.969920150371, 6024.277086749618, 6026.939730602726, 6057.121717350959, 4512.503624601291, 4513.796879140446, 4539.773011349485, 4550.089982003613, 4578.9542104579195, 3996.2806694795217, 4034.253663072341, 4037.818298176589, 4068.105016896278, 4081.428599996003, 5521.779128834882, 5573.693446860461, 5584.497395234448, 5714.514266287412, 5845.678487683133, 5942.762289508458, 5943.108533719977, 5986.07215881539, 6010.338862725097, 6032.607880487842, 5650.180723795027, 5662.8301150965535, 5677.14842773579, 5683.8010669626365, 5725.055365864669, 4907.9263811042865, 4980.203167493184, 4985.426675932242, 5028.5977121830165, 5094.057599344133, 6210.782622608187, 6223.471004964538, 6272.18461599989, 6280.466160376419, 6291.622502649856, 6030.276366836008, 6055.455009049207, 6057.848553786191, 6061.939380606137, 6063.727132279147, 5938.851528711644, 6123.173371594956, 6134.681512609229, 6199.783007594712, 6244.875102498016, 5865.794697185578, 5870.972579798433, 5894.734736936763, 5901.173835663097, 5939.0, 5952.553558483044, 5984.401559843981, 6023.48800351975, 6024.969875150597, 6031.185789918305, 5685.0335442973965, 5812.564057695605, 5838.94161058384, 5843.386444423444, 5911.645301281937, 5794.362620111869, 5818.418158184148, 5840.737166827588, 5841.153032810304, 5857.033589457692, 5725.885482290414, 5775.537956963349, 5784.739686714024, 5786.566007549366, 5798.0, 5733.8566535836935, 5845.064789633639, 5857.179994800646, 5885.205497257815, 5966.76132954677, 5659.886802264014, 5673.0, 5685.687287199078, 5691.487766100905, 5702.0], "unit": "score", "name": "dojo.html", "value": 5496.371962927231}, {"lowerIsBetter": false, "replicates": [552.7346873500719, 555.8036350507825, 571.4571157400469, 593.1666009256995, 649.7985624456416, 38670.419943700865, 40347.394789078186, 40347.79826100869, 40357.394639080434, 40414.0, 41715.539956101544, 42472.787636061774, 42499.57500424995, 42600.57399426005, 42613.57386426142, 8766.211041006323, 8863.02506724263, 8866.778330541723, 8920.687775927843, 8924.910750892506, 8744.125587441269, 9019.188273055424, 9052.366334356564, 9102.317326200528, 9108.908910910906, 9061.728148155566, 9062.501562414065, 9162.35863489556, 9184.173424391804, 9197.080291970782, 9022.142896424863, 9120.908790912106, 9129.863052054225, 9134.862977055349, 9172.770680732969, 9052.0, 9121.726348209564, 9140.954295228548, 9167.083291670846, 9169.954150229207, 35350.46974295388, 40922.0, 41790.373144402554, 41801.0, 41807.0, 3507.7369197310304, 3811.1615444602144, 4055.5944405559503, 4542.568455996675, 4584.977075114603, 29211.269718257, 29331.853340733374, 29680.70319296801, 29723.554146687817, 29882.70117298821, 3946.427767973628, 4027.6979226557833, 4059.254992128803, 4087.4890638670167, 4137.358709400048, 265610.0, 266500.0, 268667.0, 268745.0, 269786.0, 46964.0, 47531.5246847534, 65625.67187164034, 65643.34356656468, 66023.66988165029, 45604.771976139906, 45621.5437845624, 46041.53958460373, 46059.53940460619, 46107.077858442644, 16261.593460163354, 16525.173741313127, 16568.0, 16589.336426543043, 16621.83378166227, 13411.061225714302, 13451.394687239097, 13459.528916487876, 13496.0, 13501.324933753272, 15688.76466852998, 16178.83821161797, 16200.51398458048, 16263.837361626232, 16274.0, 6313.210848643919, 6371.39471750183, 6484.383983521558, 6550.541462097703, 6568.67156642166, 1070.539667942792, 1083.5070043130356, 1101.5208384352832, 1132.6828488023366, 1154.9595764148214, 30272.271792722047, 30774.384512310076, 30847.61185746647, 30952.535711964338, 31320.21699457532, 1182.8403165572538, 1183.2959389163434, 1205.3129716061935, 1225.307701148848, 1301.4143635364123, 15698.0, 15743.44897928567, 16010.679786404207, 16185.595360115856, 16202.108884011492, 582728.0, 588937.0, 589871.0, 591242.0, 919708.0, 65141.34858651353, 65625.67187164129, 66165.33834661687, 66241.66879165573, 66288.33711662918, 1479.9926000369928, 1483.5994281544138, 1494.2976800903557, 1500.294861415133, 1501.594569466238, 32429.0, 32655.836720816245, 32843.671563284064, 32976.0, 33861.153471163416, 52257.0, 53087.73456132694, 53209.46790532045, 53212.0, 53276.200856987954, 328478.0, 332609.0, 332961.0, 333481.0, 333989.0, 36196.81901590581, 36697.0, 49923.500764991884, 50604.49395505998, 50717.746411267704, 46014.539854601026, 48972.75513622409, 49576.256356155405, 49622.4744585811, 50041.74979125081, 39856.60143398529, 40987.59012409957, 41361.58638413698, 41459.585404145575, 41680.58319416767, 40724.0, 40873.795631021654, 41621.583784162984, 41723.1655366897, 41965.790171048946, 40646.59353406546, 40664.0, 40931.59068409397, 41350.586494135874, 41484.17031659289, 35157.648423515435, 35761.28477430489, 36063.819680901426, 36264.27471450504, 36333.45499817452, 27484.725152749015, 27862.860685696443, 28220.717792821808, 28300.15099547017, 28318.150455486368], "unit": "score", "name": "ext.html", "value": 20056.01727732099}, {"lowerIsBetter": false, "replicates": [385.68566618206154, 386.05416729013905, 386.17166178547035, 395.77045313718037, 397.8189923584769, 17712.822871771277, 19934.700979485282, 20533.178672853086, 20570.89714551429, 20602.793972060274, 18305.0, 18963.43109706711, 19122.521936951583, 19267.710984335212, 19330.03349832506, 5681.119426488901, 5842.737076831531, 5865.149553314767, 5887.028640274371, 5890.322612899528, 4326.394304797331, 6229.314775374705, 6431.260405053432, 6458.483321334282, 6471.061696054069, 6379.74481020761, 6392.360763923593, 6396.680165991682, 6401.487880969535, 6821.351971562718, 7082.610456424894, 7085.89371159433, 7115.8221044473785, 7117.110361204849, 7123.145222573298, 6755.527113102035, 6778.728850845961, 6814.671139127872, 6816.863662726767, 6828.2488926218075, 22952.88523557388, 23124.42188945273, 24242.636360454606, 24552.140675076287, 24644.630330545056, 2479.8884050217785, 2535.29011876673, 2586.456844062749, 2592.7666510014187, 3152.4640811062172, 14368.425262989467, 14407.207603581799, 14739.631509212248, 15504.922475387664, 15728.056316620925, 2069.5653912678204, 2093.7592176899548, 2106.368089573122, 2119.459537817862, 2159.416957421503, 81093.0, 81110.59444702798, 84945.57527212324, 85528.0, 86023.99999999937, 16937.745933811002, 17561.209745561224, 17648.735268970977, 17659.73510397345, 17695.911520442314, 27927.30181745432, 28087.157385278475, 28264.15207543777, 28426.147215583565, 28495.28761780972, 10174.0, 10499.370037797757, 10526.578936842441, 10546.314489558154, 10618.522166502526, 9122.361434699507, 9140.0, 9178.265738740885, 9243.0, 9249.306302027375, 8408.495490270603, 8628.317478091712, 8709.390342675952, 8739.51932643698, 8746.125387461203, 1900.1259420666647, 1964.3910387779833, 1974.19058186143, 1976.1305025788606, 1992.611440769036, 953.2802733935835, 999.4702807512031, 1016.6136867990116, 1027.5838285494237, 1114.3982249585295, 17633.7354939676, 17818.376356827448, 18126.365577204735, 18204.36284730028, 18535.907320463582, 1009.9040591143829, 1050.6637875879644, 1074.231924174219, 1077.466654006272, 1118.2731224704007, 10215.846762298572, 10353.171746260281, 10429.895701043044, 10585.894141058645, 10623.043926046694, 455539.0, 461919.0, 462167.0, 467411.0, 470364.0, 75381.0, 77511.0, 77608.22391776124, 78286.21713782904, 79074.60462697764, 1043.2019505078622, 1048.156234231451, 1050.033968748753, 1056.3556230699267, 1077.7197928538637, 16261.51215463538, 16264.3494260233, 16478.505644830675, 16481.505554832893, 16817.243224054702, 33476.33047339088, 34437.48343774795, 35711.28577428489, 36006.279874401844, 36236.27527449383, 49657.75171124121, 49803.75098124486, 50227.0, 50570.49429505658, 50868.49131508637, 8328.375371847256, 8473.78815529592, 8488.10874858131, 8526.701565445179, 8531.786705332417, 9802.65690700822, 12199.87800122023, 12596.118271720892, 12662.303573303188, 12692.111552191627, 10759.623413180501, 10894.400807955639, 10971.890281097087, 10990.835137473105, 11087.0, 10583.94708026455, 10669.626563070255, 10858.91011196632, 10905.291156074829, 10936.945315273373, 11004.174686898354, 11163.274387164809, 11181.72045698864, 11282.323060616389, 11354.0, 7538.924610753822, 8072.798180045545, 8131.593420328842, 8209.58952052383, 8544.0, 8360.28937540316, 10107.393556386347, 10970.835437468604, 11120.555177792798, 11346.262492937933], "unit": "score", "name": "jquery.html", "value": 9841.627986493853}, {"lowerIsBetter": false, "replicates": [1583.8020247469067, 1616.0303817709375, 1886.9811301886978, 1936.9709454358197, 1988.482994421451, 7499.100107987049, 7838.490498117619, 8158.306543943764, 8352.457090289134, 8362.749117526477, 8088.514689118657, 8153.062397824237, 8162.510249385041, 8173.632186551605, 8180.181981801817, 2484.043643197373, 2494.451220731436, 2515.5220508103494, 2515.63523289123, 2519.962200566993, 2410.192585483865, 2474.134053081425, 2479.727230004698, 2488.8631125288102, 2500.712418071918, 2460.3972026853444, 2461.027893981885, 2470.839395439291, 2471.1721573272976, 2486.7140278867982, 2429.3683642253054, 2431.878406079698, 2458.3731148557094, 2495.3262619092925, 2499.7250302466714, 2436.7197772256063, 2463.81521385895, 2466.580681284186, 2468.543319485901, 2497.8126640501855, 8298.0, 8340.958295208546, 8345.41582089254, 8393.874091888627, 8397.496150231005, 5210.687358758487, 5312.9734351328, 5318.707471089088, 5361.249425080492, 5409.24270602116, 3069.7237248647507, 3093.0102367242494, 3165.699258570432, 3178.2372230664705, 3197.520371944204, 954.3939598355025, 960.8174446855076, 974.3958745577717, 993.4486360070158, 994.1251698505341, 11574.6527604172, 11581.594644187497, 11589.30464172144, 11606.24559403636, 11618.883811161864, 4540.659450541222, 4649.814007439664, 4669.976650116728, 4705.435347758223, 4784.760761961888, 9844.507774611384, 9875.209983201326, 9879.160271377013, 9924.652637157666, 9976.700698979042, 5190.532852043334, 5210.505002024802, 5222.0, 5222.1383471727495, 5222.190560463135, 4305.483341998917, 4597.4712908015335, 4624.722516649012, 4627.398438203079, 4742.359781429463, 4051.311277082903, 4072.3687828386646, 4106.7535947842625, 4112.09533902541, 4153.439285696392, 1261.3251910228169, 1263.128441375448, 1277.552856500236, 1286.1382873474795, 1297.4226469221105, 1462.751332273516, 1480.3486465954945, 1492.55969489001, 1509.3208056374676, 1530.013141523711, 8064.112947575762, 8141.837163256701, 8169.305609023299, 8177.386695997705, 8187.38594605407, 553.3221803290936, 556.7021643420751, 557.8075563930438, 563.2593140020941, 563.3493315220926, 6085.482733967662, 6087.8478038048515, 6115.6330620162935, 6118.847028824226, 6150.415710507495, 9581.664641737645, 10219.0, 10244.02681745233, 10279.486025698685, 10337.328073675188, 10097.0, 10116.0, 10137.0, 10178.745531361776, 10217.080462758388, 7770.300672939463, 7878.330341920886, 7901.960490197513, 7962.522248665098, 7992.36061115121, 8025.197480251928, 8055.033395992518, 8081.434299598972, 8120.106788253405, 8179.059408167899, 8957.641694332415, 8984.685536006209, 9039.45763254207, 9100.817983640423, 9105.180533751995, 8843.690470833748, 9037.954810225907, 9463.763405914908, 9552.90447095548, 9645.565949532147, 6628.105205797348, 6872.41584465326, 7065.470089743187, 7150.249223831631, 7290.9635451822405, 8075.232852878967, 8120.75637730869, 8145.79635509117, 8151.673933042612, 8161.183881611792, 7234.6744396501235, 7491.625418729151, 7501.737439189602, 7524.398048156025, 7571.3564347031115, 7057.7176912922905, 7058.153021637437, 7091.184513780981, 7136.0, 7160.427165826617, 7516.436267279866, 7551.093868735567, 7552.962235188789, 7566.167721550735, 7581.166071731995, 6757.594544327356, 6824.0, 6865.450763938773, 6868.107146070979, 6877.965610171917, 6832.829179270558, 6877.828054298682, 6938.340857618518, 6949.270326615632, 6972.407345375497], "unit": "score", "name": "mootools.html", "value": 4760.90077059294}, {"lowerIsBetter": false, "replicates": [371.7564994928322, 377.1589355736709, 378.69136653627294, 379.2945122072945, 384.3542848015333, 6322.494200463963, 6426.967865160674, 6428.935710642898, 6454.774082907099, 6462.256840463348, 6301.0, 6340.334264902188, 6340.524460665445, 6344.048392741091, 6366.363363663631, 4719.268513380432, 4849.490803465638, 4901.0, 4910.042541704369, 4925.70445773253, 4867.2942423348595, 4872.951270487303, 4881.072596206727, 4882.096812089757, 4884.389451318585, 4810.639202059842, 4812.0375924815, 4838.491958344376, 4846.806127754886, 4848.927266091011, 4830.082284365994, 4838.540338667838, 4841.588464980481, 4855.295982082614, 4865.78103985318, 4229.344451610005, 4259.637930775888, 4274.273373526508, 4274.914501709979, 4275.529691733938, 5943.197668314765, 6058.030715085565, 6067.605605635619, 6076.726547305382, 6079.118527813443, 5669.574781891375, 5682.261306030189, 5685.516731077863, 5688.658680479143, 5693.459121383462, 6688.130543029423, 6690.297518760557, 6716.798496045127, 6729.7308107675635, 6754.932450675479, 4717.080169366975, 4721.24460086388, 4722.5513576210205, 4723.7874295656775, 4729.692569982974, 7001.264867188923, 7072.823179420504, 7077.858442831166, 7078.575285482888, 7090.361867431956, 4729.3683679130645, 4811.326414302001, 4825.565699087099, 4836.443808961944, 4855.417349918032, 4784.114938736345, 4884.0, 4884.780184891689, 4887.0714564232685, 4923.8276660316715, 5590.664560126405, 5618.269624948731, 5636.351819540805, 5638.548916086703, 5641.153826925912, 6787.762428315084, 6788.355106264897, 6806.489513286523, 6812.62530560814, 6837.453003759687, 1699.9745003824953, 1732.5841797968649, 1735.947921562355, 1739.0869793358336, 1744.2935611077535, 1132.1961407400672, 1144.6508814811561, 1156.4449064448943, 1170.6839153428527, 1176.053277111916, 6518.445932095825, 6540.803775886731, 6554.7378104876225, 6555.475561955032, 6584.7695330664155, 6914.585124892523, 6935.6878940446795, 6947.548409353376, 6960.199577048705, 6979.82550436233, 6481.967590162019, 6564.80305590833, 6683.866322673519, 6690.765823196165, 6693.531452798257, 3779.168582911755, 3837.9616203838164, 3842.0779013037227, 3849.7882616456363, 3866.3040652682225, 7465.0, 7475.252474752481, 7479.289467500579, 7479.738209162762, 7484.738034168778, 7281.05346304977, 7294.525855819461, 7302.780916572511, 7317.634118294171, 7338.0, 7262.891056634155, 7381.81545461357, 7406.55560666351, 7443.032405787213, 7471.887921681179, 7103.893441598277, 7119.85760284781, 7143.9285607143265, 7162.498625096193, 7166.390856777024, 6953.374196322356, 6996.650167491503, 6999.6850141742725, 7001.334873187039, 7008.369246767816, 7419.220981796833, 7436.92563074384, 7443.739469118772, 7446.813829654302, 7451.478396512192, 4685.742284174403, 4808.927866081942, 4833.226683730586, 4834.178189707688, 4861.975690121527, 7009.369156775914, 7036.0, 7041.5775053496955, 7047.47143964215, 7078.433725302067, 6813.454923606, 6818.795436136924, 6829.6243706596615, 6833.794986150423, 6839.555428897106, 6761.68147211289, 6763.661816909036, 6764.004618637612, 6771.661416929035, 6777.423918966943, 6589.703463344065, 6708.932910670831, 6719.428848547928, 6736.5958042517605, 6749.5612785168805, 6797.864042719019, 6831.487638427038, 6835.521513494008, 6850.691718872563, 6865.965670171817, 6569.146011018537, 6630.701618427279, 6668.0, 6670.099536562502, 6672.5329226953645], "unit": "score", "name": "prototype.html", "value": 5148.169471428041}, {"lowerIsBetter": false, "replicates": [845.3406343052419, 856.1395797223787, 925.7361651929201, 930.6928713524534, 940.2571968145165, 14502.492412765556, 14554.854451455481, 14596.927015364909, 14644.853551464483, 14651.633709157277, 14219.857801421982, 14273.78589321161, 14292.928535357334, 14299.285035748197, 14315.0, 786.5320134519951, 914.2046419614944, 920.2224120618084, 928.8049509602992, 931.3340961212765, 922.40504874356, 922.4741897118645, 922.6447817590242, 927.8097989912052, 932.5896605493562, 987.377951890308, 987.669130841169, 989.6635144051021, 993.7068564773373, 993.7813680990171, 980.1864452504476, 980.3725615606018, 982.5627595719943, 983.3460748602171, 985.8176237396069, 730.8940203670438, 733.4499125655758, 733.4792297468804, 734.6069852628818, 735.7388127214869, 14997.550073497703, 15055.171965542, 15083.095014299068, 15099.698006039818, 15107.622309442242, 14233.715325693533, 14263.144211347353, 14393.0, 14466.638334041629, 14628.634284142876, 11585.594504192397, 11604.535818567332, 11742.0, 11792.705182370424, 11843.763124737457, 3795.3927371620684, 3807.2956503047026, 3836.731428799985, 3857.24783667185, 3914.8825535233987, 51170.0, 51243.0, 51395.48604513982, 52687.0, 53724.92550149014, 10994.51265756904, 11099.667009989713, 11342.489587968395, 11374.203805733685, 11435.485403156712, 20487.38537843867, 20519.4870128248, 20522.179112835616, 20638.174473021212, 20709.896450517652, 7416.110066791912, 7628.771136865903, 7682.231776822273, 7750.263724946121, 7782.338501227459, 4016.6184212499766, 4075.4294398784195, 4094.201630682048, 4158.438610787565, 4180.268453020709, 3397.2016576104597, 3401.727861771052, 3417.991692450733, 3424.126847653832, 3437.5359326491102, 589.949854262384, 609.3510411411833, 610.9847253818601, 620.6493331267819, 620.9472194863487, 611.3886113886114, 683.6513378177166, 691.830501527119, 714.7855643306987, 743.2196193996282, 8981.14679105484, 8982.775430614287, 9066.818663626822, 9118.81762364749, 9648.71053868385, 745.9888101678479, 748.3900620993873, 755.8677231484468, 759.1004659478535, 766.6588368176108, 4377.474703035656, 4380.080183161508, 4402.3836662867225, 4474.574915383034, 4475.910481790346, 55603.72198139064, 56530.0, 58252.41747582555, 58397.0, 59510.10734838981, 50930.490695093315, 51795.48204517982, 52537.0, 52606.473935260925, 52651.0, 46308.5369146311, 46549.53450465452, 46744.766276168404, 47548.0, 48326.27510587344, 8409.537475438665, 8556.957215213884, 8678.479291242546, 8785.956070219863, 9004.36969412135, 35676.46485302774, 36163.63836361708, 36527.086822828576, 37096.44355334618, 37131.25737485289, 39910.60089399069, 40384.1923161541, 43407.13185736331, 44232.557674422846, 45246.321305179794, 9863.556139973574, 10448.425336606255, 11163.441827908735, 11191.552337906392, 11657.417129143678, 10247.231457640557, 10418.73953151147, 10950.945245273722, 11375.488103035217, 11633.825492617449, 10643.467826608483, 11034.172437067413, 11304.491297891778, 11309.943450282695, 11656.358900260568, 10333.328333658288, 10718.946405267923, 10841.241113122322, 10969.725756856142, 11231.26996745209, 10880.45597720095, 10969.0, 11327.092401566091, 11360.829587556029, 11378.886211138113, 8946.86579701318, 9048.321375896965, 9086.909130908607, 9120.726378208665, 9160.725178244664, 8792.868106978529, 9081.591328390106, 9154.908450915405, 9222.0, 9224.538773061455], "unit": "score", "name": "yui.html", "value": 6667.992654264458}], "name": "dromaeo_css", "value": 7495.3821537902295}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 110.0, 112.0, 112.0, 122.0, 110.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [154.0, 125.0, 152.0, 167.0, 128.0, 155.0, 156.0, 127.0, 179.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 162.0, 162.0, 160.0, 162.0, 162.0, 168.0, 160.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 75.0, 161.0, 75.0, 74.0, 74.0, 76.0, 159.0, 73.0], "unit": "score", "name": "audio-fft", "value": 92.0}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 146.0, 92.0, 93.0, 93.0, 138.0, 95.0, 94.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 149.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 97.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 56.0, 57.0, 67.0, 59.0, 57.0, 63.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 66.0, 69.0, 65.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.3}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 80.0, 81.0, 80.0, 80.0, 79.0, 85.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [117.0, 114.0, 111.0, 113.0, 128.0, 116.0, 113.0, 114.0, 117.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.7}, {"lowerIsBetter": true, "replicates": [136.0, 143.0, 143.0, 141.0, 148.0, 153.0, 147.0, 134.0, 142.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 68.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1510.4}]} 17:19:47 INFO - Return code: 0 17:19:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:19:47 ERROR - # TBPL SUCCESS # 17:19:47 INFO - Running post-action listener: _resource_record_post_action 17:19:47 INFO - Running post-run listener: _resource_record_post_run 17:19:48 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 692224; Write bytes: 250306560; Read time: 76; Write time: 169800 17:19:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 1282048; Read time: 0; Write time: 48 17:19:48 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 692224; Write bytes: 249024512; Read time: 76; Write time: 169752 17:19:48 INFO - Running post-run listener: _upload_blobber_files 17:19:48 INFO - Blob upload gear active. 17:19:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:19:48 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 17:19:48 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'] 17:19:48 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 17:19:49 INFO - (blobuploader) - INFO - Open directory for files ... 17:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:19:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:50 INFO - (blobuploader) - INFO - Done attempting. 17:19:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:19:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:19:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:51 INFO - (blobuploader) - INFO - Done attempting. 17:19:51 INFO - (blobuploader) - INFO - Iteration through files over. 17:19:51 INFO - Return code: 0 17:19:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:19:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:19:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74d883c97b62d14f2cc4216efdcafd03ca29945636abcb1252b6db455628d938ef2796469237d330dc7e9830811beeaa60d16a55a55c822fb22a8749dd123cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d55190ee740212870f2b3d670dbcdfcdcf160e83347269e2c250c3e88b7fa09ec66a278b7968e1ecda778df3938672900ff5567efcbd9ee9f8816b20d0f2471e"} 17:19:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:19:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:19:51 INFO - Contents: 17:19:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74d883c97b62d14f2cc4216efdcafd03ca29945636abcb1252b6db455628d938ef2796469237d330dc7e9830811beeaa60d16a55a55c822fb22a8749dd123cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d55190ee740212870f2b3d670dbcdfcdcf160e83347269e2c250c3e88b7fa09ec66a278b7968e1ecda778df3938672900ff5567efcbd9ee9f8816b20d0f2471e"} 17:19:51 INFO - Running post-run listener: copy_logs_to_upload_dir 17:19:51 INFO - Copying logs to upload dir... 17:19:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:19:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.527201 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-28 17:19:51.240005) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 17:19:51.244080) ========= 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-1459207941.965837-184654313 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/74d883c97b62d14f2cc4216efdcafd03ca29945636abcb1252b6db455628d938ef2796469237d330dc7e9830811beeaa60d16a55a55c822fb22a8749dd123cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d55190ee740212870f2b3d670dbcdfcdcf160e83347269e2c250c3e88b7fa09ec66a278b7968e1ecda778df3938672900ff5567efcbd9ee9f8816b20d0f2471e"} build_url:https://queue.taskcluster.net/v1/task/E0st9XR7R8iVkHxum4rDig/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/E0st9XR7R8iVkHxum4rDig/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/74d883c97b62d14f2cc4216efdcafd03ca29945636abcb1252b6db455628d938ef2796469237d330dc7e9830811beeaa60d16a55a55c822fb22a8749dd123cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d55190ee740212870f2b3d670dbcdfcdcf160e83347269e2c250c3e88b7fa09ec66a278b7968e1ecda778df3938672900ff5567efcbd9ee9f8816b20d0f2471e"}' ========= master_lag: 0.68 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 17:19:51.933475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 17:19:51.933806) ========= 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-1459207941.965837-184654313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003288 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 17:19:51.957131) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 17:19:51.957444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 17:19:51.960774) ========= ========= Total master_lag: 0.91 =========