builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1457996405.03 results: success (0) buildid: 20160314004022 builduid: f57e7c4497544e148446bcc13bbd4a42 revision: 34a219cbd67d2bf0c555321ef8308a6aefcef23d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.027338) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.027814) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.028099) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006447 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.119583) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.119929) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.363382) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.363742) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004652 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.421049) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.421399) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.421794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.422086) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-14 16:00:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.9M=0.001s 2016-03-14 16:00:05 (13.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091733 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.557098) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.560447) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015676 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.645361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.645738) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 34a219cbd67d2bf0c555321ef8308a6aefcef23d --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 34a219cbd67d2bf0c555321ef8308a6aefcef23d --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=78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-14 16:00:05,828 truncating revision to first 12 chars 2016-03-14 16:00:05,828 Setting DEBUG logging. 2016-03-14 16:00:05,828 attempt 1/10 2016-03-14 16:00:05,828 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/34a219cbd67d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 16:00:06,084 unpacking tar archive at: mozilla-aurora-34a219cbd67d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.570025 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:06.241515) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:06.241852) ========= echo 34a219cbd67d2bf0c555321ef8308a6aefcef23d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'34a219cbd67d2bf0c555321ef8308a6aefcef23d'] 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=78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 34a219cbd67d2bf0c555321ef8308a6aefcef23d program finished with exit code 0 elapsedTime=0.003834 script_repo_revision: '34a219cbd67d2bf0c555321ef8308a6aefcef23d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:06.292023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:06.292356) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:06.306959) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-14 16:00:06.307346) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:00:06 INFO - MultiFileLogger online at 20160314 16:00:06 in /builds/slave/test-pgo 16:00:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:00:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:00:06 INFO - {'append_to_log': False, 16:00:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:00:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:00:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:00:06 INFO - 'branch': 'Mozilla-Aurora', 16:00:06 INFO - 'buildbot_json_path': 'buildprops.json', 16:00:06 INFO - 'config_files': ('talos/linux_config.py',), 16:00:06 INFO - 'default_actions': ('clobber', 16:00:06 INFO - 'read-buildbot-config', 16:00:06 INFO - 'download-and-extract', 16:00:06 INFO - 'populate-webroot', 16:00:06 INFO - 'create-virtualenv', 16:00:06 INFO - 'install', 16:00:06 INFO - 'run-tests'), 16:00:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:00:06 INFO - 'download_minidump_stackwalk': True, 16:00:06 INFO - 'download_symbols': 'ondemand', 16:00:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:00:06 INFO - 'tooltool.py': '/tools/tooltool.py', 16:00:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:00:06 INFO - '/tools/misc-python/virtualenv.py')}, 16:00:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:00:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:00:06 INFO - 'installer_path': 'installer.exe', 16:00:06 INFO - 'log_level': 'info', 16:00:06 INFO - 'log_name': 'talos', 16:00:06 INFO - 'log_to_console': True, 16:00:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:00:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:00:06 INFO - 'opt_config_files': (), 16:00:06 INFO - 'pip_index': False, 16:00:06 INFO - 'sps_profile': False, 16:00:06 INFO - 'sps_profile_interval': 0, 16:00:06 INFO - 'suite': 'dromaeojs', 16:00:06 INFO - 'system_bits': '32', 16:00:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:00:06 INFO - 'title': 'talos-linux64-ix-019', 16:00:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:00:06 INFO - 'use_talos_json': True, 16:00:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:00:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:00:06 INFO - 'work_dir': 'build'} 16:00:06 INFO - ##### 16:00:06 INFO - ##### Running clobber step. 16:00:06 INFO - ##### 16:00:06 INFO - Running pre-action listener: _resource_record_pre_action 16:00:06 INFO - Running main action method: clobber 16:00:06 INFO - rmtree: /builds/slave/test-pgo/build 16:00:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:00:07 INFO - Running post-action listener: _resource_record_post_action 16:00:07 INFO - ##### 16:00:07 INFO - ##### Running read-buildbot-config step. 16:00:07 INFO - ##### 16:00:07 INFO - Running pre-action listener: _resource_record_pre_action 16:00:07 INFO - Running main action method: read_buildbot_config 16:00:07 INFO - Using buildbot properties: 16:00:07 INFO - { 16:00:07 INFO - "project": "", 16:00:07 INFO - "product": "firefox", 16:00:07 INFO - "script_repo_revision": "production", 16:00:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:00:07 INFO - "repository": "", 16:00:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 16:00:07 INFO - "buildid": "20160314004022", 16:00:07 INFO - "stage_platform": "linux64-pgo", 16:00:07 INFO - "basedir": "/builds/slave/test-pgo", 16:00:07 INFO - "nightly_build": "True", 16:00:07 INFO - "buildnumber": 108, 16:00:07 INFO - "slavename": "talos-linux64-ix-019", 16:00:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:00:07 INFO - "platform": "ubuntu64_hw", 16:00:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:00:07 INFO - "branch": "mozilla-aurora", 16:00:07 INFO - "repo_path": "releases/mozilla-aurora", 16:00:07 INFO - "revision": "34a219cbd67d2bf0c555321ef8308a6aefcef23d", 16:00:07 INFO - "pgo_build": "True", 16:00:07 INFO - "builduid": "f57e7c4497544e148446bcc13bbd4a42", 16:00:07 INFO - "slavebuilddir": "test" 16:00:07 INFO - } 16:00:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 16:00:07 INFO - Running post-action listener: _resource_record_post_action 16:00:07 INFO - ##### 16:00:07 INFO - ##### Running download-and-extract step. 16:00:07 INFO - ##### 16:00:07 INFO - Running pre-action listener: _resource_record_pre_action 16:00:07 INFO - Running main action method: download_and_extract 16:00:07 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:00:07 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:00:07 INFO - https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:00:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:00:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:00:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/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:00:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/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:00:16 INFO - Downloaded 1448 bytes. 16:00:16 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:00:16 INFO - Using the following test package requirements: 16:00:16 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:00:16 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:00:16 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:00:16 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:16 INFO - u'jsshell-linux-x86_64.zip'], 16:00:16 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:00:16 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:00:16 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:00:16 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:00:16 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:00:16 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:00:16 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:00:16 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:16 INFO - https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:00:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:00:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:00:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/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:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/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:00:24 INFO - Downloaded 23306101 bytes. 16:00:24 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:00:24 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:00:25 INFO - Return code: 0 16:00:25 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:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:25 INFO - https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:00:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:00:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:00:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/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:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/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:00:31 INFO - Downloaded 23306101 bytes. 16:00:31 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:00:31 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:00:33 INFO - Return code: 0 16:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:33 INFO - https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/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:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/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:00:34 INFO - Downloaded 10845161 bytes. 16:00:34 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:00:34 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:00:34 INFO - Return code: 0 16:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:34 INFO - https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:00:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:00:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:00:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/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:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/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:00:35 INFO - Downloaded 60436500 bytes. 16:00:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:00:35 INFO - mkdir: /builds/slave/test-pgo/properties 16:00:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:00:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:00:35 INFO - Contents: 16:00:35 INFO - build_url:https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:00:36 INFO - Running post-action listener: _resource_record_post_action 16:00:36 INFO - Running post-action listener: set_extra_try_arguments 16:00:36 INFO - ##### 16:00:36 INFO - ##### Running populate-webroot step. 16:00:36 INFO - ##### 16:00:36 INFO - Running pre-action listener: _resource_record_pre_action 16:00:36 INFO - Running main action method: populate_webroot 16:00:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:00:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:00:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:00:36 INFO - '--tppagecycles', 16:00:36 INFO - '7'], 16:00:36 INFO - 'tests': ['tsvgm']}}, 16:00:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:00:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:00:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:00:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:00:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:00:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:00:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:00:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:36 INFO - 'talos_options': ['--e10s'], 16:00:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:00:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:36 INFO - 'tests': ['damp', 'tps']}, 16:00:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:36 INFO - 'talos_options': ['--e10s'], 16:00:36 INFO - 'tests': ['damp', 'tps']}, 16:00:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:00:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:00:36 INFO - 'other': {'tests': ['a11yr', 16:00:36 INFO - 'ts_paint', 16:00:36 INFO - 'tpaint', 16:00:36 INFO - 'sessionrestore', 16:00:36 INFO - 'sessionrestore_no_auto_restore', 16:00:36 INFO - 'tabpaint']}, 16:00:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:00:36 INFO - 'tests': ['a11yr', 16:00:36 INFO - 'ts_paint', 16:00:36 INFO - 'tpaint', 16:00:36 INFO - 'sessionrestore', 16:00:36 INFO - 'sessionrestore_no_auto_restore', 16:00:36 INFO - 'tabpaint']}, 16:00:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:00:36 INFO - 'tests': ['a11yr', 16:00:36 INFO - 'ts_paint', 16:00:36 INFO - 'tpaint', 16:00:36 INFO - 'sessionrestore', 16:00:36 INFO - 'sessionrestore_no_auto_restore', 16:00:36 INFO - 'tabpaint']}, 16:00:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:00:36 INFO - 'tests': ['a11yr', 16:00:36 INFO - 'ts_paint', 16:00:36 INFO - 'tpaint', 16:00:36 INFO - 'sessionrestore', 16:00:36 INFO - 'sessionrestore_no_auto_restore', 16:00:36 INFO - 'tabpaint']}, 16:00:36 INFO - 'other_l64': {'tests': ['a11yr', 16:00:36 INFO - 'ts_paint', 16:00:36 INFO - 'tpaint', 16:00:36 INFO - 'sessionrestore', 16:00:36 INFO - 'sessionrestore_no_auto_restore', 16:00:36 INFO - 'tabpaint']}, 16:00:36 INFO - 'other_nol64': {'tests': ['a11yr', 16:00:36 INFO - 'ts_paint', 16:00:36 INFO - 'tpaint', 16:00:36 INFO - 'sessionrestore', 16:00:36 INFO - 'sessionrestore_no_auto_restore', 16:00:36 INFO - 'tabpaint']}, 16:00:36 INFO - 'svgr': {'tests': ['tsvgx', 16:00:36 INFO - 'tsvgr_opacity', 16:00:36 INFO - 'tart', 16:00:36 INFO - 'tscrollx', 16:00:36 INFO - 'cart']}, 16:00:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:00:36 INFO - 'tests': ['tsvgx', 16:00:36 INFO - 'tsvgr_opacity', 16:00:36 INFO - 'tart', 16:00:36 INFO - 'tscrollx', 16:00:36 INFO - 'cart']}, 16:00:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:36 INFO - 'tests': ['tp5o']}, 16:00:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:36 INFO - 'talos_options': ['--e10s'], 16:00:36 INFO - 'tests': ['tp5o']}, 16:00:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:36 INFO - 'talos_options': ['--xperf_path', 16:00:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:00:36 INFO - 'tests': ['tp5n']}, 16:00:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:36 INFO - 'talos_options': ['--e10s', 16:00:36 INFO - '--xperf_path', 16:00:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:00:36 INFO - 'tests': ['tp5n']}}, 16:00:36 INFO - 'talos.zip': {'path': '', 16:00:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:00:36 INFO - Running post-action listener: _resource_record_post_action 16:00:36 INFO - ##### 16:00:36 INFO - ##### Running create-virtualenv step. 16:00:36 INFO - ##### 16:00:36 INFO - Running pre-action listener: _resource_record_pre_action 16:00:36 INFO - Running main action method: create_virtualenv 16:00:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:00:36 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:00:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:00:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:00:36 INFO - Using real prefix '/usr' 16:00:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:00:37 INFO - Installing distribute.............................................................................................................................................................................................done. 16:00:39 INFO - Installing pip.................done. 16:00:39 INFO - Return code: 0 16:00:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:00:39 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:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:39 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:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:39 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 0x7f0c3d639f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22066d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295920>, '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 0x2296820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', '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:00:39 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:00:39 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:00:39 INFO - Using env: {'DISPLAY': ':0', 16:00:39 INFO - 'HOME': '/home/cltbld', 16:00:39 INFO - 'LANG': 'en_US.UTF-8', 16:00:39 INFO - 'LANGUAGE': 'en_US:en', 16:00:39 INFO - 'LOGNAME': 'cltbld', 16:00:39 INFO - 'MAIL': '/var/mail/cltbld', 16:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:39 INFO - 'MOZ_NO_REMOTE': '1', 16:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:39 INFO - 'NO_EM_RESTART': '1', 16:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:39 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:39 INFO - 'SHELL': '/bin/bash', 16:00:39 INFO - 'SHLVL': '1', 16:00:39 INFO - 'TERM': 'linux', 16:00:39 INFO - 'TMOUT': '86400', 16:00:39 INFO - 'USER': 'cltbld', 16:00:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', 16:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:39 INFO - '_': '/tools/buildbot/bin/python'} 16:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:39 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:00:39 INFO - Cleaning up... 16:00:39 INFO - Return code: 0 16:00:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:00:39 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:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:39 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:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:39 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 0x7f0c3d639f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22066d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295920>, '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 0x2296820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', '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:00:39 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:00:39 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:00:39 INFO - Using env: {'DISPLAY': ':0', 16:00:39 INFO - 'HOME': '/home/cltbld', 16:00:39 INFO - 'LANG': 'en_US.UTF-8', 16:00:39 INFO - 'LANGUAGE': 'en_US:en', 16:00:39 INFO - 'LOGNAME': 'cltbld', 16:00:39 INFO - 'MAIL': '/var/mail/cltbld', 16:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:39 INFO - 'MOZ_NO_REMOTE': '1', 16:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:39 INFO - 'NO_EM_RESTART': '1', 16:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:39 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:39 INFO - 'SHELL': '/bin/bash', 16:00:39 INFO - 'SHLVL': '1', 16:00:39 INFO - 'TERM': 'linux', 16:00:39 INFO - 'TMOUT': '86400', 16:00:39 INFO - 'USER': 'cltbld', 16:00:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', 16:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:39 INFO - '_': '/tools/buildbot/bin/python'} 16:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:39 INFO - Downloading/unpacking psutil>=0.7.1 16:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:00:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:00:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:00:41 INFO - Installing collected packages: psutil 16:00:41 INFO - Running setup.py install for psutil 16:00:41 INFO - building 'psutil._psutil_linux' extension 16:00:41 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:00:41 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:00:41 INFO - building 'psutil._psutil_posix' extension 16:00:41 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:00:41 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:00:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:00:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:00:41 INFO - Successfully installed psutil 16:00:41 INFO - Cleaning up... 16:00:42 INFO - Return code: 0 16:00:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:00: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:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00: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:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00: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', '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 0x7f0c3d639f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22066d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295920>, '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 0x2296820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', '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:00: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:00: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 mozsystemmonitor==0.0.0 16:00:42 INFO - Using env: {'DISPLAY': ':0', 16:00:42 INFO - 'HOME': '/home/cltbld', 16:00:42 INFO - 'LANG': 'en_US.UTF-8', 16:00:42 INFO - 'LANGUAGE': 'en_US:en', 16:00:42 INFO - 'LOGNAME': 'cltbld', 16:00:42 INFO - 'MAIL': '/var/mail/cltbld', 16:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:42 INFO - 'MOZ_NO_REMOTE': '1', 16:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:42 INFO - 'NO_EM_RESTART': '1', 16:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:42 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:42 INFO - 'SHELL': '/bin/bash', 16:00:42 INFO - 'SHLVL': '1', 16:00:42 INFO - 'TERM': 'linux', 16:00:42 INFO - 'TMOUT': '86400', 16:00:42 INFO - 'USER': 'cltbld', 16:00:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', 16:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:42 INFO - '_': '/tools/buildbot/bin/python'} 16:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:00:42 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:00:42 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:00:42 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:00:42 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:00:42 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:00:42 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:00:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:00:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:00:44 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:00:44 INFO - Installing collected packages: mozsystemmonitor 16:00:44 INFO - Running setup.py install for mozsystemmonitor 16:00:44 INFO - Successfully installed mozsystemmonitor 16:00:44 INFO - Cleaning up... 16:00:44 INFO - Return code: 0 16:00:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0c3d639f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22066d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295920>, '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 0x2296820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', '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:00:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:00:44 INFO - Using env: {'DISPLAY': ':0', 16:00:44 INFO - 'HOME': '/home/cltbld', 16:00:44 INFO - 'LANG': 'en_US.UTF-8', 16:00:44 INFO - 'LANGUAGE': 'en_US:en', 16:00:44 INFO - 'LOGNAME': 'cltbld', 16:00:44 INFO - 'MAIL': '/var/mail/cltbld', 16:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:44 INFO - 'MOZ_NO_REMOTE': '1', 16:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:44 INFO - 'NO_EM_RESTART': '1', 16:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:44 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:44 INFO - 'SHELL': '/bin/bash', 16:00:44 INFO - 'SHLVL': '1', 16:00:44 INFO - 'TERM': 'linux', 16:00:44 INFO - 'TMOUT': '86400', 16:00:44 INFO - 'USER': 'cltbld', 16:00:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', 16:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:44 INFO - '_': '/tools/buildbot/bin/python'} 16:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:44 INFO - Downloading/unpacking blobuploader==1.2.4 16:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:46 INFO - Downloading blobuploader-1.2.4.tar.gz 16:00:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:00:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:00:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:47 INFO - Downloading docopt-0.6.1.tar.gz 16:00:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:00:47 INFO - Installing collected packages: blobuploader, requests, docopt 16:00:47 INFO - Running setup.py install for blobuploader 16:00:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:00:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:00:47 INFO - Running setup.py install for requests 16:00:47 INFO - Running setup.py install for docopt 16:00:47 INFO - Successfully installed blobuploader requests docopt 16:00:47 INFO - Cleaning up... 16:00:47 INFO - Return code: 0 16:00:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:47 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 0x7f0c3d639f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22066d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295920>, '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 0x2296820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', '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:00:47 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:00:47 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:00:47 INFO - Using env: {'DISPLAY': ':0', 16:00:47 INFO - 'HOME': '/home/cltbld', 16:00:47 INFO - 'LANG': 'en_US.UTF-8', 16:00:47 INFO - 'LANGUAGE': 'en_US:en', 16:00:47 INFO - 'LOGNAME': 'cltbld', 16:00:47 INFO - 'MAIL': '/var/mail/cltbld', 16:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:47 INFO - 'MOZ_NO_REMOTE': '1', 16:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:47 INFO - 'NO_EM_RESTART': '1', 16:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:47 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:47 INFO - 'SHELL': '/bin/bash', 16:00:47 INFO - 'SHLVL': '1', 16:00:47 INFO - 'TERM': 'linux', 16:00:47 INFO - 'TMOUT': '86400', 16:00:47 INFO - 'USER': 'cltbld', 16:00:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', 16:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:47 INFO - '_': '/tools/buildbot/bin/python'} 16:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:47 INFO - Running setup.py (path:/tmp/pip-noxGyG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:47 INFO - Running setup.py (path:/tmp/pip-c11KoT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:48 INFO - Running setup.py (path:/tmp/pip-KsZvMA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:48 INFO - Running setup.py (path:/tmp/pip-8dQ6UC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:48 INFO - Running setup.py (path:/tmp/pip-zGKflI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:48 INFO - Running setup.py (path:/tmp/pip-Uk3bRW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:48 INFO - Running setup.py (path:/tmp/pip-vHRH16-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:48 INFO - Running setup.py (path:/tmp/pip-BzqN7_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:48 INFO - Running setup.py (path:/tmp/pip-lNh_u8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:48 INFO - Running setup.py (path:/tmp/pip-cMROH4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:48 INFO - Running setup.py (path:/tmp/pip-_lns7l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:48 INFO - Running setup.py (path:/tmp/pip-9bQpTA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:48 INFO - Running setup.py (path:/tmp/pip-YOBk04-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:48 INFO - Running setup.py (path:/tmp/pip-fSj3cC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:48 INFO - Running setup.py (path:/tmp/pip-S7Jofk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:48 INFO - Running setup.py (path:/tmp/pip-r_3WbR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:49 INFO - Running setup.py (path:/tmp/pip-gvmPhy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:00:49 INFO - Running setup.py install for manifestparser 16:00:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:00:49 INFO - Running setup.py install for mozcrash 16:00:49 INFO - Running setup.py install for mozdebug 16:00:49 INFO - Running setup.py install for mozdevice 16:00:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:00:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:00:49 INFO - Running setup.py install for mozfile 16:00:49 INFO - Running setup.py install for mozhttpd 16:00:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:00:49 INFO - Running setup.py install for mozinfo 16:00:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:00:49 INFO - Running setup.py install for mozInstall 16:00:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:00:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:00:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:00:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:00:49 INFO - Running setup.py install for mozleak 16:00:50 INFO - Running setup.py install for mozlog 16:00:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:00:50 INFO - Running setup.py install for moznetwork 16:00:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:00:50 INFO - Running setup.py install for mozprocess 16:00:50 INFO - Running setup.py install for mozprofile 16:00:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:00:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:00:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:00:50 INFO - Running setup.py install for mozrunner 16:00:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:00:50 INFO - Running setup.py install for mozscreenshot 16:00:50 INFO - Running setup.py install for moztest 16:00:50 INFO - Running setup.py install for mozversion 16:00:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:00:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:00:50 INFO - Cleaning up... 16:00:50 INFO - Return code: 0 16:00:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:50 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 0x7f0c3d639f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22066d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295920>, '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 0x2296820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', '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:00:50 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:00:50 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:00:50 INFO - Using env: {'DISPLAY': ':0', 16:00:50 INFO - 'HOME': '/home/cltbld', 16:00:50 INFO - 'LANG': 'en_US.UTF-8', 16:00:50 INFO - 'LANGUAGE': 'en_US:en', 16:00:50 INFO - 'LOGNAME': 'cltbld', 16:00:50 INFO - 'MAIL': '/var/mail/cltbld', 16:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:50 INFO - 'MOZ_NO_REMOTE': '1', 16:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:50 INFO - 'NO_EM_RESTART': '1', 16:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:50 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:50 INFO - 'SHELL': '/bin/bash', 16:00:50 INFO - 'SHLVL': '1', 16:00:50 INFO - 'TERM': 'linux', 16:00:50 INFO - 'TMOUT': '86400', 16:00:50 INFO - 'USER': 'cltbld', 16:00:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', 16:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:50 INFO - '_': '/tools/buildbot/bin/python'} 16:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:51 INFO - Running setup.py (path:/tmp/pip-vfFheV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:51 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:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:51 INFO - Running setup.py (path:/tmp/pip-8cr1vB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:51 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:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:51 INFO - Running setup.py (path:/tmp/pip-ycEyLk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:51 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:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:51 INFO - Running setup.py (path:/tmp/pip-4Ctfhb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:51 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:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:51 INFO - Running setup.py (path:/tmp/pip-PxxBDp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:51 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:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:51 INFO - Running setup.py (path:/tmp/pip-6r9UDO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:51 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:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:51 INFO - Running setup.py (path:/tmp/pip-guf_Lr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:51 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:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:51 INFO - Running setup.py (path:/tmp/pip-exhVXA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:51 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:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:51 INFO - Running setup.py (path:/tmp/pip-ZQuLDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:51 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:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:51 INFO - Running setup.py (path:/tmp/pip-iWxNeF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:51 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:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:51 INFO - Running setup.py (path:/tmp/pip-zI1Cw9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:51 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:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:51 INFO - Running setup.py (path:/tmp/pip-wOFNnx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:51 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:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:51 INFO - Running setup.py (path:/tmp/pip-ND_dmg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:52 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:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:52 INFO - Running setup.py (path:/tmp/pip-ZgnM3C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:52 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:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:52 INFO - Running setup.py (path:/tmp/pip-DFVv9H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:52 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:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:52 INFO - Running setup.py (path:/tmp/pip-eWBlCH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:52 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:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:52 INFO - Running setup.py (path:/tmp/pip-SNJafi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:52 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:00:52 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:00:52 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:00:52 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:00:52 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:00:52 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:00:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:00:52 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:00:52 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:00:52 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:00:52 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:00:52 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:00:52 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:00:54 INFO - Downloading blessings-1.6.tar.gz 16:00:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:00:54 INFO - Installing collected packages: blessings 16:00:54 INFO - Running setup.py install for blessings 16:00:54 INFO - Successfully installed blessings 16:00:54 INFO - Cleaning up... 16:00:54 INFO - Return code: 0 16:00:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:00:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:00:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:00:54 INFO - Reading from file tmpfile_stdout 16:00:54 INFO - Current package versions: 16:00:54 INFO - argparse == 1.2.1 16:00:54 INFO - blessings == 1.6 16:00:54 INFO - blobuploader == 1.2.4 16:00:54 INFO - docopt == 0.6.1 16:00:54 INFO - manifestparser == 1.1 16:00:54 INFO - mozInstall == 1.12 16:00:54 INFO - mozcrash == 0.17 16:00:54 INFO - mozdebug == 0.1 16:00:54 INFO - mozdevice == 0.48 16:00:54 INFO - mozfile == 1.2 16:00:54 INFO - mozhttpd == 0.7 16:00:54 INFO - mozinfo == 0.9 16:00:54 INFO - mozleak == 0.1 16:00:54 INFO - mozlog == 3.1 16:00:54 INFO - moznetwork == 0.27 16:00:54 INFO - mozprocess == 0.22 16:00:54 INFO - mozprofile == 0.28 16:00:54 INFO - mozrunner == 6.11 16:00:54 INFO - mozscreenshot == 0.1 16:00:54 INFO - mozsystemmonitor == 0.0 16:00:54 INFO - moztest == 0.7 16:00:54 INFO - mozversion == 1.4 16:00:54 INFO - psutil == 3.1.1 16:00:54 INFO - requests == 1.2.3 16:00:54 INFO - wsgiref == 0.1.2 16:00:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:00:54 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:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:54 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:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:54 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 0x7f0c3d639f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22066d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295920>, '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 0x2296820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', '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:00:54 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:00:54 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:00:54 INFO - Using env: {'DISPLAY': ':0', 16:00:54 INFO - 'HOME': '/home/cltbld', 16:00:54 INFO - 'LANG': 'en_US.UTF-8', 16:00:54 INFO - 'LANGUAGE': 'en_US:en', 16:00:54 INFO - 'LOGNAME': 'cltbld', 16:00:54 INFO - 'MAIL': '/var/mail/cltbld', 16:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:54 INFO - 'MOZ_NO_REMOTE': '1', 16:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:54 INFO - 'NO_EM_RESTART': '1', 16:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:54 INFO - 'SHELL': '/bin/bash', 16:00:54 INFO - 'SHLVL': '1', 16:00:54 INFO - 'TERM': 'linux', 16:00:54 INFO - 'TMOUT': '86400', 16:00:54 INFO - 'USER': 'cltbld', 16:00:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', 16:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:54 INFO - '_': '/tools/buildbot/bin/python'} 16:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:54 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:00:54 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:00:54 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:00:54 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:00:54 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:00:54 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:00:54 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:00:54 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:00:54 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:00:54 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:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:00:54 INFO - Cleaning up... 16:00:54 INFO - Return code: 0 16:00:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:00:54 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:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:54 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:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:54 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 0x7f0c3d639f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22066d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295920>, '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 0x2296820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', '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:00:54 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:00:54 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:00:54 INFO - Using env: {'DISPLAY': ':0', 16:00:54 INFO - 'HOME': '/home/cltbld', 16:00:54 INFO - 'LANG': 'en_US.UTF-8', 16:00:54 INFO - 'LANGUAGE': 'en_US:en', 16:00:54 INFO - 'LOGNAME': 'cltbld', 16:00:54 INFO - 'MAIL': '/var/mail/cltbld', 16:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:54 INFO - 'MOZ_NO_REMOTE': '1', 16:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:54 INFO - 'NO_EM_RESTART': '1', 16:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:54 INFO - 'SHELL': '/bin/bash', 16:00:54 INFO - 'SHLVL': '1', 16:00:54 INFO - 'TERM': 'linux', 16:00:54 INFO - 'TMOUT': '86400', 16:00:54 INFO - 'USER': 'cltbld', 16:00:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', 16:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:54 INFO - '_': '/tools/buildbot/bin/python'} 16:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:55 INFO - Downloading/unpacking jsonschema 16:00:55 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:00:55 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:00:55 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:00:55 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:00:55 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:00:55 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:00:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:00:56 INFO - Downloading/unpacking functools32 (from jsonschema) 16:00: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:00: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:00: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:00: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:00: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:00: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:00:57 INFO - Downloading functools32-3.2.3-2.tar.gz 16:00:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:00:57 INFO - warning: no files found matching '*.txt' 16:00:57 INFO - no previously-included directories found matching 'build' 16:00:57 INFO - no previously-included directories found matching 'dist' 16:00:57 INFO - no previously-included directories found matching '.git*' 16:00:57 INFO - Installing collected packages: jsonschema, functools32 16:00:57 INFO - Running setup.py install for functools32 16:00:57 INFO - warning: no files found matching '*.txt' 16:00:57 INFO - no previously-included directories found matching 'build' 16:00:57 INFO - no previously-included directories found matching 'dist' 16:00:57 INFO - no previously-included directories found matching '.git*' 16:00:57 INFO - Successfully installed jsonschema functools32 16:00:57 INFO - Cleaning up... 16:00:57 INFO - Return code: 0 16:00:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0c3d639f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22066d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2295920>, '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 0x2296820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', '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:00:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:00:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:00:57 INFO - Using env: {'DISPLAY': ':0', 16:00:57 INFO - 'HOME': '/home/cltbld', 16:00:57 INFO - 'LANG': 'en_US.UTF-8', 16:00:57 INFO - 'LANGUAGE': 'en_US:en', 16:00:57 INFO - 'LOGNAME': 'cltbld', 16:00:57 INFO - 'MAIL': '/var/mail/cltbld', 16:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:57 INFO - 'MOZ_NO_REMOTE': '1', 16:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:57 INFO - 'NO_EM_RESTART': '1', 16:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:57 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:57 INFO - 'SHELL': '/bin/bash', 16:00:57 INFO - 'SHLVL': '1', 16:00:57 INFO - 'TERM': 'linux', 16:00:57 INFO - 'TMOUT': '86400', 16:00:57 INFO - 'USER': 'cltbld', 16:00:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', 16:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:57 INFO - '_': '/tools/buildbot/bin/python'} 16:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:57 INFO - Downloading/unpacking flake8 16:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:00:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:00: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:00: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:00: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:00: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:00: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:00: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:00:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:00:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:00: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:00: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:00: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:00: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:00: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:00: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:00:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:00: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:00: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:00: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:00: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:00: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:00: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:01:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:01:00 INFO - no previously-included directories found matching 'docs/_build' 16:01:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:01:00 INFO - Running setup.py install for pep8 16:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:01:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:01:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:01:00 INFO - no previously-included directories found matching 'docs/_build' 16:01:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:01:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:01:00 INFO - Cleaning up... 16:01:00 INFO - Return code: 0 16:01:00 INFO - Running post-action listener: _resource_record_post_action 16:01:00 INFO - Running post-action listener: _start_resource_monitoring 16:01:00 INFO - Starting resource monitoring. 16:01:00 INFO - ##### 16:01:00 INFO - ##### Running install step. 16:01:00 INFO - ##### 16:01:00 INFO - Running pre-action listener: _resource_record_pre_action 16:01:00 INFO - Running main action method: install 16:01:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:01:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:01:00 INFO - Reading from file tmpfile_stdout 16:01:00 INFO - Detecting whether we're running mozinstall >=1.0... 16:01:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:01:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:01:00 INFO - Reading from file tmpfile_stdout 16:01:00 INFO - Output received: 16:01:00 INFO - Usage: mozinstall [options] installer 16:01:00 INFO - Options: 16:01:00 INFO - -h, --help show this help message and exit 16:01:00 INFO - -d DEST, --destination=DEST 16:01:00 INFO - Directory to install application into. [default: 16:01:00 INFO - "/builds/slave/test-pgo"] 16:01:00 INFO - --app=APP Application being installed. [default: firefox] 16:01:00 INFO - mkdir: /builds/slave/test-pgo/build/application 16:01:00 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:01:00 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 16:01:15 INFO - Reading from file tmpfile_stdout 16:01:15 INFO - Output received: 16:01:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:01:15 INFO - Running post-action listener: _resource_record_post_action 16:01:15 INFO - ##### 16:01:15 INFO - ##### Running run-tests step. 16:01:15 INFO - ##### 16:01:15 INFO - Running pre-action listener: _resource_record_pre_action 16:01:15 INFO - Running main action method: run_tests 16:01:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:01:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:01:15 INFO - Python 2.7.3 16:01:15 INFO - Return code: 0 16:01:15 INFO - grabbing minidump binary from tooltool 16:01: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:01: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 0x2295920>, '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 0x2296820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2296cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:01: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 16:01: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 16:01:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:01:15 INFO - Return code: 0 16:01:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:01:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:01:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:01:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:01:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:01:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:01:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:01:16 INFO - Return code: 0 16:01: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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 16:01: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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 16:01:16 INFO - Using env: {'DISPLAY': ':0', 16:01:16 INFO - 'HOME': '/home/cltbld', 16:01:16 INFO - 'LANG': 'en_US.UTF-8', 16:01:16 INFO - 'LANGUAGE': 'en_US:en', 16:01:16 INFO - 'LOGNAME': 'cltbld', 16:01:16 INFO - 'MAIL': '/var/mail/cltbld', 16:01:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:01:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:16 INFO - 'MOZ_NO_REMOTE': '1', 16:01:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:16 INFO - 'NO_EM_RESTART': '1', 16:01:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:01:16 INFO - 'PWD': '/builds/slave/test-pgo', 16:01:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:01:16 INFO - 'SHELL': '/bin/bash', 16:01:16 INFO - 'SHLVL': '1', 16:01:16 INFO - 'TERM': 'linux', 16:01:16 INFO - 'TMOUT': '86400', 16:01:16 INFO - 'USER': 'cltbld', 16:01:16 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468', 16:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:16 INFO - '_': '/tools/buildbot/bin/python'} 16:01: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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:01:17 INFO - mozversion application_buildid: 20160314004022 16:01:17 INFO - mozversion application_changeset: 34a219cbd67d2bf0c555321ef8308a6aefcef23d 16:01:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:01:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:01:17 INFO - mozversion application_name: Firefox 16:01:17 INFO - mozversion application_remotingname: firefox-dev 16:01:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:01:17 INFO - mozversion application_vendor: Mozilla 16:01:17 INFO - mozversion application_version: 47.0a2 16:01:17 INFO - mozversion platform_buildid: 20160314004022 16:01:17 INFO - mozversion platform_changeset: 34a219cbd67d2bf0c555321ef8308a6aefcef23d 16:01:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:01:17 INFO - mozversion platform_version: 47.0a2 16:01:17 INFO - using testdate: 1457996477 16:01:17 INFO - actual date: 1457996477 16:01:17 INFO - starting webserver on 'localhost:38804' 16:01:17 INFO - SUITE-START | Running 2 tests 16:01:17 INFO - TEST-START | dromaeo_css 16:01:17 INFO - operating with platform_type : linux_ 16:01:17 INFO - Initialising browser for dromaeo_css test... 16:01:17 INFO - TEST-INFO | started process 19862 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptCdQUL/profile http://localhost:38804/getInfo.html) 16:01:22 INFO - PROCESS | 19862 | __metrics Screen width/height:1600/1200 16:01:22 INFO - PROCESS | 19862 | colorDepth:24 16:01:22 INFO - PROCESS | 19862 | Browser inner width/height: 1024/697 16:01:22 INFO - PROCESS | 19862 | __metrics 16:01:23 INFO - PROCESS | 19862 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:01:23 INFO - TEST-INFO | 19862: exit 0 16:01:23 INFO - Browser initialized. 16:01:23 INFO - Running cycle 1/1 for dromaeo_css test... 16:01:23 INFO - TEST-INFO | started process 19949 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptCdQUL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:01:35 INFO - PROCESS | 19949 | RSS: Main: 143773696 16:01:35 INFO - PROCESS | 19949 | 16:02:27 INFO - PROCESS | 19949 | 1457996547063 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] 16:04:34 INFO - PROCESS | 19949 | Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38804/tests/dromaeo/cssquery-ext.html) 16:04:35 INFO - PROCESS | 19949 | RSS: Main: 261402624 16:04:35 INFO - PROCESS | 19949 | 16:07:37 INFO - PROCESS | 19949 | Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-ext.html (next: http://localhost:38804/tests/dromaeo/cssquery-jquery.html) 16:07:38 INFO - PROCESS | 19949 | RSS: Main: 225112064 16:07:38 INFO - PROCESS | 19949 | 16:10:40 INFO - PROCESS | 19949 | Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38804/tests/dromaeo/cssquery-mootools.html) 16:10:40 INFO - PROCESS | 19949 | RSS: Main: 221548544 16:10:40 INFO - PROCESS | 19949 | 16:13:42 INFO - PROCESS | 19949 | Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38804/tests/dromaeo/cssquery-prototype.html) 16:13:43 INFO - PROCESS | 19949 | RSS: Main: 212275200 16:13:43 INFO - PROCESS | 19949 | 16:16:45 INFO - PROCESS | 19949 | Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38804/tests/dromaeo/cssquery-yui.html) 16:16:46 INFO - PROCESS | 19949 | RSS: Main: 213737472 16:16:46 INFO - PROCESS | 19949 | 16:19:48 INFO - PROCESS | 19949 | Cycle 1(1): loaded http://localhost:38804/tests/dromaeo/cssquery-yui.html (next: http://localhost:38804/tests/dromaeo/cssquery-dojo.html) 16:19:48 INFO - PROCESS | 19949 | RSS: Main: 256229376 16:19:48 INFO - PROCESS | 19949 | 16:19:48 INFO - PROCESS | 19949 | __start_tp_report 16:19:48 INFO - PROCESS | 19949 | _x_x_mozilla_page_load 16:19:48 INFO - PROCESS | 19949 | _x_x_mozilla_page_load_details 16:19:48 INFO - PROCESS | 19949 | |i|pagename|runs| 16:19:48 INFO - PROCESS | 19949 | |0;dojo.html;3265.7224135948445;3348.614909285433;3360.1767566946087;3366.9831650841743;3398.048546407006;5355.3305836770405;5408.405075441703;5425.240466334716;5452.536534394576;5483.616146869721;5375.193720941861;5386.111291636876;5430.8099216527335;5433.103537916249;5454.890902181954;4786.71279723216;4914.926276105853;4970;4987.501249875002;5019.021290848286;4898.706077635354;4966.279889416032;4968.726720030397;4970.378702662168;4985.052839960414;4898.093852637256;4918.827841025565;4980.875478113058;4989.950100498985;5001.1248031594505;4978.576820970222;5001.524855138774;5005.549500544968;5006.424261209934;5027.924581131268;4799.952000479985;4848.927266091011;4943.555080042814;4944.184209605411;4954.603631709455;5233.345831771028;5236;5249.501297376743;5252.553532949704;5297.284866543045;5702.173184888168;5785.132230165509;5797.797077102281;5850.941490585083;5853.268341457318;5837.6497410155525;5855.326637436664;5872.853178670524;5888.852778680524;5905.881882362329;5478.643888147258;5479.369872464677;5480.616356854982;5483.8080667176855;5483.972580137074;5846.093855452412;5867.266591676041;5932.970335148297;5943.0194017987415;5960.344362120163;5721.256236689203;5746.396628354046;5749.9425005750245;5753.654780713171;5759.22250496186;5846.0646296593195;5847.736851841677;5848;5856.297244330707;5857.297124345021;5628.97185514078;5714.142878568248;5809.390014048548;5830.970845145747;5836.941630583639;5799.942000580025;5809.186713860063;5817.185594016756;5820.8253752386645;5823.068309070529;4344.717593356421;4429.734215947054;4431.091626216617;4433.955660443419;4469.240229161051;3979.144483935968;4036.1524079943542;4048.3320252158064;4058.228936502055;4082.7754473503646;5502.972485137549;5508.3114610673665;5508.394076651565;5515.696636685021;5516.475934786189;5713.085906254979;5772.191893134965;5795.217645617872;5869.178315035899;5871.266091738533;5488.451154884479;5511.3937466879415;5518.862028449321;5521.116621340566;5541.501264886179;5043.117454445457;5047.697138171721;5048.040872234264;5052.520010598987;5075.984803039407;5905.527557795366;5942.58401911862;6007.879842403127;6054.727537260834;6057.545684073712;5834.970825145847;5835.912461312999;5846.29844418664;5851.882962340645;5853.385394533683;5996.820095397145;5998.130271110577;6009.639421634716;6010.338862725184;6022.187004754477;5642.351129620146;5713.342965559014;5753.539716822561;5763.971180144073;5771.249737534094;5864.091065884794;5900.380460051632;5905.173275741314;5910.408959104056;5911.852203694942;5682.801101961411;5700.201971723879;5700.258966334516;5700.600957933071;5707.971460142673;5527.8894422110525;5718.742656580547;5758.395368486249;5780.421957804186;5805;5593.965116453469;5611.607187496836;5616.438356164351;5619.269494965792;5627.971860140673;5580.190872323572;5715.171300161536;5715.8571035724435;5720.39935806751;5727.341355743976;5489.780408783604;5533.253010843485;5596.216529685766;5715.628484148517;5738.282714660668 16:19:48 INFO - PROCESS | 19949 | |1;ext.html;519.4649511003668;545.3265217456441;547.5181839980817;552.9612927095102;579.4466284698112;32594.348113037726;40962.59037409629;41643.79178104113;41670;41680.16639667205;43573;44535;44584.3312350315;44606;44649.330260046125;8888.911110888888;9080.046595107518;9101.135392137736;9101.63593456261;9101.681441149562;8832.249258813008;8927.910720892805;8955.910440895605;8956.19394254517;9229.538523073854;9194.31042671799;9282.350235483518;9294;9306.022867598906;9317.673881414152;9117.908820911805;9183.265338772915;9221.031791661846;9224.07759224079;9227.123423274777;9129.269658427376;9266.166045055978;9270.536473176315;9275.860862087075;9276.814463710689;42822;43185.352219716726;43343.78328108339;43380.56619433829;43407;3618.945715814265;3712.0905378182247;3731.8880433587037;3961.1681546875193;4140.648044916185;32699.6730032699;32875;32979;33125.17187070318;33150.33699326024;4113.958860411388;4162.334026555736;4191.72753771007;4231.97884010581;4242.936355954663;211241;212257;213638;213668;213849;47280;47780.7610961943;65861.67069164623;66582.66708666425;66705.33294667088;46223.5377646226;46240.53759462429;46258.768706156254;46314.76842615765;46377.768111159225;16409.179541022902;16427.260773265232;16526.752098718527;16561;16565;13790.586282411543;13818;13818.37817298224;13852.861471385359;13879.375428105759;15564.533064008097;16045.759313610306;16105.677886442205;16130;16142.677146457005;6049.969750151309;6091.786787462417;6097.60365576245;6133.570650054543;6153.907691384633;1019.5004447820514;1033.1992705653179;1049.0453687144661;1060.0883240413239;1185.1111666250313;30638.69361306403;30723;30832.845835771128;31208.375832483678;31363;1159.1422347462985;1178.0810967445407;1215.8601760797621;1271.5613113475836;1287.4978758284276;15878.364865405254;15915.283812228477;16011.119388433515;16151.273192706356;16753.497395078168;324144;327048;327514;327558;329618;59298.40701593015;59557;59773.70113149406;59802;59928;1388.6042477893955;1471.3378979459287;1474.0787008119926;1506.4501456968128;1518.6431188670654;30017.849910750305;30097.69902300949;30183.547246790877;30312.84843575768;30562;46869;47579.76210118927;48134.27798582954;48181.759091204316;48443.27335089906;233835;234852;234883;235853;302829;34847.825760871034;35128.82435587908;35129.64870351366;35216.11959701028;35426;43022.784886075366;43344;44330;44339;47973.520264796905;38760.41859372168;39022.80488597539;39050.60949390583;39182.80408597939;39265.80367098146;37608.811955940044;38186.42720359141;38818;38890.80554597209;39225.2154956905;38389.232215354976;38781;39080.609193907694;39773.80113099416;39954.20091598094;33636.66363336335;34976.475352870235;35201.29597408089;35451.29097418089;35569;26557.937682493255;26775.464490709688;26862.865685671448;26925.865370673022;27519.724802751716 16:19:48 INFO - PROCESS | 19949 | |2;jquery.html;380.1389851985254;380.6459992207247;388.7706253310547;388.8153127264548;391.60252343870974;17595.744787214357;19425.902870485665;19759.209631614718;19990.90004549977;20151.49621259469;18143.63712725748;18201.726974095367;18296.085195740226;18346;18413.26346946124;5728.198052272674;5878.764849406019;5905.822825315226;5914.319853216892;5915.704214789243;4348.130373925212;6130.509559235273;6318.968405157968;6357.268914074872;6361.4274715275615;6083.391660833925;6282.24613046435;6293.55945083842;6307.274663413697;6335.524835637322;6384.553081284312;6401.9039714404325;6406.135171751824;6410.775622853178;6416.518761092913;3955.881323560298;5362.758675859557;5507.807226747044;5512.531434828044;5514.91727624086;21933.01301441439;22108.115675372967;22346.329610111723;22655.660165097535;22767.089316427322;2372.5847976604027;2383.5947888858936;2388.820838437124;2409.0725070847675;2544.5038217547585;13809.378577963915;13825.446982120704;13925.23411212393;13936.790948135786;14253.928730356281;1944.2320283487943;1981.8216360527622;2027.553938133623;2075.7509098908076;2095.518030852897;63818;63984;64661.67669161671;65409.3459065408;66800.66599667018;10664.573417063231;10774.838377424188;10914.836277455845;11061.225714199929;11181.273217240854;14756.40974361035;14824.481143159937;14827.258637068104;14842.777358339634;14862.331195096247;8170.264676179172;8286.627101780434;8293.460925039853;8380.161983801692;8380.748577542683;7556.319931206218;7639.236076392427;7713.807154821175;7715.807104822312;8112.3104536113915;6572.309907459744;6699.76550820719;6717.018479548545;6722.798316050526;6756.3919247266995;1822.8177182281665;1868.1873385077536;1908.3320837706692;1961.1665042356942;1962.5486138188296;1013.716159475348;1039.6828967165088;1051.6897515233024;1081.3782075306574;1183.3195912350434;16897.746533802;17065;17160.485185444457;17400.5649858752;17457.825421745874;1042.4058286776465;1043.639944219243;1043.7286305560608;1055.9366438013744;1131.298594871185;10365.222608304257;10849.240553161202;10849.620263290746;10855.728606784736;10861.022507974163;459900;468095;480703;482292;487154;68187.31812681908;68887;70264.64867675629;70959;71455.2854471459;1025.887152413234;1026.9640562580273;1038.7974345002804;1041.6406339812752;1075.3977772447454;16245.350185992427;16288.755668665217;16348.918255408647;16439.506814795575;16483;33244.66755332416;33981.320373592884;34707.65292347044;35115.64884351124;35638;44768.328475073555;45255.32117018313;45275.77362113168;45954.08091838211;46425.53574464212;8113.148119447609;8264.297534709616;8490.533020683675;8546.743597692079;8595.140485951355;10285.331453455501;12729.681757956125;12822.487100515875;12878.67803304925;13280.070395072253;11125.833112503156;11226.775464490827;11307.151963602599;11421.401003859632;11538.88461115378;11142.777144456903;11191.776164476827;11458.541658333907;11464.713382165513;11550.249233799776;10694.679159625224;11101.722456938642;11349.035331996873;11769.705757356134;11889.881101188877;8723.127687231226;8753.824923501621;8854.380193386402;8945;8980.820383592421;11592.304461732323;11653.76692466163;11815.82276265874;11870.643880683594;11919.404029798648 16:19:48 INFO - PROCESS | 19949 | |3;mootools.html;1486.509451880878;1592.5302035899408;1610.6698126883994;1884.594812115395;1978.6636271833786;7388.482806203568;7916.604169791509;8056.355491560676;8069.798255043619;8074.152214017532;8016.91983080169;8173.877391839127;8182.67269309227;8190.05814331352;8192.057913339968;2116.121809449077;2162.297253392646;2298.78161574651;2333.7549557296493;2392.1866565367773;2413.1312727418117;2424.5635785558593;2424.696912885889;2425.575524283252;2425.757424257569;2364.7517010713887;2377.6314671225987;2392.3301475586863;2456.3981824453035;2456.6069428891383;2407.61478163493;2459.262221333611;2470.0737223541173;2471.888765005579;2474.084588702183;2398.124684490166;2402.0631953538136;2409.5180963807306;2414.4929564791414;2414.9517009659885;8279.793005174859;8326.50040997542;8329.916700832975;8340.541270230135;8343.290820280283;5121.923171152435;5261.158214685632;5268.947310526884;5305.522502974751;5312;3299.0432774495366;3314.734821214297;3351.882684106069;3367.9494807577908;3390.3049874775857;1012.5089331674133;1017.6590842067842;1019.7909428567126;1034.3845411979935;1079.9730006749814;11324.773504529863;11449.084073274118;11470.598529051527;11474.196806223568;11479.483423245974;4490.191765482179;4522.321651752263;4557.065801510748;4573.519780423007;4574;9972.501374931224;10028.197744180448;10045.447500387403;10051.748706282402;10053.246006549538;5021.774020169101;5039.622028347889;5052.964142350809;5054.848354549369;5060.7722652480725;4173.64524015456;4577.450705915311;4701.670883038223;4811.879703007453;4814.566688998007;3973.1259122992897;4005.8583303758874;4030.496187976503;4060.5330387005874;4079.3676980068135;1266.1010682415588;1289.774289499334;1290.2903403128241;1301.2062641788502;1305.1516514265804;1284.3706583773883;1457.2203870929213;1465.377214683755;1480.2376775960388;1494.2080697230485;7799.610019499116;7822.6088695564995;7860.449768516149;7863.37093032556;7869.409794265453;1218.214251807579;1242.167747609104;1242.4781591731314;1246.0841281657974;1269.3018839638346;6156.569040167145;6245.937540624626;6307.5269354798575;6309.621422714652;6310.368963103653;9970.750731231632;10104.242181836391;10128.088472037552;10175.185985121172;10176.287659863738;9233.676821311356;9770.169535589412;9812.313138080408;9971.10260076582;9997.650082247086;7578.3179513842915;7632.1986191450205;7666.923330766733;7697.076350837935;7715.691372345155;7694.269044440769;7725.150233474201;7795.727149549739;7838.529688218725;7858.174891636296;8752.431091979;8912.910870891468;9083.818323633623;9121.40710853819;9150.176484116462;9253.213476854542;9403.4828084456;9482.099200575934;9607.183389411699;9626.374285671409;6960.9303906962305;7048.400885924754;7564.659590318559;8098;8183.918160818315;7692.269234422721;7716.459847810599;7744;7744.341730952932;7755.457118001911;6718.496112791658;6856.5200435969;6871.587704737732;6982.266861979419;7016.859662806613;6904.4131248842405;6950.235474097946;6996.6151861648095;7014.824629384306;7068.045813815274;7278.09023872016;7292.708291668274;7316.524425912512;7474.850502989801;7489.70041198346;6953.513254072166;6956;6981.581105133709;6988.79033628992;7003.124609423822;6649.368310010541;6806.081179040964;6817.522773405814;6840.486963477859;7112.502124851418 16:19:48 INFO - PROCESS | 19949 | |4;prototype.html;375.791435753157;380.21485632169583;382.46454963051724;385.05469073424746;389.1749491078911;5979.043353063511;6031;6040.03359462485;6056.03103503439;6056.1824153739235;5961.672108034057;5974.701264936747;5981.043033114703;5983.760649574023;5986.401359864011;4477.932831007537;4527.3888025116685;4587.42657167854;4692.296155576665;4695.389599352079;4634.930476042862;4673.415823022122;4687.1328804171335;4705.364775755281;4724.480307166209;4653.464851542082;4668.18306796311;4675.251959686434;4685.484596694361;4689.273162659776;4486.663500237495;4531.932021019687;4640.164770341337;4681.297805329194;4697.953020469803;4125.154343359604;4127.9174416511505;4142.150859073882;4150.232207041677;4160.313548264533;5623.746931388097;5673.319201695782;5687.772489100473;5695;5696.886062278772;5491.0116179087745;5495.6153069285165;5503.147012213113;5507.752151153208;5509.3664228613825;6344.080108384258;6349.4602958748565;6352.714127864211;6353.523485738542;6353.650549219791;4327.199468098381;4434.512203657595;4663.417072865892;4672.15901137795;4672.976635116803;6542.149520562297;6563.1796025496815;6618.139641846577;6627.1716035495565;6629.469642428594;4670.9766451167525;4674.462436819741;4674.696144750648;4675.064987002545;4676.50896655853;4734.479207287196;4736.052789442126;4737.028909073631;4739.644526660514;4743.169945259635;5364.249005139283;5370.597205209625;5377.166539186433;5378.381486129067;5381.165919282517;6188.288346840171;6385.584936979174;6390.584612000205;6397.200349956255;6402.871942561216;1649.9010059396235;1653.115583163002;1669.5575672446812;1669.7495375693743;1669.8330166983446;1051.1800795379463;1100.6352123367128;1106.6790630717162;1116.1907616977626;1122.854028976228;6092.3603021682975;6210.875782484325;6215.223097112861;6250.624962502265;6257.092721555349;6639.86720265592;6651;6651.634160121143;6654.467642588678;6663.766768163091;6221.2845522765465;6226.097215903668;6227.408396202353;6234.906476402857;6247.031710084944;3558.1282585766653;3579.158897659048;3589.9282014359565;3596.5504311961004;3597.8380972856285;6708.463322934153;6830.624315662587;6850.691718872663;6865.485088618374;6867.896981545281;6742.325767423218;6771.322867713189;6790.694418751168;6792.286809884989;6794.286599907037;6816.659167041628;6817.352351526696;6818.386345228953;6818.965905170442;6826.112605361272;6626.072349871119;6630.602163870183;6632.137822083291;6634.104395906491;6634.402903738686;6403.391677790602;6521.293663129748;6527.51043671717;6530.053142294436;6559.27847936717;6814.568940522546;6849.1780986281965;6853.7943861684225;6861.519693621598;6915;4795.688280261772;4845.297431872288;4847.418309802846;4850.80596776125;4852.611791056777;6564.146660934239;6571.277159512545;6571.474282057328;6572.671366431755;6576.243731970884;6254.468370188585;6404.455621272058;6405.967970160119;6409;6412.038194270896;6456.838579035561;6469.708863101077;6477.643729594729;6493.740250389931;6498.935010650022;6373.3945275198785;6375.840603984938;6376.808695739135;6381.936180638134;6387.968060159669;6489.8702025960165;6492.415682588589;6492.805215843532;6501.674916254074;6504.642244676399;6020.4280593343565;6065.120557519223;6340.302566717565;6343.904841427475;6344.71448784815 16:19:48 INFO - PROCESS | 19949 | |5;yui.html;825.5129473610565;862.1421685423005;905.7690288976312;912.2428384440914;941.049539964636;14895.031822931516;14992.250387480637;14994.925025374885;15060.24698765063;15074.547763567098;15951.920240398811;16068.758968615452;16079.678406431864;16081.11553864537;16112.75830862535;784.3999340504519;933.0389698610425;950.325269058969;954.1889394015101;955.2405837359316;794.6582969323189;800.627708115726;802.9277365037145;945.6028468043438;964.8745663063827;996.173176263703;996.3673067602089;997.9002099789999;998.1216529454107;998.3959704378855;985.4333758089056;987.1214618989105;987.6197663899378;988.1501908358806;988.5205675247499;612.2499937576478;731.5208538407352;734.6657270941762;740.7777666699968;746.3916907720245;15336.616584585363;15403.3838646454;15426.537203883901;15465.690686186326;15494.30275637599;13643.863561364358;14214.147151170859;14288.428462861577;14336.283185840666;14337.211453370164;11627.360495172763;11638.185327027111;11797.351145686984;11850.762984740257;11914.46384912681;3839.2513459875336;3839.558450778168;3843.2889915365467;3855.094052897567;3882.6893848492055;55508.44491555113;55647.44352556463;55838;56357;56402.43597564013;9710;10196.643117491001;10368.948155259175;10568.735781605521;10591.470426478645;19792.50518737014;19934.70097948532;19955.102020409115;19965.700514492295;19987.60024799496;7755.185705500841;7793.688252469838;7946.960265198637;8153.103158652543;8191.71329003494;4532.773361331986;4642.326862604971;4650.744209068466;4670.346151538787;4680.461746899082;3416.8804091856664;3439.8968030959113;3440.8623655054016;3444.603870554918;3449.0170301463963;601.4737105033096;620.5749061892618;625.8873402787542;633.9904901426482;637.2289529669059;652.6280020388429;720.218562859293;722.757876111498;729.5549714674045;761.5811303782897;8210.548419836967;8616.78458038554;8712.738617841474;8764.8685269721;8826.735197944072;693.3928429106495;716.2479396633514;718.741253148866;723.8769409200448;724.69562783631;4105.712600117963;4130.731502452391;4167.354060120686;4357.9564204358185;4360.694751367374;57778;57934.7103264481;58908.41091589115;60128.39871601316;60254;49961;50436.747816260686;50532.747336263084;50875.49124508782;51821;49175.50824491781;49356.50643493519;49815;49903.25145122826;50015.24977125273;8698.347623928357;9003.819923601623;9136.177744003071;9146.725598232064;9180.47447522047;36548.81725591355;36588.26823463569;36759.448608271436;37792.244155117296;38213.61786382212;43185.35221971736;47713.76143119262;50003.749981249865;50346.244806328665;50802.23796642979;11369.374684392438;11423.086153107564;11548.191626586395;11574.942125289319;11873.228240164362;13340.19958802475;13378.13042152257;13416.798748018982;13522;13664.658383540092;12167.695807604527;12227.938860305641;12280.754384912074;12391.256524608552;12575.874241257836;12185.817212741638;12407.875921240671;12465.189762665397;12663.746725065632;12808.231506109663;11340.886591133984;11393.316401015965;11662.650120496399;12046.879531204926;12527.812082818948;10198.847017294598;10260.230482713678;10323.48382580883;10455;10507.422091785025;9828.655997040069;9875.851862222216;9887.555060022172;9894.901050989398;10089.646862359783 16:19:48 INFO - PROCESS | 19949 | __end_tp_report 16:19:48 INFO - PROCESS | 19949 | __start_cc_report 16:19:48 INFO - PROCESS | 19949 | _x_x_mozilla_cycle_collect,919 16:19:48 INFO - PROCESS | 19949 | __end_cc_report 16:19:48 INFO - PROCESS | 19949 | __startTimestamp1457997588878__endTimestamp 16:19:48 INFO - PROCESS | 19949 | 16:19:48 INFO - PROCESS | 19949 | ------- Summary: start ------- 16:19:48 INFO - PROCESS | 19949 | Number of tests: 6 16:19:48 INFO - PROCESS | 19949 | 16:19:48 INFO - PROCESS | 19949 | [#0] dojo.html Cycles:165 Average:5411.79 Median:5616.44 stddev:588.05 (10.5%) stddev-sans-first:565.24 16:19:48 INFO - PROCESS | 19949 | Values: 3265.7 3348.6 3360.2 3367.0 3398.0 5355.3 5408.4 5425.2 5452.5 5483.6 5375.2 5386.1 5430.8 5433.1 5454.9 4786.7 4914.9 4970.0 4987.5 5019.0 4898.7 4966.3 4968.7 4970.4 4985.1 4898.1 4918.8 4980.9 4990.0 5001.1 4978.6 5001.5 5005.5 5006.4 5027.9 4800.0 4848.9 4943.6 4944.2 4954.6 5233.3 5236.0 5249.5 5252.6 5297.3 5702.2 5785.1 5797.8 5850.9 5853.3 5837.6 5855.3 5872.9 5888.9 5905.9 5478.6 5479.4 5480.6 5483.8 5484.0 5846.1 5867.3 5933.0 5943.0 5960.3 5721.3 5746.4 5749.9 5753.7 5759.2 5846.1 5847.7 5848.0 5856.3 5857.3 5629.0 5714.1 5809.4 5831.0 5836.9 5799.9 5809.2 5817.2 5820.8 5823.1 4344.7 4429.7 4431.1 4434.0 4469.2 3979.1 4036.2 4048.3 4058.2 4082.8 5503.0 5508.3 5508.4 5515.7 5516.5 5713.1 5772.2 5795.2 5869.2 5871.3 5488.5 5511.4 5518.9 5521.1 5541.5 5043.1 5047.7 5048.0 5052.5 5076.0 5905.5 5942.6 6007.9 6054.7 6057.5 5835.0 5835.9 5846.3 5851.9 5853.4 5996.8 5998.1 6009.6 6010.3 6022.2 5642.4 5713.3 5753.5 5764.0 5771.2 5864.1 5900.4 5905.2 5910.4 5911.9 5682.8 5700.2 5700.3 5700.6 5708.0 5527.9 5718.7 5758.4 5780.4 5805.0 5594.0 5611.6 5616.4 5619.3 5628.0 5580.2 5715.2 5715.9 5720.4 5727.3 5489.8 5533.3 5596.2 5715.6 5738.3 16:19:48 INFO - PROCESS | 19949 | 16:19:48 INFO - PROCESS | 19949 | [#1] ext.html Cycles:180 Average:44660.65 Median:38956.81 stddev:69751.48 (179.0%) stddev-sans-first:69868.41 16:19:48 INFO - PROCESS | 19949 | Values: 519.5 545.3 547.5 553.0 579.4 32594.3 40962.6 41643.8 41670.0 41680.2 43573.0 44535.0 44584.3 44606.0 44649.3 8888.9 9080.0 9101.1 9101.6 9101.7 8832.2 8927.9 8955.9 8956.2 9229.5 9194.3 9282.4 9294.0 9306.0 9317.7 9117.9 9183.3 9221.0 9224.1 9227.1 9129.3 9266.2 9270.5 9275.9 9276.8 42822.0 43185.4 43343.8 43380.6 43407.0 3618.9 3712.1 3731.9 3961.2 4140.6 32699.7 32875.0 32979.0 33125.2 33150.3 4114.0 4162.3 4191.7 4232.0 4242.9 211241.0 212257.0 213638.0 213668.0 213849.0 47280.0 47780.8 65861.7 66582.7 66705.3 46223.5 46240.5 46258.8 46314.8 46377.8 16409.2 16427.3 16526.8 16561.0 16565.0 13790.6 13818.0 13818.4 13852.9 13879.4 15564.5 16045.8 16105.7 16130.0 16142.7 6050.0 6091.8 6097.6 6133.6 6153.9 1019.5 1033.2 1049.0 1060.1 1185.1 30638.7 30723.0 30832.8 31208.4 31363.0 1159.1 1178.1 1215.9 1271.6 1287.5 15878.4 15915.3 16011.1 16151.3 16753.5 324144.0 327048.0 327514.0 327558.0 329618.0 59298.4 59557.0 59773.7 59802.0 59928.0 1388.6 1471.3 1474.1 1506.5 1518.6 30017.8 30097.7 30183.5 30312.8 30562.0 46869.0 47579.8 48134.3 48181.8 48443.3 233835.0 234852.0 234883.0 235853.0 302829.0 34847.8 35128.8 35129.6 35216.1 35426.0 43022.8 43344.0 44330.0 44339.0 47973.5 38760.4 39022.8 39050.6 39182.8 39265.8 37608.8 38186.4 38818.0 38890.8 39225.2 38389.2 38781.0 39080.6 39773.8 39954.2 33636.7 34976.5 35201.3 35451.3 35569.0 26557.9 26775.5 26862.9 26925.9 27519.7 16:19:48 INFO - PROCESS | 19949 | 16:19:48 INFO - PROCESS | 19949 | [#2] jquery.html Cycles:180 Average:27009.85 Median:22020.56 stddev:77686.83 (352.8%) stddev-sans-first:77879.03 16:19:48 INFO - PROCESS | 19949 | Values: 380.1 380.6 388.8 388.8 391.6 17595.7 19425.9 19759.2 19990.9 20151.5 18143.6 18201.7 18296.1 18346.0 18413.3 5728.2 5878.8 5905.8 5914.3 5915.7 4348.1 6130.5 6319.0 6357.3 6361.4 6083.4 6282.2 6293.6 6307.3 6335.5 6384.6 6401.9 6406.1 6410.8 6416.5 3955.9 5362.8 5507.8 5512.5 5514.9 21933.0 22108.1 22346.3 22655.7 22767.1 2372.6 2383.6 2388.8 2409.1 2544.5 13809.4 13825.4 13925.2 13936.8 14253.9 1944.2 1981.8 2027.6 2075.8 2095.5 63818.0 63984.0 64661.7 65409.3 66800.7 10664.6 10774.8 10914.8 11061.2 11181.3 14756.4 14824.5 14827.3 14842.8 14862.3 8170.3 8286.6 8293.5 8380.2 8380.7 7556.3 7639.2 7713.8 7715.8 8112.3 6572.3 6699.8 6717.0 6722.8 6756.4 1822.8 1868.2 1908.3 1961.2 1962.5 1013.7 1039.7 1051.7 1081.4 1183.3 16897.7 17065.0 17160.5 17400.6 17457.8 1042.4 1043.6 1043.7 1055.9 1131.3 10365.2 10849.2 10849.6 10855.7 10861.0 459900.0 468095.0 480703.0 482292.0 487154.0 68187.3 68887.0 70264.6 70959.0 71455.3 1025.9 1027.0 1038.8 1041.6 1075.4 16245.4 16288.8 16348.9 16439.5 16483.0 33244.7 33981.3 34707.7 35115.6 35638.0 44768.3 45255.3 45275.8 45954.1 46425.5 8113.1 8264.3 8490.5 8546.7 8595.1 10285.3 12729.7 12822.5 12878.7 13280.1 11125.8 11226.8 11307.2 11421.4 11538.9 11142.8 11191.8 11458.5 11464.7 11550.2 10694.7 11101.7 11349.0 11769.7 11889.9 8723.1 8753.8 8854.4 8945.0 8980.8 11592.3 11653.8 11815.8 11870.6 11919.4 16:19:48 INFO - PROCESS | 19949 | 16:19:48 INFO - PROCESS | 19949 | [#3] mootools.html Cycles:180 Average:5822.69 Median:5287.23 stddev:2996.87 (56.7%) stddev-sans-first:2987.55 16:19:48 INFO - PROCESS | 19949 | Values: 1486.5 1592.5 1610.7 1884.6 1978.7 7388.5 7916.6 8056.4 8069.8 8074.2 8016.9 8173.9 8182.7 8190.1 8192.1 2116.1 2162.3 2298.8 2333.8 2392.2 2413.1 2424.6 2424.7 2425.6 2425.8 2364.8 2377.6 2392.3 2456.4 2456.6 2407.6 2459.3 2470.1 2471.9 2474.1 2398.1 2402.1 2409.5 2414.5 2415.0 8279.8 8326.5 8329.9 8340.5 8343.3 5121.9 5261.2 5268.9 5305.5 5312.0 3299.0 3314.7 3351.9 3367.9 3390.3 1012.5 1017.7 1019.8 1034.4 1080.0 11324.8 11449.1 11470.6 11474.2 11479.5 4490.2 4522.3 4557.1 4573.5 4574.0 9972.5 10028.2 10045.4 10051.7 10053.2 5021.8 5039.6 5053.0 5054.8 5060.8 4173.6 4577.5 4701.7 4811.9 4814.6 3973.1 4005.9 4030.5 4060.5 4079.4 1266.1 1289.8 1290.3 1301.2 1305.2 1284.4 1457.2 1465.4 1480.2 1494.2 7799.6 7822.6 7860.4 7863.4 7869.4 1218.2 1242.2 1242.5 1246.1 1269.3 6156.6 6245.9 6307.5 6309.6 6310.4 9970.8 10104.2 10128.1 10175.2 10176.3 9233.7 9770.2 9812.3 9971.1 9997.7 7578.3 7632.2 7666.9 7697.1 7715.7 7694.3 7725.2 7795.7 7838.5 7858.2 8752.4 8912.9 9083.8 9121.4 9150.2 9253.2 9403.5 9482.1 9607.2 9626.4 6960.9 7048.4 7564.7 8098.0 8183.9 7692.3 7716.5 7744.0 7744.3 7755.5 6718.5 6856.5 6871.6 6982.3 7016.9 6904.4 6950.2 6996.6 7014.8 7068.0 7278.1 7292.7 7316.5 7474.9 7489.7 6953.5 6956.0 6981.6 6988.8 7003.1 6649.4 6806.1 6817.5 6840.5 7112.5 16:19:48 INFO - PROCESS | 19949 | 16:19:48 INFO - PROCESS | 19949 | [#4] prototype.html Cycles:180 Average:5392.62 Median:6060.65 stddev:1594.58 (26.3%) stddev-sans-first:1553.95 16:19:48 INFO - PROCESS | 19949 | Values: 375.8 380.2 382.5 385.1 389.2 5979.0 6031.0 6040.0 6056.0 6056.2 5961.7 5974.7 5981.0 5983.8 5986.4 4477.9 4527.4 4587.4 4692.3 4695.4 4634.9 4673.4 4687.1 4705.4 4724.5 4653.5 4668.2 4675.3 4685.5 4689.3 4486.7 4531.9 4640.2 4681.3 4698.0 4125.2 4127.9 4142.2 4150.2 4160.3 5623.7 5673.3 5687.8 5695.0 5696.9 5491.0 5495.6 5503.1 5507.8 5509.4 6344.1 6349.5 6352.7 6353.5 6353.7 4327.2 4434.5 4663.4 4672.2 4673.0 6542.1 6563.2 6618.1 6627.2 6629.5 4671.0 4674.5 4674.7 4675.1 4676.5 4734.5 4736.1 4737.0 4739.6 4743.2 5364.2 5370.6 5377.2 5378.4 5381.2 6188.3 6385.6 6390.6 6397.2 6402.9 1649.9 1653.1 1669.6 1669.7 1669.8 1051.2 1100.6 1106.7 1116.2 1122.9 6092.4 6210.9 6215.2 6250.6 6257.1 6639.9 6651.0 6651.6 6654.5 6663.8 6221.3 6226.1 6227.4 6234.9 6247.0 3558.1 3579.2 3589.9 3596.6 3597.8 6708.5 6830.6 6850.7 6865.5 6867.9 6742.3 6771.3 6790.7 6792.3 6794.3 6816.7 6817.4 6818.4 6819.0 6826.1 6626.1 6630.6 6632.1 6634.1 6634.4 6403.4 6521.3 6527.5 6530.1 6559.3 6814.6 6849.2 6853.8 6861.5 6915.0 4795.7 4845.3 4847.4 4850.8 4852.6 6564.1 6571.3 6571.5 6572.7 6576.2 6254.5 6404.5 6406.0 6409.0 6412.0 6456.8 6469.7 6477.6 6493.7 6498.9 6373.4 6375.8 6376.8 6381.9 6388.0 6489.9 6492.4 6492.8 6501.7 6504.6 6020.4 6065.1 6340.3 6343.9 6344.7 16:19:48 INFO - PROCESS | 19949 | 16:19:48 INFO - PROCESS | 19949 | [#5] yui.html Cycles:180 Average:14851.84 Median:26197.11 stddev:16936.04 (64.6%) stddev-sans-first:16950.79 16:19:48 INFO - PROCESS | 19949 | Values: 825.5 862.1 905.8 912.2 941.0 14895.0 14992.3 14994.9 15060.2 15074.5 15951.9 16068.8 16079.7 16081.1 16112.8 784.4 933.0 950.3 954.2 955.2 794.7 800.6 802.9 945.6 964.9 996.2 996.4 997.9 998.1 998.4 985.4 987.1 987.6 988.2 988.5 612.2 731.5 734.7 740.8 746.4 15336.6 15403.4 15426.5 15465.7 15494.3 13643.9 14214.1 14288.4 14336.3 14337.2 11627.4 11638.2 11797.4 11850.8 11914.5 3839.3 3839.6 3843.3 3855.1 3882.7 55508.4 55647.4 55838.0 56357.0 56402.4 9710.0 10196.6 10368.9 10568.7 10591.5 19792.5 19934.7 19955.1 19965.7 19987.6 7755.2 7793.7 7947.0 8153.1 8191.7 4532.8 4642.3 4650.7 4670.3 4680.5 3416.9 3439.9 3440.9 3444.6 3449.0 601.5 620.6 625.9 634.0 637.2 652.6 720.2 722.8 729.6 761.6 8210.5 8616.8 8712.7 8764.9 8826.7 693.4 716.2 718.7 723.9 724.7 4105.7 4130.7 4167.4 4358.0 4360.7 57778.0 57934.7 58908.4 60128.4 60254.0 49961.0 50436.7 50532.7 50875.5 51821.0 49175.5 49356.5 49815.0 49903.3 50015.2 8698.3 9003.8 9136.2 9146.7 9180.5 36548.8 36588.3 36759.4 37792.2 38213.6 43185.4 47713.8 50003.7 50346.2 50802.2 11369.4 11423.1 11548.2 11574.9 11873.2 13340.2 13378.1 13416.8 13522.0 13664.7 12167.7 12227.9 12280.8 12391.3 12575.9 12185.8 12407.9 12465.2 12663.7 12808.2 11340.9 11393.3 11662.7 12046.9 12527.8 10198.8 10260.2 10323.5 10455.0 10507.4 9828.7 9875.9 9887.6 9894.9 10089.6 16:19:48 INFO - PROCESS | 19949 | -------- Summary: end -------- 16:19:48 INFO - PROCESS | 19949 | 16:19:49 INFO - TEST-INFO | 19949: exit 0 16:19:49 INFO - TEST-OK | dromaeo_css | took 1112500ms 16:19:49 INFO - TEST-START | kraken 16:19:49 INFO - operating with platform_type : linux_ 16:19:49 INFO - Initialising browser for kraken test... 16:19:49 INFO - TEST-INFO | started process 20143 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbk5naN/profile http://localhost:38804/getInfo.html) 16:19:54 INFO - PROCESS | 20143 | __metrics Screen width/height:1600/1200 16:19:54 INFO - PROCESS | 20143 | colorDepth:24 16:19:54 INFO - PROCESS | 20143 | Browser inner width/height: 1024/697 16:19:54 INFO - PROCESS | 20143 | __metrics 16:19:54 INFO - PROCESS | 20143 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:19:55 INFO - TEST-INFO | 20143: exit 0 16:19:55 INFO - Browser initialized. 16:19:55 INFO - Running cycle 1/1 for kraken test... 16:19:55 INFO - TEST-INFO | started process 20237 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbk5naN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:07 INFO - PROCESS | 20237 | RSS: Main: 143765504 16:20:07 INFO - PROCESS | 20237 | 16:20:10 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38804/tests/kraken/driver.html?testName=audio-beat-detection) 16:20:10 INFO - PROCESS | 20237 | RSS: Main: 180682752 16:20:10 INFO - PROCESS | 20237 | 16:20:13 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38804/tests/kraken/driver.html?testName=audio-dft) 16:20:13 INFO - PROCESS | 20237 | RSS: Main: 178892800 16:20:13 INFO - PROCESS | 20237 | 16:20:16 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38804/tests/kraken/driver.html?testName=audio-fft) 16:20:17 INFO - PROCESS | 20237 | RSS: Main: 176160768 16:20:17 INFO - PROCESS | 20237 | 16:20:19 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38804/tests/kraken/driver.html?testName=audio-oscillator) 16:20:19 INFO - PROCESS | 20237 | RSS: Main: 175554560 16:20:19 INFO - PROCESS | 20237 | 16:20:21 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38804/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:20:22 INFO - PROCESS | 20237 | RSS: Main: 172814336 16:20:22 INFO - PROCESS | 20237 | 16:20:25 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38804/tests/kraken/driver.html?testName=imaging-darkroom) 16:20:26 INFO - PROCESS | 20237 | RSS: Main: 172060672 16:20:26 INFO - PROCESS | 20237 | 16:20:29 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38804/tests/kraken/driver.html?testName=imaging-desaturate) 16:20:30 INFO - PROCESS | 20237 | RSS: Main: 172044288 16:20:30 INFO - PROCESS | 20237 | 16:20:32 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38804/tests/kraken/driver.html?testName=json-parse-financial) 16:20:33 INFO - PROCESS | 20237 | RSS: Main: 173465600 16:20:33 INFO - PROCESS | 20237 | 16:20:34 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38804/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:20:35 INFO - PROCESS | 20237 | RSS: Main: 178847744 16:20:35 INFO - PROCESS | 20237 | 16:20:37 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:20:37 INFO - PROCESS | 20237 | RSS: Main: 175722496 16:20:37 INFO - PROCESS | 20237 | 16:20:39 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:20:40 INFO - PROCESS | 20237 | RSS: Main: 183291904 16:20:40 INFO - PROCESS | 20237 | 16:20:42 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:20:43 INFO - PROCESS | 20237 | RSS: Main: 188284928 16:20:43 INFO - PROCESS | 20237 | 16:20:45 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:20:46 INFO - PROCESS | 20237 | RSS: Main: 188739584 16:20:46 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | Cycle 1(1): loaded http://localhost:38804/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38804/tests/kraken/driver.html?testName=ai-astar) 16:20:48 INFO - PROCESS | 20237 | RSS: Main: 247861248 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | __start_tp_report 16:20:48 INFO - PROCESS | 20237 | _x_x_mozilla_page_load 16:20:48 INFO - PROCESS | 20237 | _x_x_mozilla_page_load_details 16:20:48 INFO - PROCESS | 20237 | |i|pagename|runs| 16:20:48 INFO - PROCESS | 20237 | |0;ai-astar;111;110;107;111;109;109;100;109;110;109 16:20:48 INFO - PROCESS | 20237 | |1;audio-beat-detection;148;125;150;170;127;159;159;125;169;127 16:20:48 INFO - PROCESS | 20237 | |2;audio-dft;160;162;161;160;162;162;160;163;160;160 16:20:48 INFO - PROCESS | 20237 | |3;audio-fft;72;76;76;162;78;75;75;74;167;75 16:20:48 INFO - PROCESS | 20237 | |4;audio-oscillator;93;93;134;93;93;93;150;94;94;146 16:20:48 INFO - PROCESS | 20237 | |5;imaging-gaussian-blur;117;116;117;116;118;118;117;117;118;118 16:20:48 INFO - PROCESS | 20237 | |6;imaging-darkroom;145;145;145;146;145;145;145;145;146;145 16:20:48 INFO - PROCESS | 20237 | |7;imaging-desaturate;96;95;96;96;95;96;95;96;95;95 16:20:48 INFO - PROCESS | 20237 | |8;json-parse-financial;54;55;54;54;54;54;54;63;55;52 16:20:48 INFO - PROCESS | 20237 | |9;json-stringify-tinderbox;64;65;64;63;64;65;65;64;64;64 16:20:48 INFO - PROCESS | 20237 | |10;stanford-crypto-aes;77;78;78;78;78;76;77;76;77;78 16:20:48 INFO - PROCESS | 20237 | |11;stanford-crypto-ccm;110;110;118;108;112;112;106;113;122;108 16:20:48 INFO - PROCESS | 20237 | |12;stanford-crypto-pbkdf2;136;136;137;136;140;136;135;135;143;136 16:20:48 INFO - PROCESS | 20237 | |13;stanford-crypto-sha256-iterative;64;66;64;64;65;64;66;65;67;64 16:20:48 INFO - PROCESS | 20237 | __end_tp_report 16:20:48 INFO - PROCESS | 20237 | __start_cc_report 16:20:48 INFO - PROCESS | 20237 | _x_x_mozilla_cycle_collect,1037 16:20:48 INFO - PROCESS | 20237 | __end_cc_report 16:20:48 INFO - PROCESS | 20237 | __startTimestamp1457997648316__endTimestamp 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | ------- Summary: start ------- 16:20:48 INFO - PROCESS | 20237 | Number of tests: 14 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.50 stddev:3.21 (2.9%) stddev-sans-first:3.27 16:20:48 INFO - PROCESS | 20237 | Values: 111.0 110.0 107.0 111.0 109.0 109.0 100.0 109.0 110.0 109.0 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:154.50 stddev:18.46 (11.9%) stddev-sans-first:19.56 16:20:48 INFO - PROCESS | 20237 | Values: 148.0 125.0 150.0 170.0 127.0 159.0 159.0 125.0 169.0 127.0 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.15 (0.7%) stddev-sans-first:1.17 16:20:48 INFO - PROCESS | 20237 | Values: 160.0 162.0 161.0 160.0 162.0 162.0 160.0 163.0 160.0 160.0 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.00 stddev:37.73 (50.3%) stddev-sans-first:39.25 16:20:48 INFO - PROCESS | 20237 | Values: 72.0 76.0 76.0 162.0 78.0 75.0 75.0 74.0 167.0 75.0 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.00 stddev:24.50 (26.3%) stddev-sans-first:25.35 16:20:48 INFO - PROCESS | 20237 | Values: 93.0 93.0 134.0 93.0 93.0 93.0 150.0 94.0 94.0 146.0 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 16:20:48 INFO - PROCESS | 20237 | Values: 117.0 116.0 117.0 116.0 118.0 118.0 117.0 117.0 118.0 118.0 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 16:20:48 INFO - PROCESS | 20237 | Values: 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:20:48 INFO - PROCESS | 20237 | Values: 96.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.00 stddev:2.96 (5.5%) stddev-sans-first:3.12 16:20:48 INFO - PROCESS | 20237 | Values: 54.0 55.0 54.0 54.0 54.0 54.0 54.0 63.0 55.0 52.0 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 16:20:48 INFO - PROCESS | 20237 | Values: 64.0 65.0 64.0 63.0 64.0 65.0 65.0 64.0 64.0 64.0 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:78.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 16:20:48 INFO - PROCESS | 20237 | Values: 77.0 78.0 78.0 78.0 78.0 76.0 77.0 76.0 77.0 78.0 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#11] stanford-crypto-ccm Cycles:10 Average:111.90 Median:112.00 stddev:4.86 (4.3%) stddev-sans-first:5.11 16:20:48 INFO - PROCESS | 20237 | Values: 110.0 110.0 118.0 108.0 112.0 112.0 106.0 113.0 122.0 108.0 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.00 Median:136.00 stddev:2.54 (1.9%) stddev-sans-first:2.67 16:20:48 INFO - PROCESS | 20237 | Values: 136.0 136.0 137.0 136.0 140.0 136.0 135.0 135.0 143.0 136.0 16:20:48 INFO - PROCESS | 20237 | 16:20:48 INFO - PROCESS | 20237 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.10 (1.7%) stddev-sans-first:1.12 16:20:48 INFO - PROCESS | 20237 | Values: 64.0 66.0 64.0 64.0 65.0 64.0 66.0 65.0 67.0 64.0 16:20:48 INFO - PROCESS | 20237 | -------- Summary: end -------- 16:20:48 INFO - PROCESS | 20237 | 16:20:49 INFO - TEST-INFO | 20237: exit 0 16:20:49 INFO - TEST-OK | kraken | took 59794ms 16:20:49 INFO - SUITE-END | took 1172s 16:20:49 INFO - Completed test suite (00:19:32) 16:20:49 INFO - javascript benchmark 16:20:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3265.7224135948445, 3348.614909285433, 3360.1767566946087, 3366.9831650841743, 3398.048546407006, 5355.3305836770405, 5408.405075441703, 5425.240466334716, 5452.536534394576, 5483.616146869721, 5375.193720941861, 5386.111291636876, 5430.8099216527335, 5433.103537916249, 5454.890902181954, 4786.71279723216, 4914.926276105853, 4970.0, 4987.501249875002, 5019.021290848286, 4898.706077635354, 4966.279889416032, 4968.726720030397, 4970.378702662168, 4985.052839960414, 4898.093852637256, 4918.827841025565, 4980.875478113058, 4989.950100498985, 5001.1248031594505, 4978.576820970222, 5001.524855138774, 5005.549500544968, 5006.424261209934, 5027.924581131268, 4799.952000479985, 4848.927266091011, 4943.555080042814, 4944.184209605411, 4954.603631709455, 5233.345831771028, 5236.0, 5249.501297376743, 5252.553532949704, 5297.284866543045, 5702.173184888168, 5785.132230165509, 5797.797077102281, 5850.941490585083, 5853.268341457318, 5837.6497410155525, 5855.326637436664, 5872.853178670524, 5888.852778680524, 5905.881882362329, 5478.643888147258, 5479.369872464677, 5480.616356854982, 5483.8080667176855, 5483.972580137074, 5846.093855452412, 5867.266591676041, 5932.970335148297, 5943.0194017987415, 5960.344362120163, 5721.256236689203, 5746.396628354046, 5749.9425005750245, 5753.654780713171, 5759.22250496186, 5846.0646296593195, 5847.736851841677, 5848.0, 5856.297244330707, 5857.297124345021, 5628.97185514078, 5714.142878568248, 5809.390014048548, 5830.970845145747, 5836.941630583639, 5799.942000580025, 5809.186713860063, 5817.185594016756, 5820.8253752386645, 5823.068309070529, 4344.717593356421, 4429.734215947054, 4431.091626216617, 4433.955660443419, 4469.240229161051, 3979.144483935968, 4036.1524079943542, 4048.3320252158064, 4058.228936502055, 4082.7754473503646, 5502.972485137549, 5508.3114610673665, 5508.394076651565, 5515.696636685021, 5516.475934786189, 5713.085906254979, 5772.191893134965, 5795.217645617872, 5869.178315035899, 5871.266091738533, 5488.451154884479, 5511.3937466879415, 5518.862028449321, 5521.116621340566, 5541.501264886179, 5043.117454445457, 5047.697138171721, 5048.040872234264, 5052.520010598987, 5075.984803039407, 5905.527557795366, 5942.58401911862, 6007.879842403127, 6054.727537260834, 6057.545684073712, 5834.970825145847, 5835.912461312999, 5846.29844418664, 5851.882962340645, 5853.385394533683, 5996.820095397145, 5998.130271110577, 6009.639421634716, 6010.338862725184, 6022.187004754477, 5642.351129620146, 5713.342965559014, 5753.539716822561, 5763.971180144073, 5771.249737534094, 5864.091065884794, 5900.380460051632, 5905.173275741314, 5910.408959104056, 5911.852203694942, 5682.801101961411, 5700.201971723879, 5700.258966334516, 5700.600957933071, 5707.971460142673, 5527.8894422110525, 5718.742656580547, 5758.395368486249, 5780.421957804186, 5805.0, 5593.965116453469, 5611.607187496836, 5616.438356164351, 5619.269494965792, 5627.971860140673, 5580.190872323572, 5715.171300161536, 5715.8571035724435, 5720.39935806751, 5727.341355743976, 5489.780408783604, 5533.253010843485, 5596.216529685766, 5715.628484148517, 5738.282714660668], "unit": "score", "name": "dojo.html", "value": 5374.8029709963985}, {"lowerIsBetter": false, "replicates": [519.4649511003668, 545.3265217456441, 547.5181839980817, 552.9612927095102, 579.4466284698112, 32594.348113037726, 40962.59037409629, 41643.79178104113, 41670.0, 41680.16639667205, 43573.0, 44535.0, 44584.3312350315, 44606.0, 44649.330260046125, 8888.911110888888, 9080.046595107518, 9101.135392137736, 9101.63593456261, 9101.681441149562, 8832.249258813008, 8927.910720892805, 8955.910440895605, 8956.19394254517, 9229.538523073854, 9194.31042671799, 9282.350235483518, 9294.0, 9306.022867598906, 9317.673881414152, 9117.908820911805, 9183.265338772915, 9221.031791661846, 9224.07759224079, 9227.123423274777, 9129.269658427376, 9266.166045055978, 9270.536473176315, 9275.860862087075, 9276.814463710689, 42822.0, 43185.352219716726, 43343.78328108339, 43380.56619433829, 43407.0, 3618.945715814265, 3712.0905378182247, 3731.8880433587037, 3961.1681546875193, 4140.648044916185, 32699.6730032699, 32875.0, 32979.0, 33125.17187070318, 33150.33699326024, 4113.958860411388, 4162.334026555736, 4191.72753771007, 4231.97884010581, 4242.936355954663, 211241.0, 212257.0, 213638.0, 213668.0, 213849.0, 47280.0, 47780.7610961943, 65861.67069164623, 66582.66708666425, 66705.33294667088, 46223.5377646226, 46240.53759462429, 46258.768706156254, 46314.76842615765, 46377.768111159225, 16409.179541022902, 16427.260773265232, 16526.752098718527, 16561.0, 16565.0, 13790.586282411543, 13818.0, 13818.37817298224, 13852.861471385359, 13879.375428105759, 15564.533064008097, 16045.759313610306, 16105.677886442205, 16130.0, 16142.677146457005, 6049.969750151309, 6091.786787462417, 6097.60365576245, 6133.570650054543, 6153.907691384633, 1019.5004447820514, 1033.1992705653179, 1049.0453687144661, 1060.0883240413239, 1185.1111666250313, 30638.69361306403, 30723.0, 30832.845835771128, 31208.375832483678, 31363.0, 1159.1422347462985, 1178.0810967445407, 1215.8601760797621, 1271.5613113475836, 1287.4978758284276, 15878.364865405254, 15915.283812228477, 16011.119388433515, 16151.273192706356, 16753.497395078168, 324144.0, 327048.0, 327514.0, 327558.0, 329618.0, 59298.40701593015, 59557.0, 59773.70113149406, 59802.0, 59928.0, 1388.6042477893955, 1471.3378979459287, 1474.0787008119926, 1506.4501456968128, 1518.6431188670654, 30017.849910750305, 30097.69902300949, 30183.547246790877, 30312.84843575768, 30562.0, 46869.0, 47579.76210118927, 48134.27798582954, 48181.759091204316, 48443.27335089906, 233835.0, 234852.0, 234883.0, 235853.0, 302829.0, 34847.825760871034, 35128.82435587908, 35129.64870351366, 35216.11959701028, 35426.0, 43022.784886075366, 43344.0, 44330.0, 44339.0, 47973.520264796905, 38760.41859372168, 39022.80488597539, 39050.60949390583, 39182.80408597939, 39265.80367098146, 37608.811955940044, 38186.42720359141, 38818.0, 38890.80554597209, 39225.2154956905, 38389.232215354976, 38781.0, 39080.609193907694, 39773.80113099416, 39954.20091598094, 33636.66363336335, 34976.475352870235, 35201.29597408089, 35451.29097418089, 35569.0, 26557.937682493255, 26775.464490709688, 26862.865685671448, 26925.865370673022, 27519.724802751716], "unit": "score", "name": "ext.html", "value": 18999.22883165945}, {"lowerIsBetter": false, "replicates": [380.1389851985254, 380.6459992207247, 388.7706253310547, 388.8153127264548, 391.60252343870974, 17595.744787214357, 19425.902870485665, 19759.209631614718, 19990.90004549977, 20151.49621259469, 18143.63712725748, 18201.726974095367, 18296.085195740226, 18346.0, 18413.26346946124, 5728.198052272674, 5878.764849406019, 5905.822825315226, 5914.319853216892, 5915.704214789243, 4348.130373925212, 6130.509559235273, 6318.968405157968, 6357.268914074872, 6361.4274715275615, 6083.391660833925, 6282.24613046435, 6293.55945083842, 6307.274663413697, 6335.524835637322, 6384.553081284312, 6401.9039714404325, 6406.135171751824, 6410.775622853178, 6416.518761092913, 3955.881323560298, 5362.758675859557, 5507.807226747044, 5512.531434828044, 5514.91727624086, 21933.01301441439, 22108.115675372967, 22346.329610111723, 22655.660165097535, 22767.089316427322, 2372.5847976604027, 2383.5947888858936, 2388.820838437124, 2409.0725070847675, 2544.5038217547585, 13809.378577963915, 13825.446982120704, 13925.23411212393, 13936.790948135786, 14253.928730356281, 1944.2320283487943, 1981.8216360527622, 2027.553938133623, 2075.7509098908076, 2095.518030852897, 63818.0, 63984.0, 64661.67669161671, 65409.3459065408, 66800.66599667018, 10664.573417063231, 10774.838377424188, 10914.836277455845, 11061.225714199929, 11181.273217240854, 14756.40974361035, 14824.481143159937, 14827.258637068104, 14842.777358339634, 14862.331195096247, 8170.264676179172, 8286.627101780434, 8293.460925039853, 8380.161983801692, 8380.748577542683, 7556.319931206218, 7639.236076392427, 7713.807154821175, 7715.807104822312, 8112.3104536113915, 6572.309907459744, 6699.76550820719, 6717.018479548545, 6722.798316050526, 6756.3919247266995, 1822.8177182281665, 1868.1873385077536, 1908.3320837706692, 1961.1665042356942, 1962.5486138188296, 1013.716159475348, 1039.6828967165088, 1051.6897515233024, 1081.3782075306574, 1183.3195912350434, 16897.746533802, 17065.0, 17160.485185444457, 17400.5649858752, 17457.825421745874, 1042.4058286776465, 1043.639944219243, 1043.7286305560608, 1055.9366438013744, 1131.298594871185, 10365.222608304257, 10849.240553161202, 10849.620263290746, 10855.728606784736, 10861.022507974163, 459900.0, 468095.0, 480703.0, 482292.0, 487154.0, 68187.31812681908, 68887.0, 70264.64867675629, 70959.0, 71455.2854471459, 1025.887152413234, 1026.9640562580273, 1038.7974345002804, 1041.6406339812752, 1075.3977772447454, 16245.350185992427, 16288.755668665217, 16348.918255408647, 16439.506814795575, 16483.0, 33244.66755332416, 33981.320373592884, 34707.65292347044, 35115.64884351124, 35638.0, 44768.328475073555, 45255.32117018313, 45275.77362113168, 45954.08091838211, 46425.53574464212, 8113.148119447609, 8264.297534709616, 8490.533020683675, 8546.743597692079, 8595.140485951355, 10285.331453455501, 12729.681757956125, 12822.487100515875, 12878.67803304925, 13280.070395072253, 11125.833112503156, 11226.775464490827, 11307.151963602599, 11421.401003859632, 11538.88461115378, 11142.777144456903, 11191.776164476827, 11458.541658333907, 11464.713382165513, 11550.249233799776, 10694.679159625224, 11101.722456938642, 11349.035331996873, 11769.705757356134, 11889.881101188877, 8723.127687231226, 8753.824923501621, 8854.380193386402, 8945.0, 8980.820383592421, 11592.304461732323, 11653.76692466163, 11815.82276265874, 11870.643880683594, 11919.404029798648], "unit": "score", "name": "jquery.html", "value": 9137.52465768801}, {"lowerIsBetter": false, "replicates": [1486.509451880878, 1592.5302035899408, 1610.6698126883994, 1884.594812115395, 1978.6636271833786, 7388.482806203568, 7916.604169791509, 8056.355491560676, 8069.798255043619, 8074.152214017532, 8016.91983080169, 8173.877391839127, 8182.67269309227, 8190.05814331352, 8192.057913339968, 2116.121809449077, 2162.297253392646, 2298.78161574651, 2333.7549557296493, 2392.1866565367773, 2413.1312727418117, 2424.5635785558593, 2424.696912885889, 2425.575524283252, 2425.757424257569, 2364.7517010713887, 2377.6314671225987, 2392.3301475586863, 2456.3981824453035, 2456.6069428891383, 2407.61478163493, 2459.262221333611, 2470.0737223541173, 2471.888765005579, 2474.084588702183, 2398.124684490166, 2402.0631953538136, 2409.5180963807306, 2414.4929564791414, 2414.9517009659885, 8279.793005174859, 8326.50040997542, 8329.916700832975, 8340.541270230135, 8343.290820280283, 5121.923171152435, 5261.158214685632, 5268.947310526884, 5305.522502974751, 5312.0, 3299.0432774495366, 3314.734821214297, 3351.882684106069, 3367.9494807577908, 3390.3049874775857, 1012.5089331674133, 1017.6590842067842, 1019.7909428567126, 1034.3845411979935, 1079.9730006749814, 11324.773504529863, 11449.084073274118, 11470.598529051527, 11474.196806223568, 11479.483423245974, 4490.191765482179, 4522.321651752263, 4557.065801510748, 4573.519780423007, 4574.0, 9972.501374931224, 10028.197744180448, 10045.447500387403, 10051.748706282402, 10053.246006549538, 5021.774020169101, 5039.622028347889, 5052.964142350809, 5054.848354549369, 5060.7722652480725, 4173.64524015456, 4577.450705915311, 4701.670883038223, 4811.879703007453, 4814.566688998007, 3973.1259122992897, 4005.8583303758874, 4030.496187976503, 4060.5330387005874, 4079.3676980068135, 1266.1010682415588, 1289.774289499334, 1290.2903403128241, 1301.2062641788502, 1305.1516514265804, 1284.3706583773883, 1457.2203870929213, 1465.377214683755, 1480.2376775960388, 1494.2080697230485, 7799.610019499116, 7822.6088695564995, 7860.449768516149, 7863.37093032556, 7869.409794265453, 1218.214251807579, 1242.167747609104, 1242.4781591731314, 1246.0841281657974, 1269.3018839638346, 6156.569040167145, 6245.937540624626, 6307.5269354798575, 6309.621422714652, 6310.368963103653, 9970.750731231632, 10104.242181836391, 10128.088472037552, 10175.185985121172, 10176.287659863738, 9233.676821311356, 9770.169535589412, 9812.313138080408, 9971.10260076582, 9997.650082247086, 7578.3179513842915, 7632.1986191450205, 7666.923330766733, 7697.076350837935, 7715.691372345155, 7694.269044440769, 7725.150233474201, 7795.727149549739, 7838.529688218725, 7858.174891636296, 8752.431091979, 8912.910870891468, 9083.818323633623, 9121.40710853819, 9150.176484116462, 9253.213476854542, 9403.4828084456, 9482.099200575934, 9607.183389411699, 9626.374285671409, 6960.9303906962305, 7048.400885924754, 7564.659590318559, 8098.0, 8183.918160818315, 7692.269234422721, 7716.459847810599, 7744.0, 7744.341730952932, 7755.457118001911, 6718.496112791658, 6856.5200435969, 6871.587704737732, 6982.266861979419, 7016.859662806613, 6904.4131248842405, 6950.235474097946, 6996.6151861648095, 7014.824629384306, 7068.045813815274, 7278.09023872016, 7292.708291668274, 7316.524425912512, 7474.850502989801, 7489.70041198346, 6953.513254072166, 6956.0, 6981.581105133709, 6988.79033628992, 7003.124609423822, 6649.368310010541, 6806.081179040964, 6817.522773405814, 6840.486963477859, 7112.502124851418], "unit": "score", "name": "mootools.html", "value": 4809.360768375776}, {"lowerIsBetter": false, "replicates": [375.791435753157, 380.21485632169583, 382.46454963051724, 385.05469073424746, 389.1749491078911, 5979.043353063511, 6031.0, 6040.03359462485, 6056.03103503439, 6056.1824153739235, 5961.672108034057, 5974.701264936747, 5981.043033114703, 5983.760649574023, 5986.401359864011, 4477.932831007537, 4527.3888025116685, 4587.42657167854, 4692.296155576665, 4695.389599352079, 4634.930476042862, 4673.415823022122, 4687.1328804171335, 4705.364775755281, 4724.480307166209, 4653.464851542082, 4668.18306796311, 4675.251959686434, 4685.484596694361, 4689.273162659776, 4486.663500237495, 4531.932021019687, 4640.164770341337, 4681.297805329194, 4697.953020469803, 4125.154343359604, 4127.9174416511505, 4142.150859073882, 4150.232207041677, 4160.313548264533, 5623.746931388097, 5673.319201695782, 5687.772489100473, 5695.0, 5696.886062278772, 5491.0116179087745, 5495.6153069285165, 5503.147012213113, 5507.752151153208, 5509.3664228613825, 6344.080108384258, 6349.4602958748565, 6352.714127864211, 6353.523485738542, 6353.650549219791, 4327.199468098381, 4434.512203657595, 4663.417072865892, 4672.15901137795, 4672.976635116803, 6542.149520562297, 6563.1796025496815, 6618.139641846577, 6627.1716035495565, 6629.469642428594, 4670.9766451167525, 4674.462436819741, 4674.696144750648, 4675.064987002545, 4676.50896655853, 4734.479207287196, 4736.052789442126, 4737.028909073631, 4739.644526660514, 4743.169945259635, 5364.249005139283, 5370.597205209625, 5377.166539186433, 5378.381486129067, 5381.165919282517, 6188.288346840171, 6385.584936979174, 6390.584612000205, 6397.200349956255, 6402.871942561216, 1649.9010059396235, 1653.115583163002, 1669.5575672446812, 1669.7495375693743, 1669.8330166983446, 1051.1800795379463, 1100.6352123367128, 1106.6790630717162, 1116.1907616977626, 1122.854028976228, 6092.3603021682975, 6210.875782484325, 6215.223097112861, 6250.624962502265, 6257.092721555349, 6639.86720265592, 6651.0, 6651.634160121143, 6654.467642588678, 6663.766768163091, 6221.2845522765465, 6226.097215903668, 6227.408396202353, 6234.906476402857, 6247.031710084944, 3558.1282585766653, 3579.158897659048, 3589.9282014359565, 3596.5504311961004, 3597.8380972856285, 6708.463322934153, 6830.624315662587, 6850.691718872663, 6865.485088618374, 6867.896981545281, 6742.325767423218, 6771.322867713189, 6790.694418751168, 6792.286809884989, 6794.286599907037, 6816.659167041628, 6817.352351526696, 6818.386345228953, 6818.965905170442, 6826.112605361272, 6626.072349871119, 6630.602163870183, 6632.137822083291, 6634.104395906491, 6634.402903738686, 6403.391677790602, 6521.293663129748, 6527.51043671717, 6530.053142294436, 6559.27847936717, 6814.568940522546, 6849.1780986281965, 6853.7943861684225, 6861.519693621598, 6915.0, 4795.688280261772, 4845.297431872288, 4847.418309802846, 4850.80596776125, 4852.611791056777, 6564.146660934239, 6571.277159512545, 6571.474282057328, 6572.671366431755, 6576.243731970884, 6254.468370188585, 6404.455621272058, 6405.967970160119, 6409.0, 6412.038194270896, 6456.838579035561, 6469.708863101077, 6477.643729594729, 6493.740250389931, 6498.935010650022, 6373.3945275198785, 6375.840603984938, 6376.808695739135, 6381.936180638134, 6387.968060159669, 6489.8702025960165, 6492.415682588589, 6492.805215843532, 6501.674916254074, 6504.642244676399, 6020.4280593343565, 6065.120557519223, 6340.302566717565, 6343.904841427475, 6344.71448784815], "unit": "score", "name": "prototype.html", "value": 4886.737204121785}, {"lowerIsBetter": false, "replicates": [825.5129473610565, 862.1421685423005, 905.7690288976312, 912.2428384440914, 941.049539964636, 14895.031822931516, 14992.250387480637, 14994.925025374885, 15060.24698765063, 15074.547763567098, 15951.920240398811, 16068.758968615452, 16079.678406431864, 16081.11553864537, 16112.75830862535, 784.3999340504519, 933.0389698610425, 950.325269058969, 954.1889394015101, 955.2405837359316, 794.6582969323189, 800.627708115726, 802.9277365037145, 945.6028468043438, 964.8745663063827, 996.173176263703, 996.3673067602089, 997.9002099789999, 998.1216529454107, 998.3959704378855, 985.4333758089056, 987.1214618989105, 987.6197663899378, 988.1501908358806, 988.5205675247499, 612.2499937576478, 731.5208538407352, 734.6657270941762, 740.7777666699968, 746.3916907720245, 15336.616584585363, 15403.3838646454, 15426.537203883901, 15465.690686186326, 15494.30275637599, 13643.863561364358, 14214.147151170859, 14288.428462861577, 14336.283185840666, 14337.211453370164, 11627.360495172763, 11638.185327027111, 11797.351145686984, 11850.762984740257, 11914.46384912681, 3839.2513459875336, 3839.558450778168, 3843.2889915365467, 3855.094052897567, 3882.6893848492055, 55508.44491555113, 55647.44352556463, 55838.0, 56357.0, 56402.43597564013, 9710.0, 10196.643117491001, 10368.948155259175, 10568.735781605521, 10591.470426478645, 19792.50518737014, 19934.70097948532, 19955.102020409115, 19965.700514492295, 19987.60024799496, 7755.185705500841, 7793.688252469838, 7946.960265198637, 8153.103158652543, 8191.71329003494, 4532.773361331986, 4642.326862604971, 4650.744209068466, 4670.346151538787, 4680.461746899082, 3416.8804091856664, 3439.8968030959113, 3440.8623655054016, 3444.603870554918, 3449.0170301463963, 601.4737105033096, 620.5749061892618, 625.8873402787542, 633.9904901426482, 637.2289529669059, 652.6280020388429, 720.218562859293, 722.757876111498, 729.5549714674045, 761.5811303782897, 8210.548419836967, 8616.78458038554, 8712.738617841474, 8764.8685269721, 8826.735197944072, 693.3928429106495, 716.2479396633514, 718.741253148866, 723.8769409200448, 724.69562783631, 4105.712600117963, 4130.731502452391, 4167.354060120686, 4357.9564204358185, 4360.694751367374, 57778.0, 57934.7103264481, 58908.41091589115, 60128.39871601316, 60254.0, 49961.0, 50436.747816260686, 50532.747336263084, 50875.49124508782, 51821.0, 49175.50824491781, 49356.50643493519, 49815.0, 49903.25145122826, 50015.24977125273, 8698.347623928357, 9003.819923601623, 9136.177744003071, 9146.725598232064, 9180.47447522047, 36548.81725591355, 36588.26823463569, 36759.448608271436, 37792.244155117296, 38213.61786382212, 43185.35221971736, 47713.76143119262, 50003.749981249865, 50346.244806328665, 50802.23796642979, 11369.374684392438, 11423.086153107564, 11548.191626586395, 11574.942125289319, 11873.228240164362, 13340.19958802475, 13378.13042152257, 13416.798748018982, 13522.0, 13664.658383540092, 12167.695807604527, 12227.938860305641, 12280.754384912074, 12391.256524608552, 12575.874241257836, 12185.817212741638, 12407.875921240671, 12465.189762665397, 12663.746725065632, 12808.231506109663, 11340.886591133984, 11393.316401015965, 11662.650120496399, 12046.879531204926, 12527.812082818948, 10198.847017294598, 10260.230482713678, 10323.48382580883, 10455.0, 10507.422091785025, 9828.655997040069, 9875.851862222216, 9887.555060022172, 9894.901050989398, 10089.646862359783], "unit": "score", "name": "yui.html", "value": 6878.716534495376}], "name": "dromaeo_css", "value": 7296.191056434136}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 107.0, 111.0, 109.0, 109.0, 100.0, 109.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [148.0, 125.0, 150.0, 170.0, 127.0, 159.0, 159.0, 125.0, 169.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 160.0, 162.0, 162.0, 160.0, 163.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 76.0, 162.0, 78.0, 75.0, 75.0, 74.0, 167.0, 75.0], "unit": "score", "name": "audio-fft", "value": 93.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 134.0, 93.0, 93.0, 93.0, 150.0, 94.0, 94.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 116.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 63.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 63.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 78.0, 78.0, 78.0, 76.0, 77.0, 76.0, 77.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 77.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 118.0, 108.0, 112.0, 112.0, 106.0, 113.0, 122.0, 108.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.9}, {"lowerIsBetter": true, "replicates": [136.0, 136.0, 137.0, 136.0, 140.0, 136.0, 135.0, 135.0, 143.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.0}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 64.0, 64.0, 65.0, 64.0, 66.0, 65.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1484.8000000000002}]} 16:20:49 INFO - Return code: 0 16:20:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:20:49 INFO - # TBPL SUCCESS # 16:20:49 INFO - Running post-action listener: _resource_record_post_action 16:20:49 INFO - Running post-run listener: _resource_record_post_run 16:20:50 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 497258496; Read time: 12; Write time: 520924 16:20:50 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 244273152; Read time: 0; Write time: 266096 16:20:50 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252985344; Read time: 12; Write time: 254828 16:20:50 INFO - Running post-run listener: _upload_blobber_files 16:20:50 INFO - Blob upload gear active. 16:20:50 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:20:50 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 16:20:50 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'] 16:20:50 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 16:20:51 INFO - (blobuploader) - INFO - Open directory for files ... 16:20:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:20:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:20:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:51 INFO - (blobuploader) - INFO - Done attempting. 16:20:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:20:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:20:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:52 INFO - (blobuploader) - INFO - Done attempting. 16:20:52 INFO - (blobuploader) - INFO - Iteration through files over. 16:20:52 INFO - Return code: 0 16:20:52 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:20:52 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:20:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d34b9249d4e278c08c572ea612b853f9afa9159b1160f05771f36126ed9bb6c1edcb8095b7a4ce29c4c45c2092be3c43d97a8fd109a180b95b025756733561ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3839282b6e0c04c275bdcd519c5ed99a928c0f908f3b92fd560bef77d3b3afd9d12b512952f44c2ae5e30d95730411eb73a5c2461fb1513af1f98f7033938ea"} 16:20:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:20:52 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:20:52 INFO - Contents: 16:20:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d34b9249d4e278c08c572ea612b853f9afa9159b1160f05771f36126ed9bb6c1edcb8095b7a4ce29c4c45c2092be3c43d97a8fd109a180b95b025756733561ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3839282b6e0c04c275bdcd519c5ed99a928c0f908f3b92fd560bef77d3b3afd9d12b512952f44c2ae5e30d95730411eb73a5c2461fb1513af1f98f7033938ea"} 16:20:52 INFO - Running post-run listener: copy_logs_to_upload_dir 16:20:52 INFO - Copying logs to upload dir... 16:20:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:20:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.395085 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-03-14 16:20:52.723074) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 16:20:52.726759) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d34b9249d4e278c08c572ea612b853f9afa9159b1160f05771f36126ed9bb6c1edcb8095b7a4ce29c4c45c2092be3c43d97a8fd109a180b95b025756733561ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3839282b6e0c04c275bdcd519c5ed99a928c0f908f3b92fd560bef77d3b3afd9d12b512952f44c2ae5e30d95730411eb73a5c2461fb1513af1f98f7033938ea"} build_url:https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011486 build_url: 'https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d34b9249d4e278c08c572ea612b853f9afa9159b1160f05771f36126ed9bb6c1edcb8095b7a4ce29c4c45c2092be3c43d97a8fd109a180b95b025756733561ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3839282b6e0c04c275bdcd519c5ed99a928c0f908f3b92fd560bef77d3b3afd9d12b512952f44c2ae5e30d95730411eb73a5c2461fb1513af1f98f7033938ea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 16:20:52.751998) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:20:52.752424) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1457994303.813816-1829163468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:20:52.836364) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 16:20:52.836822) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 16:20:52.837164) ========= ========= Total master_lag: 0.44 =========