builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1457996405.31 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.313242) ========= 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.313931) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.314848) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006367 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.370692) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.371065) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.435614) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.435873) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.525375) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.525655) ========= 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.526007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.530330) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667 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% 98.2M=0s 2016-03-14 16:00:05 (98.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090405 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.674702) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.675097) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014759 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.740952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:05.741335) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-14 16:00:05,956 truncating revision to first 12 chars 2016-03-14 16:00:05,956 Setting DEBUG logging. 2016-03-14 16:00:05,956 attempt 1/10 2016-03-14 16:00:05,956 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,218 unpacking tar archive at: mozilla-aurora-34a219cbd67d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.557166 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:06.317554) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:06.317956) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 34a219cbd67d2bf0c555321ef8308a6aefcef23d program finished with exit code 0 elapsedTime=0.004849 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.376914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:06.377239) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 16:00:06.399316) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-14 16:00:06.399616) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667 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-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16: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-e10s', 16:00:06 INFO - 'system_bits': '32', 16:00:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:00:06 INFO - 'title': 'talos-linux64-ix-064', 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-e10s", 16:00:07 INFO - "repository": "", 16:00:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 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": 130, 16:00:07 INFO - "slavename": "talos-linux64-ix-064", 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:12 INFO - Downloaded 1448 bytes. 16:00:12 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:00:12 INFO - Using the following test package requirements: 16:00:12 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:00:12 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:12 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:00:12 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:12 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:00:12 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:12 INFO - u'jsshell-linux-x86_64.zip'], 16:00:12 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:12 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:00:12 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:00:12 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:12 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:00:12 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:12 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:00:12 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:12 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:00:12 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:00:12 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:00:12 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:00:12 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:12 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:12 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:12 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:12 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:12 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:17 INFO - Downloaded 23306101 bytes. 16:00:17 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:17 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:19 INFO - Return code: 0 16:00:19 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:19 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:19 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:19 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:19 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:19 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:19 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:20 INFO - Downloaded 23306101 bytes. 16:00:20 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:20 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:22 INFO - Return code: 0 16:00:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Downloaded 10845161 bytes. 16:00:22 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:22 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:23 INFO - Return code: 0 16:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:23 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:23 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:23 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:23 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:23 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:25 INFO - Downloaded 60436500 bytes. 16:00:25 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:25 INFO - mkdir: /builds/slave/test-pgo/properties 16:00:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:00:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:00:25 INFO - Contents: 16:00:25 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:26 INFO - Running post-action listener: _resource_record_post_action 16:00:26 INFO - Running post-action listener: set_extra_try_arguments 16:00:26 INFO - ##### 16:00:26 INFO - ##### Running populate-webroot step. 16:00:26 INFO - ##### 16:00:26 INFO - Running pre-action listener: _resource_record_pre_action 16:00:26 INFO - Running main action method: populate_webroot 16:00:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:00:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:00:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:00:26 INFO - '--tppagecycles', 16:00:26 INFO - '7'], 16:00:26 INFO - 'tests': ['tsvgm']}}, 16:00:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:00:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:00:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:00:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:00:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:00:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:00:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:00:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:26 INFO - 'talos_options': ['--e10s'], 16:00:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:00:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:26 INFO - 'tests': ['damp', 'tps']}, 16:00:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:26 INFO - 'talos_options': ['--e10s'], 16:00:26 INFO - 'tests': ['damp', 'tps']}, 16:00:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:00:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:00:26 INFO - 'other': {'tests': ['a11yr', 16:00:26 INFO - 'ts_paint', 16:00:26 INFO - 'tpaint', 16:00:26 INFO - 'sessionrestore', 16:00:26 INFO - 'sessionrestore_no_auto_restore', 16:00:26 INFO - 'tabpaint']}, 16:00:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:00:26 INFO - 'tests': ['a11yr', 16:00:26 INFO - 'ts_paint', 16:00:26 INFO - 'tpaint', 16:00:26 INFO - 'sessionrestore', 16:00:26 INFO - 'sessionrestore_no_auto_restore', 16:00:26 INFO - 'tabpaint']}, 16:00:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:00:26 INFO - 'tests': ['a11yr', 16:00:26 INFO - 'ts_paint', 16:00:26 INFO - 'tpaint', 16:00:26 INFO - 'sessionrestore', 16:00:26 INFO - 'sessionrestore_no_auto_restore', 16:00:26 INFO - 'tabpaint']}, 16:00:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:00:26 INFO - 'tests': ['a11yr', 16:00:26 INFO - 'ts_paint', 16:00:26 INFO - 'tpaint', 16:00:26 INFO - 'sessionrestore', 16:00:26 INFO - 'sessionrestore_no_auto_restore', 16:00:26 INFO - 'tabpaint']}, 16:00:26 INFO - 'other_l64': {'tests': ['a11yr', 16:00:26 INFO - 'ts_paint', 16:00:26 INFO - 'tpaint', 16:00:26 INFO - 'sessionrestore', 16:00:26 INFO - 'sessionrestore_no_auto_restore', 16:00:26 INFO - 'tabpaint']}, 16:00:26 INFO - 'other_nol64': {'tests': ['a11yr', 16:00:26 INFO - 'ts_paint', 16:00:26 INFO - 'tpaint', 16:00:26 INFO - 'sessionrestore', 16:00:26 INFO - 'sessionrestore_no_auto_restore', 16:00:26 INFO - 'tabpaint']}, 16:00:26 INFO - 'svgr': {'tests': ['tsvgx', 16:00:26 INFO - 'tsvgr_opacity', 16:00:26 INFO - 'tart', 16:00:26 INFO - 'tscrollx', 16:00:26 INFO - 'cart']}, 16:00:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:00:26 INFO - 'tests': ['tsvgx', 16:00:26 INFO - 'tsvgr_opacity', 16:00:26 INFO - 'tart', 16:00:26 INFO - 'tscrollx', 16:00:26 INFO - 'cart']}, 16:00:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:26 INFO - 'tests': ['tp5o']}, 16:00:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:26 INFO - 'talos_options': ['--e10s'], 16:00:26 INFO - 'tests': ['tp5o']}, 16:00:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:26 INFO - 'talos_options': ['--xperf_path', 16:00:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:00:26 INFO - 'tests': ['tp5n']}, 16:00:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:26 INFO - 'talos_options': ['--e10s', 16:00:26 INFO - '--xperf_path', 16:00:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:00:26 INFO - 'tests': ['tp5n']}}, 16:00:26 INFO - 'talos.zip': {'path': '', 16:00:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:00:26 INFO - Running post-action listener: _resource_record_post_action 16:00:26 INFO - ##### 16:00:26 INFO - ##### Running create-virtualenv step. 16:00:26 INFO - ##### 16:00:26 INFO - Running pre-action listener: _resource_record_pre_action 16:00:26 INFO - Running main action method: create_virtualenv 16:00:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:00:26 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:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:00:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:00:26 INFO - Using real prefix '/usr' 16:00:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:00:27 INFO - Installing distribute.............................................................................................................................................................................................done. 16:00:29 INFO - Installing pip.................done. 16:00:29 INFO - Return code: 0 16:00:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:29 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 0x7febb7c6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16796d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708920>, '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 0x1709820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1709cb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', '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:29 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:29 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:29 INFO - Using env: {'DISPLAY': ':0', 16:00:29 INFO - 'HOME': '/home/cltbld', 16:00:29 INFO - 'LANG': 'en_US.UTF-8', 16:00:29 INFO - 'LANGUAGE': 'en_US:en', 16:00:29 INFO - 'LOGNAME': 'cltbld', 16:00:29 INFO - 'MAIL': '/var/mail/cltbld', 16:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:29 INFO - 'MOZ_NO_REMOTE': '1', 16:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:29 INFO - 'NO_EM_RESTART': '1', 16:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:29 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:29 INFO - 'SHELL': '/bin/bash', 16:00:29 INFO - 'SHLVL': '1', 16:00:29 INFO - 'TERM': 'linux', 16:00:29 INFO - 'TMOUT': '86400', 16:00:29 INFO - 'USER': 'cltbld', 16:00:29 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', 16:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:29 INFO - '_': '/tools/buildbot/bin/python'} 16:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:29 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:29 INFO - Cleaning up... 16:00:29 INFO - Return code: 0 16:00:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:29 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 0x7febb7c6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16796d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708920>, '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 0x1709820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1709cb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', '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:29 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:29 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:29 INFO - Using env: {'DISPLAY': ':0', 16:00:29 INFO - 'HOME': '/home/cltbld', 16:00:29 INFO - 'LANG': 'en_US.UTF-8', 16:00:29 INFO - 'LANGUAGE': 'en_US:en', 16:00:29 INFO - 'LOGNAME': 'cltbld', 16:00:29 INFO - 'MAIL': '/var/mail/cltbld', 16:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:29 INFO - 'MOZ_NO_REMOTE': '1', 16:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:29 INFO - 'NO_EM_RESTART': '1', 16:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:29 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:29 INFO - 'SHELL': '/bin/bash', 16:00:29 INFO - 'SHLVL': '1', 16:00:29 INFO - 'TERM': 'linux', 16:00:29 INFO - 'TMOUT': '86400', 16:00:29 INFO - 'USER': 'cltbld', 16:00:29 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', 16:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:29 INFO - '_': '/tools/buildbot/bin/python'} 16:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:29 INFO - Downloading/unpacking psutil>=0.7.1 16:00:29 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:29 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:29 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:29 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:29 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:29 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:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:00:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:00:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:00:31 INFO - Installing collected packages: psutil 16:00:31 INFO - Running setup.py install for psutil 16:00:31 INFO - building 'psutil._psutil_linux' extension 16:00:31 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:31 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:31 INFO - building 'psutil._psutil_posix' extension 16:00:31 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:31 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:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:00:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:00:31 INFO - Successfully installed psutil 16:00:31 INFO - Cleaning up... 16:00:32 INFO - Return code: 0 16:00:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:32 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 0x7febb7c6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16796d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708920>, '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 0x1709820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1709cb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', '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:32 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:32 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:32 INFO - Using env: {'DISPLAY': ':0', 16:00:32 INFO - 'HOME': '/home/cltbld', 16:00:32 INFO - 'LANG': 'en_US.UTF-8', 16:00:32 INFO - 'LANGUAGE': 'en_US:en', 16:00:32 INFO - 'LOGNAME': 'cltbld', 16:00:32 INFO - 'MAIL': '/var/mail/cltbld', 16:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:32 INFO - 'MOZ_NO_REMOTE': '1', 16:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:32 INFO - 'NO_EM_RESTART': '1', 16:00:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:32 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:32 INFO - 'SHELL': '/bin/bash', 16:00:32 INFO - 'SHLVL': '1', 16:00:32 INFO - 'TERM': 'linux', 16:00:32 INFO - 'TMOUT': '86400', 16:00:32 INFO - 'USER': 'cltbld', 16:00:32 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', 16:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:32 INFO - '_': '/tools/buildbot/bin/python'} 16:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:00:32 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:32 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:32 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:32 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:32 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:32 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:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:00:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:00:34 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:34 INFO - Installing collected packages: mozsystemmonitor 16:00:34 INFO - Running setup.py install for mozsystemmonitor 16:00:34 INFO - Successfully installed mozsystemmonitor 16:00:34 INFO - Cleaning up... 16:00:34 INFO - Return code: 0 16:00:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7febb7c6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16796d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708920>, '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 0x1709820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1709cb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', '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:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:00:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:00:34 INFO - Using env: {'DISPLAY': ':0', 16:00:34 INFO - 'HOME': '/home/cltbld', 16:00:34 INFO - 'LANG': 'en_US.UTF-8', 16:00:34 INFO - 'LANGUAGE': 'en_US:en', 16:00:34 INFO - 'LOGNAME': 'cltbld', 16:00:34 INFO - 'MAIL': '/var/mail/cltbld', 16:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:34 INFO - 'MOZ_NO_REMOTE': '1', 16:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:34 INFO - 'NO_EM_RESTART': '1', 16:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:34 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:34 INFO - 'SHELL': '/bin/bash', 16:00:34 INFO - 'SHLVL': '1', 16:00:34 INFO - 'TERM': 'linux', 16:00:34 INFO - 'TMOUT': '86400', 16:00:34 INFO - 'USER': 'cltbld', 16:00:34 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', 16:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:34 INFO - '_': '/tools/buildbot/bin/python'} 16:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:34 INFO - Downloading/unpacking blobuploader==1.2.4 16:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:36 INFO - Downloading blobuploader-1.2.4.tar.gz 16:00:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:00:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:00:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:37 INFO - Downloading docopt-0.6.1.tar.gz 16:00:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:00:37 INFO - Installing collected packages: blobuploader, requests, docopt 16:00:37 INFO - Running setup.py install for blobuploader 16:00:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:00:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:00:37 INFO - Running setup.py install for requests 16:00:37 INFO - Running setup.py install for docopt 16:00:37 INFO - Successfully installed blobuploader requests docopt 16:00:37 INFO - Cleaning up... 16:00:37 INFO - Return code: 0 16:00:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:37 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 0x7febb7c6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16796d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708920>, '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 0x1709820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1709cb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 16:00:37 INFO - 'HOME': '/home/cltbld', 16:00:37 INFO - 'LANG': 'en_US.UTF-8', 16:00:37 INFO - 'LANGUAGE': 'en_US:en', 16:00:37 INFO - 'LOGNAME': 'cltbld', 16:00:37 INFO - 'MAIL': '/var/mail/cltbld', 16:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:37 INFO - 'MOZ_NO_REMOTE': '1', 16:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:37 INFO - 'NO_EM_RESTART': '1', 16:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:37 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:37 INFO - 'SHELL': '/bin/bash', 16:00:37 INFO - 'SHLVL': '1', 16:00:37 INFO - 'TERM': 'linux', 16:00:37 INFO - 'TMOUT': '86400', 16:00:37 INFO - 'USER': 'cltbld', 16:00:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', 16:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:37 INFO - '_': '/tools/buildbot/bin/python'} 16:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:37 INFO - Running setup.py (path:/tmp/pip-PomKNo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:38 INFO - Running setup.py (path:/tmp/pip-Hnoc59-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:38 INFO - Running setup.py (path:/tmp/pip-yN1D0W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:38 INFO - Running setup.py (path:/tmp/pip-IdVbbB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:38 INFO - Running setup.py (path:/tmp/pip-J8MBRg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:38 INFO - Running setup.py (path:/tmp/pip-3n3ZQP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:38 INFO - Running setup.py (path:/tmp/pip-juDVzM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:38 INFO - Running setup.py (path:/tmp/pip-aiocrU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:38 INFO - Running setup.py (path:/tmp/pip-l25fFD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:38 INFO - Running setup.py (path:/tmp/pip-XGpxNU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:38 INFO - Running setup.py (path:/tmp/pip-zpta6_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:38 INFO - Running setup.py (path:/tmp/pip-BL0Fhf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:38 INFO - Running setup.py (path:/tmp/pip-Ti_3qZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:38 INFO - Running setup.py (path:/tmp/pip-j5nCvX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:38 INFO - Running setup.py (path:/tmp/pip-Dmjoa1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:39 INFO - Running setup.py (path:/tmp/pip-hH5vVX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:39 INFO - Running setup.py (path:/tmp/pip-toBbzK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:00:39 INFO - Running setup.py install for manifestparser 16:00:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:00:39 INFO - Running setup.py install for mozcrash 16:00:39 INFO - Running setup.py install for mozdebug 16:00:39 INFO - Running setup.py install for mozdevice 16:00:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:00:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:00:39 INFO - Running setup.py install for mozfile 16:00:39 INFO - Running setup.py install for mozhttpd 16:00:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:00:39 INFO - Running setup.py install for mozinfo 16:00:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:00:39 INFO - Running setup.py install for mozInstall 16:00:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:00:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:00:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:00:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:00:39 INFO - Running setup.py install for mozleak 16:00:40 INFO - Running setup.py install for mozlog 16:00:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:00:40 INFO - Running setup.py install for moznetwork 16:00:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:00:40 INFO - Running setup.py install for mozprocess 16:00:40 INFO - Running setup.py install for mozprofile 16:00:40 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:00:40 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:00:40 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:00:40 INFO - Running setup.py install for mozrunner 16:00:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:00:40 INFO - Running setup.py install for mozscreenshot 16:00:40 INFO - Running setup.py install for moztest 16:00:40 INFO - Running setup.py install for mozversion 16:00:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:00:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:00:40 INFO - Cleaning up... 16:00:40 INFO - Return code: 0 16:00:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:40 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 0x7febb7c6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16796d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708920>, '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 0x1709820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1709cb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', '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:40 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:40 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:40 INFO - Using env: {'DISPLAY': ':0', 16:00:40 INFO - 'HOME': '/home/cltbld', 16:00:40 INFO - 'LANG': 'en_US.UTF-8', 16:00:40 INFO - 'LANGUAGE': 'en_US:en', 16:00:40 INFO - 'LOGNAME': 'cltbld', 16:00:40 INFO - 'MAIL': '/var/mail/cltbld', 16:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:40 INFO - 'MOZ_NO_REMOTE': '1', 16:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:40 INFO - 'NO_EM_RESTART': '1', 16:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:40 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:40 INFO - 'SHELL': '/bin/bash', 16:00:40 INFO - 'SHLVL': '1', 16:00:40 INFO - 'TERM': 'linux', 16:00:40 INFO - 'TMOUT': '86400', 16:00:40 INFO - 'USER': 'cltbld', 16:00:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', 16:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:40 INFO - '_': '/tools/buildbot/bin/python'} 16:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:41 INFO - Running setup.py (path:/tmp/pip-SxdNw2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:41 INFO - Running setup.py (path:/tmp/pip-jCAzAf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:41 INFO - Running setup.py (path:/tmp/pip-x1GZEH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:41 INFO - Running setup.py (path:/tmp/pip-zQS8vL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:41 INFO - Running setup.py (path:/tmp/pip-sC7A2g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:41 INFO - Running setup.py (path:/tmp/pip-OhMQMy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:41 INFO - Running setup.py (path:/tmp/pip-NBSLJt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:41 INFO - Running setup.py (path:/tmp/pip-5OMqqa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:41 INFO - Running setup.py (path:/tmp/pip-nfmh4R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:41 INFO - Running setup.py (path:/tmp/pip-a6kats-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:41 INFO - Running setup.py (path:/tmp/pip-7eWgnd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:41 INFO - Running setup.py (path:/tmp/pip-vBV6CQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:42 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:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:42 INFO - Running setup.py (path:/tmp/pip-JbCP2L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:42 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:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:42 INFO - Running setup.py (path:/tmp/pip-7cbO_s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:42 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:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:42 INFO - Running setup.py (path:/tmp/pip-6FJc7J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:42 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:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:42 INFO - Running setup.py (path:/tmp/pip-UHhGhZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:42 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:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:42 INFO - Running setup.py (path:/tmp/pip-n_QC5Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:42 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:42 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:42 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:42 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:42 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:42 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:42 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: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 blessings-1.6.tar.gz 16:00:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:00:44 INFO - Installing collected packages: blessings 16:00:44 INFO - Running setup.py install for blessings 16:00:44 INFO - Successfully installed blessings 16:00:44 INFO - Cleaning up... 16:00:44 INFO - Return code: 0 16:00:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:00:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:00:44 INFO - Reading from file tmpfile_stdout 16:00:44 INFO - Current package versions: 16:00:44 INFO - argparse == 1.2.1 16:00:44 INFO - blessings == 1.6 16:00:44 INFO - blobuploader == 1.2.4 16:00:44 INFO - docopt == 0.6.1 16:00:44 INFO - manifestparser == 1.1 16:00:44 INFO - mozInstall == 1.12 16:00:44 INFO - mozcrash == 0.17 16:00:44 INFO - mozdebug == 0.1 16:00:44 INFO - mozdevice == 0.48 16:00:44 INFO - mozfile == 1.2 16:00:44 INFO - mozhttpd == 0.7 16:00:44 INFO - mozinfo == 0.9 16:00:44 INFO - mozleak == 0.1 16:00:44 INFO - mozlog == 3.1 16:00:44 INFO - moznetwork == 0.27 16:00:44 INFO - mozprocess == 0.22 16:00:44 INFO - mozprofile == 0.28 16:00:44 INFO - mozrunner == 6.11 16:00:44 INFO - mozscreenshot == 0.1 16:00:44 INFO - mozsystemmonitor == 0.0 16:00:44 INFO - moztest == 0.7 16:00:44 INFO - mozversion == 1.4 16:00:44 INFO - psutil == 3.1.1 16:00:44 INFO - requests == 1.2.3 16:00:44 INFO - wsgiref == 0.1.2 16:00:44 INFO - Installing None 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', '-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 0x7febb7c6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16796d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708920>, '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 0x1709820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1709cb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', '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', '-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:44 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: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': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', 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 - 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:44 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:44 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:44 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:44 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:44 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:44 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:44 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:44 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:44 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:44 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:44 INFO - Cleaning up... 16:00:44 INFO - Return code: 0 16:00:44 INFO - Installing jsonschema 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb7c6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16796d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708920>, '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 0x1709820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1709cb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', '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', 'jsonschema'] 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 jsonschema 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': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', 16:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:44 INFO - '_': '/tools/buildbot/bin/python'} 16:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:45 INFO - Downloading/unpacking jsonschema 16:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:00:46 INFO - Downloading/unpacking functools32 (from jsonschema) 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 functools32-3.2.3-2.tar.gz 16:00:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:00:47 INFO - warning: no files found matching '*.txt' 16:00:47 INFO - no previously-included directories found matching 'build' 16:00:47 INFO - no previously-included directories found matching 'dist' 16:00:47 INFO - no previously-included directories found matching '.git*' 16:00:47 INFO - Installing collected packages: jsonschema, functools32 16:00:47 INFO - Running setup.py install for functools32 16:00:47 INFO - warning: no files found matching '*.txt' 16:00:47 INFO - no previously-included directories found matching 'build' 16:00:47 INFO - no previously-included directories found matching 'dist' 16:00:47 INFO - no previously-included directories found matching '.git*' 16:00:47 INFO - Successfully installed jsonschema functools32 16:00:47 INFO - Cleaning up... 16:00:47 INFO - Return code: 0 16:00:47 INFO - Installing flake8 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', '--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 0x7febb7c6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16796d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1708920>, '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 0x1709820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1709cb0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', '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', '--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:47 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: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': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', 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 - Downloading/unpacking flake8 16:00:47 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:47 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 - 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:47 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:47 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:47 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:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:00:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:00:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:00:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:00:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:00:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:00:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:00:50 INFO - no previously-included directories found matching 'docs/_build' 16:00:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:00:50 INFO - Running setup.py install for pep8 16:00:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:00:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:00:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:00:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:00:50 INFO - no previously-included directories found matching 'docs/_build' 16:00:50 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:00:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:00:50 INFO - Cleaning up... 16:00:50 INFO - Return code: 0 16:00:50 INFO - Running post-action listener: _resource_record_post_action 16:00:50 INFO - Running post-action listener: _start_resource_monitoring 16:00:50 INFO - Starting resource monitoring. 16:00:50 INFO - ##### 16:00:50 INFO - ##### Running install step. 16:00:50 INFO - ##### 16:00:50 INFO - Running pre-action listener: _resource_record_pre_action 16:00:50 INFO - Running main action method: install 16:00:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:00:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:00:50 INFO - Reading from file tmpfile_stdout 16:00:50 INFO - Detecting whether we're running mozinstall >=1.0... 16:00:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:00:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:00:50 INFO - Reading from file tmpfile_stdout 16:00:50 INFO - Output received: 16:00:50 INFO - Usage: mozinstall [options] installer 16:00:50 INFO - Options: 16:00:50 INFO - -h, --help show this help message and exit 16:00:50 INFO - -d DEST, --destination=DEST 16:00:50 INFO - Directory to install application into. [default: 16:00:50 INFO - "/builds/slave/test-pgo"] 16:00:50 INFO - --app=APP Application being installed. [default: firefox] 16:00:50 INFO - mkdir: /builds/slave/test-pgo/build/application 16:00:50 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:00:50 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:05 INFO - Reading from file tmpfile_stdout 16:01:05 INFO - Output received: 16:01:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:01:05 INFO - Running post-action listener: _resource_record_post_action 16:01:05 INFO - ##### 16:01:05 INFO - ##### Running run-tests step. 16:01:05 INFO - ##### 16:01:05 INFO - Running pre-action listener: _resource_record_pre_action 16:01:05 INFO - Running main action method: run_tests 16:01:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:01:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:01:05 INFO - Python 2.7.3 16:01:05 INFO - Return code: 0 16:01:05 INFO - grabbing minidump binary from tooltool 16:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:05 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 0x1708920>, '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 0x1709820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1709cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:01:05 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:05 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:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:01:05 INFO - Return code: 0 16:01:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:01:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:01:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:01:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:01:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:01:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:01:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:01:06 INFO - Return code: 0 16:01:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 16:01:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:01:06 INFO - Using env: {'DISPLAY': ':0', 16:01:06 INFO - 'HOME': '/home/cltbld', 16:01:06 INFO - 'LANG': 'en_US.UTF-8', 16:01:06 INFO - 'LANGUAGE': 'en_US:en', 16:01:06 INFO - 'LOGNAME': 'cltbld', 16:01:06 INFO - 'MAIL': '/var/mail/cltbld', 16:01:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:01:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:06 INFO - 'MOZ_NO_REMOTE': '1', 16:01:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:06 INFO - 'NO_EM_RESTART': '1', 16:01:06 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:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:01:06 INFO - 'PWD': '/builds/slave/test-pgo', 16:01:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:01:06 INFO - 'SHELL': '/bin/bash', 16:01:06 INFO - 'SHLVL': '1', 16:01:06 INFO - 'TERM': 'linux', 16:01:06 INFO - 'TMOUT': '86400', 16:01:06 INFO - 'USER': 'cltbld', 16:01:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667', 16:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:06 INFO - '_': '/tools/buildbot/bin/python'} 16:01:06 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXfG9LHiS2eLAXp_-Z6JlQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:01:07 INFO - mozversion application_buildid: 20160314004022 16:01:07 INFO - mozversion application_changeset: 34a219cbd67d2bf0c555321ef8308a6aefcef23d 16:01:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:01:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:01:07 INFO - mozversion application_name: Firefox 16:01:07 INFO - mozversion application_remotingname: firefox-dev 16:01:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:01:07 INFO - mozversion application_vendor: Mozilla 16:01:07 INFO - mozversion application_version: 47.0a2 16:01:07 INFO - mozversion platform_buildid: 20160314004022 16:01:07 INFO - mozversion platform_changeset: 34a219cbd67d2bf0c555321ef8308a6aefcef23d 16:01:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:01:07 INFO - mozversion platform_version: 47.0a2 16:01:07 INFO - using testdate: 1457996467 16:01:07 INFO - actual date: 1457996467 16:01:07 INFO - starting webserver on 'localhost:56173' 16:01:07 INFO - SUITE-START | Running 2 tests 16:01:07 INFO - TEST-START | dromaeo_css 16:01:07 INFO - operating with platform_type : linux_ 16:01:07 INFO - Initialising browser for dromaeo_css test... 16:01:07 INFO - TEST-INFO | started process 31756 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsDvHxq/profile http://localhost:56173/getInfo.html) 16:01:11 INFO - PROCESS | 31756 | 16:01:11 INFO - PROCESS | 31756 | (process:31830): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:01:11 INFO - PROCESS | 31756 | __metrics Screen width/height:1600/1200 16:01:11 INFO - PROCESS | 31756 | colorDepth:24 16:01:11 INFO - PROCESS | 31756 | Browser inner width/height: 1024/697 16:01:11 INFO - PROCESS | 31756 | __metrics 16:01:12 ERROR - PROCESS | 31756 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:01:13 INFO - TEST-INFO | 31756: exit 0 16:01:13 INFO - Browser initialized. 16:01:13 INFO - Running cycle 1/1 for dromaeo_css test... 16:01:13 INFO - TEST-INFO | started process 31881 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsDvHxq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:01:15 INFO - PROCESS | 31881 | 16:01:15 INFO - PROCESS | 31881 | (process:31951): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:01:25 INFO - PROCESS | 31881 | RSS: Main: 154562560 16:01:25 INFO - PROCESS | 31881 | 16:02:14 INFO - PROCESS | 31881 | 1457996534881 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:22 INFO - PROCESS | 31881 | Cycle 1(1): loaded http://localhost:56173/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56173/tests/dromaeo/cssquery-ext.html) 16:04:23 INFO - PROCESS | 31881 | RSS: Main: 157888512 16:04:23 INFO - PROCESS | 31881 | 16:07:25 INFO - PROCESS | 31881 | Cycle 1(1): loaded http://localhost:56173/tests/dromaeo/cssquery-ext.html (next: http://localhost:56173/tests/dromaeo/cssquery-jquery.html) 16:07:26 INFO - PROCESS | 31881 | RSS: Main: 156954624 16:07:26 INFO - PROCESS | 31881 | 16:10:28 INFO - PROCESS | 31881 | Cycle 1(1): loaded http://localhost:56173/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56173/tests/dromaeo/cssquery-mootools.html) 16:10:28 INFO - PROCESS | 31881 | RSS: Main: 155803648 16:10:28 INFO - PROCESS | 31881 | 16:13:30 INFO - PROCESS | 31881 | Cycle 1(1): loaded http://localhost:56173/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56173/tests/dromaeo/cssquery-prototype.html) 16:13:30 INFO - PROCESS | 31881 | RSS: Main: 155484160 16:13:30 INFO - PROCESS | 31881 | 16:16:33 INFO - PROCESS | 31881 | Cycle 1(1): loaded http://localhost:56173/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56173/tests/dromaeo/cssquery-yui.html) 16:16:33 INFO - PROCESS | 31881 | RSS: Main: 155631616 16:16:33 INFO - PROCESS | 31881 | 16:19:36 INFO - PROCESS | 31881 | Cycle 1(1): loaded http://localhost:56173/tests/dromaeo/cssquery-yui.html (next: http://localhost:56173/tests/dromaeo/cssquery-dojo.html) 16:19:36 INFO - PROCESS | 31881 | RSS: Main: 159522816 16:19:36 INFO - PROCESS | 31881 | 16:19:36 INFO - PROCESS | 31881 | __start_tp_report 16:19:36 INFO - PROCESS | 31881 | _x_x_mozilla_page_load 16:19:36 INFO - PROCESS | 31881 | _x_x_mozilla_page_load_details 16:19:36 INFO - PROCESS | 31881 | |i|pagename|runs| 16:19:36 INFO - PROCESS | 31881 | |0;dojo.html;3263.8531266093023;3369.03982365026;3374.8312584370774;3412.8293585320744;3423.760336776425;5391.838244852655;5431.348238211411;5437.238786569878;5438.320209973754;5475.425080366559;5449.836504904849;5479.4520547945185;5482.753276102575;5483.643563168392;5518.448155184479;4926.458089610149;4999.650024498286;5064.11378008847;5065.341505604285;5078.1874900016;4902.828401005965;5032.949670503303;5046.798128074873;5058.570021548173;5068.72122033288;5050.671706339094;5070.08738427083;5116.820911268106;5191.935653191105;5192.221166824987;5082.390113186423;5102.336696229485;5110.463401342842;5130.4613015633195;5139.74301284938;4886.389201349832;4917.778699958475;5080.263361812516;5083;5122.129238029544;5311.495407936279;5332.173513105475;5357.874846282285;5366.6779993200535;5370.087085195526;5929.822105336847;5933.703314834284;5980.700964951735;5988.520918326523;6013.218281623404;5908.172855800191;5956.344802071769;5962.2249107615735;5969.70151492428;5986.521078313768;5580.91628625571;5612.045952188138;5629;5630.521405680481;5639.3232812062;5988.341282458926;6126.846828829226;6133.264008318941;6133.723982420802;6136.6624835633575;5886.793962211302;5916.319623243296;5918.4377484139795;5930.614510056833;5946.405359464019;5954.821355359346;5963.344032156459;5966.373530779206;5973.163757074013;5977.491913187341;5789.739461724233;5905.675187864623;5911.793087241926;5917.6745279010065;5918.319393269829;5945.4351836576325;5969.164316995624;5990.071538911476;6010.068439391901;6019.036954087325;4525.117602067631;4529.071540334289;4547.704399214041;4555.1117532080925;4584.610308123847;4033.092554175346;4051.8784436466954;4085.4688890444054;4093.6520395766097;4136.028033412145;5519.2824932758485;5612.859678507988;5667.829965101054;5674.148877668383;5678.0915053591225;5970.731317090741;6011.12838638395;6012.098185272157;6016.157737916695;6046.486048685823;5573.777048918079;5688;5689.203511508392;5692;5720.685362305113;5116.258142569381;5124.436312005676;5133.743312834344;5149.716765577854;5168.7415629218385;6102.633841969496;6125.418085281891;6131.877362452726;6138.7237574309265;6148.815535533941;5901.439363260483;5913.822585322448;5966.403359663999;5975.940240597538;5977.163197152315;6147.600405973598;6160.815175544741;6193.628382296896;6201.069839524108;6216.409441103088;5938.673372964528;5940.405959404198;5943.435373639497;5943.673097979653;5969;5899.705014749159;5933.851653708692;6035.969820150871;6074.362191969956;6091.0558863376245;5812.883742325214;5815.9709201453725;5817.127430885401;5849.327327357239;5851.561132914963;5831.650100993954;5842.2405087338375;5852.297724273115;5857.355690874086;5868.413158684098;5551.944480555143;5782.508486778503;5815.738291776795;5859.121131830259;5879.323877754113;5930.940690593211;5936.317323507679;5944.910826337695;5948.940510595012;5963.165156878127;5670.121131224667;5800.042992906123;5815.9709201453725;5819.243498345188;5832.9708351457975 16:19:36 INFO - PROCESS | 31881 | |1;ext.html;516.5841497594437;540.3488796000819;545.7189547383099;560.0143747005269;566.0038332534739;39452.210955780865;39684.60315396845;39713.20573588526;39782.40326395099;39793.204135917265;41594.58405415945;41882.58117418832;42153;42173.156536869246;42192;8797.868031979526;8953.820923581525;8972.730818075468;8982.730518084436;8996.280297576179;8859.424137431079;8899.421537600068;8915.28677705782;8964.417312874642;9000.8649870252;9202.953985230064;9221.077892210793;9221.308401869854;9265.583048762788;9303.488308143049;9044.819103617923;9193.172614464731;9211.493367864765;9221.446713197163;9235.261179105722;9088.727338179866;9132.3150763693;9199.310051746146;9201.861972070425;9202.585883635185;42990.35514467254;43311.13377732459;43373;43421.34867976983;43436.3484547732;3128;3568.678818906285;3701.1214916037648;3775.9622403775884;3776.037110536823;29524.704752952624;29575.260618484495;29840.850795745882;29986.400271994655;30074.097777066723;3614.7831130132276;3644.0889777555612;3685.7788532688123;3703.4629978652943;3760.9435858462143;198920;199120;200185;200558;202561;47315;62766.68616656979;63267.36732632707;63347.683261584316;63379;44945;45309.09381812345;45341;45521.317180242324;45554.77222613866;15903.920480397524;16260.837391626168;16270.83729162717;16306.103164326076;16411.097389643444;13157.079004469595;13249.271290078945;13262;13279.402426890812;13279.66800829987;15303.61740956485;15528.767068493982;16005;16052.839471605368;16058.116803575682;6003.3996600339615;6176.4441200292185;6190.350013248634;6268.843278917972;6277.560570760094;1042.9883013476915;1058.5342449322275;1060.3002018667796;1149.781541507111;1245.1284101129245;30234.84882575573;30375.24061898426;30418.54372184419;30657.69342306593;31261.687383126333;1115.0577761791274;1131.6265632341308;1154.468944285638;1169.351010189336;1188.7503624238834;15698.68602627941;15763.921180394025;15832.129232892301;15962.680746385007;15997.920010399874;319949;749805;758618;767903;768786;61444.38555614387;61706;61726.38273617296;62086.689566551875;62208.68895655583;1485.0866716969201;1497.7528707763315;1498.9550313490613;1506.5706273712158;1518.5444366689949;32039.359212816078;32671.509927351584;32679.346413072082;33846.3230735379;35734.8213258932;56020.439795601524;56696;56799.43200567942;56853.71573142108;56958.14562781479;311298;314691;316675;316779;317561;46040.30939535976;48609.51390486192;49164.75417622889;49527.75236123941;50967.74516127395;47287.76356118197;47962.28056579085;48442.5155748438;48515.85371904815;48727.5127248723;38637.22725545417;40085.19829603333;41018.58981410267;41124.38313425361;41413.58586414097;40287.1942561153;40306;41059.7947010275;41076.589234107276;41218;39784.403233950936;39982;39985.20029599334;40589.782306530855;40769.38845917373;35329.82335088308;35339;35561.64438355687;36026;36145.63854361423;27317.863410683614;27632.86183569069;27723;27815.860920696075;28093.157205283875 16:19:36 INFO - PROCESS | 31881 | |2;jquery.html;384.3945785388013;387.21395566999;390.7948327128257;398.06057703819;398.0625626649241;17193.91403042986;18966.241350346005;19447;19579.41261762146;19805.306814261505;12265;12373.752524949496;12520.81218781719;17682.93902365859;17716.29134834605;5248.134057880445;5446.509814116729;5455.645383050109;5483.150111732668;5491.697956612385;5332.200169974496;5421.647592906468;5492.972535137319;5498.945010549884;5537.1140617501205;5415.13357862742;5487.094629386146;5507.063799154133;5818.709064546756;5863.530917526609;5743.54051675865;5780.595358324919;5792.826215213571;5806.419358064202;5808.273965754281;5574.331080270353;5617.9719101404235;5621.522170615503;5659.745311460994;5758.049921762904;14329.928350358286;14488.217233542062;14505.05717128394;14547.70904581913;14628.561143165616;2212.093041852833;2311.653252012195;2317.4669825940127;2437.500312435964;2995.2961054152256;10900.50947707355;13145.671358216025;13757.10578812374;13958.720825583532;14023.64940876476;1835.4034938644993;1922.9903850480657;1968.1832039703506;2003.5391859872166;2066.111572024029;67598;67618.66190669064;68985;69972.30027699709;70110;11402.486888090056;11543.191976561728;11676.241044332091;11685;11815.409229538489;14595.197264150574;15459.304331305118;15498.845011549965;15565.610859728371;15624.218789060502;8264;8401.411901166983;8438.282745966662;8495.532745699045;8568.400211985101;7950.562719050507;7958.08482024563;7959.363250939911;8037.397195210383;8104.1085480597085;4998.4251811042195;5003.149464591028;5012.273220383097;5013.097642424325;5045.697258164522;2035.236786205173;2066.772655007948;2076.5016396064834;2080.5942841146134;2137.1665050630268;999.8056210407823;1009.9799202805073;1048.9632862849764;1056.6143357674393;1087.075985412393;16938.83061169397;16940.40708575194;17116;17466.650666986843;17732.29070837152;995.3629677006721;1005.100435110572;1017.2624846985876;1018.8675472188568;1029.4441001858913;8124.431289809775;10087.596496140219;10096.040876116756;10131.797364052678;10231.181505479544;403239;406421;408299;423800;431207;75359.62320188365;76223;77399.61300193463;79002;79656.60171699105;1000.8798944126752;1002.3634991780126;1019.6991887393089;1020.5356562763925;1023.9488025598839;15632.92183539075;15838.28727707233;15874.920625396799;15902.125383104041;15906.68186636284;26507.867460662572;33118.834405827816;35583;35613.109672258404;35756.4636530447;37764;46346.07307853892;46715;46779;47182.29226561535;8587.355948304028;8677.088905664814;8791.824163516821;8851.557422128739;8860.291176705978;12489.31308778026;13676.111052781538;13704.931475342559;13813.240271784747;13846.792298115335;11730.589429369931;11790.174687772116;11973.76052478963;12043.518259269882;12081.456334464794;11555.711107222387;11700.824487632863;11992.76014479723;12222.572209972608;12326.75346493083;12174.93912530467;12281.385930703607;12401.193922395016;12465.563705270271;12574.811377829157;8235.38234632417;8812.471251724917;9072.138146876036;9130.817383652422;9203.631854726003;10766.623168189075;11451.370174640475;11546.249493782878;11587.478563464832;11768.52925882955 16:19:36 INFO - PROCESS | 31881 | |3;mootools.html;1405.2622373254044;1427.279223991884;1658.2537857963919;1933.82595566399;1975.9407217783462;7710.7686769397005;8176.264136227738;8178.4683995540245;8297.211764882333;8308.70919517817;8347.499150051;8382.07797142314;8435.198656127674;8461.323094152469;8470.576471176448;2414.6740190074333;2427.9757202428013;2436.049940523197;2439.0731522021697;2440.1825388494876;2396.508715713275;2408.1932552594903;2424.5514579802707;2426.5510880487077;2436.500517393939;2362.7400985891622;2411.9397015074674;2413.3122060212845;2435.1598698449097;2436.196055301746;2424.103081859714;2430.8541487510806;2432.70807503099;2434.573949558829;2457.4347899982927;2414.275717284825;2416.6254230594286;2417;2422;2428.0287884846025;8582.87125693115;8614.784630384227;8699.478031318078;8709.695160669346;8746.650133994632;5119.948800511985;5280.2079688046715;5296;5297.17893726473;5305;3209.6629853865475;3240.351929614063;3275.328557645677;3302.1909632140278;3309.1396236978317;1002.448653240722;1945.8540609454349;2037.9796202037937;2098.5383215692677;2117.9682304765442;11482.885171148266;11576.652700419001;11578.884211157949;11631.418429078596;11648;4388.780560971939;4430.867073987785;4488.708233964782;4509.594136527729;4553.977230113828;9203.217726493323;9249.213816825511;9250.76873078165;9263.53682315895;9307.441553506676;5195.064888320063;5197.610179236573;5199.090159222121;5199.220116982483;5201.193814958688;4661.557152070548;4751.097291514601;4787.952120478821;4848.272759086165;4862.05189987949;3859.807009649506;3881.8253178606465;3891.124496988155;3932.8820135395413;3938.0351813805228;1155.96532104037;1156.2484385149553;1161.2451906260999;1162.7325715085578;1163.6334554615269;1495.8279797823172;1502;1503.053076561759;1522.3073501556987;1525.260248779341;8326.25063744266;8327.458715183493;8327.66689332432;8344.290735287446;8349.582520874053;479.06821232702754;481.3908615305055;489.99755001224764;493.2084005171719;503.80603467665213;6351.04734289851;6413.102165696806;6446.580972236789;6506.186726659168;6536.117624120778;10360;10699.73250668724;10720.088792452572;10800.945995269973;10826.729331766612;10440.321379110334;10470.528826202839;10498.632547860789;10647.893521064845;10673.946630266953;7857.724979625686;7872.330851877655;7963.681452741941;7970.681172753025;7999.760007199793;7883.369330453665;7929.088154862265;7936.960315198618;8038.718644847402;8105.351571874354;9215.216706580015;9321.533923303943;9396.107369799858;9445.858312125461;9450.960394356478;8910.37627366104;9145.77135571616;9333.066693330884;9789.216862651114;9861.753456163653;6787;7174.784756457315;7376.446766492427;7487.737929172453;7633.5419874807685;7950.125486196398;8044.034715834137;8047.919520804717;8051.597420129087;8069.556174410229;7214.314640109181;7335.77992660221;7459.216782237787;7514.0607424071995;7521.849563008818;7161.641917903979;7318.780436586911;7322.670479828527;7325.084364454443;7336.669849856876;7689.461737678309;7700.576468294297;7701.422393320636;7754.457187997012;7782.455228133977;6957.721691132298;6958.721651133898;7011.6494175292055;7022.1924478685605;7047.823804404931;7134.500584959003;7153.713851445884;7175.569465832067;7193.892091618525;7198.352148306678 16:19:36 INFO - PROCESS | 31881 | |4;prototype.html;375.96240375962407;378.62137862137854;381.62028781362534;385.8572328238552;391.9495751386285;6387.5209359298005;6403.551751377406;6406.487481001521;6409.166808314918;6422.807315780528;6310.589811662238;6398.232212134539;6413.038044293358;6417.614943103417;6425.13260709804;4789.80840766369;4881.633877459187;4917.877053073666;4922.384701912261;4945.5301746334135;4891.682040667363;4897.730624815634;4898.118338699032;4898.387701537308;4902.901941961159;4822.445418776833;4829.541193586604;4848.5151484851585;4850.733209673466;4869.780859861297;4849.199882019462;4851.69004368822;4857.29569212464;4929.408470983469;4931.605471562267;4323.308270676708;4325.84859529915;4327.3725309830215;4331.588499092612;4341.869743907688;5804.448577385184;6098.207233059718;6098.420650038239;6102.786402475892;6109.694515274263;5623.578231632644;5675.602707810455;5697.857553561153;5701.572382071361;5714.942850571482;6785.117934668461;6839.247682754893;6849.726010959555;6855.348741869514;6861.931380686229;4648.697834640738;4666.2067448533835;4675.94791171987;4684.718916864965;4690.788914498856;7024.789256322319;7042.647867606599;7122.715091396338;7122.9287707122785;7128.501004929657;4709.646776491777;4872.439669437989;4890.290907818347;4895.559399654048;4914.655974081851;4863.732494712754;4887.755612219375;4902.975485122623;4907.754612269444;4935.728534930541;5681.659100453986;5696.8006119785605;5714.885702285931;5718.971405142947;5730.713464326767;6831.863362732717;6882.931170688229;6887.345702158287;6911.343422374866;6918.688659010357;1723.4312676816621;1768.5409537131918;1769.3718729850975;1772;1774.8047714751367;1151.447305293447;1172.4489489939715;1187.7386974865515;1194.2655267010725;1202.9939850300693;6590.8352291193105;6602.966985165043;6610.10763546915;6611.570247933869;6618.602883826986;7094.574325540484;7099.680514376865;7102.60935648534;7104.609246491493;7112.182099058571;6401.967990160112;6530.412262896267;6562.67186640666;6568;6570.737170513222;3839.500864887603;3853.845846166178;3872.9225415491533;3876.030992251937;3886.941695874564;7238.52949558277;7311.415086793044;7323.974643549907;7328.413726901835;7390.039294891737;7337;7344.375728063174;7357.742479013209;7371.447141464411;7386.372158366492;7130.393916517154;7437.293457121565;7496;7497.212792656693;7497.587632680255;7155.8568828624175;7174.497785154989;7187.281271872771;7188.6046267455795;7192.244814294424;7030.367266945999;7041.964790176016;7072.611006394492;7083.929160708327;7093.751718689821;7315.524490908074;7425.294597013275;7434.702611895464;7447.106347238366;7478.401727861867;4880.901212478669;4928.581070609039;4934.827281045146;4936.827211047596;4955.083309587738;7133.607651579213;7166.283371663;7184.209736929038;7190.4607154464675;7192.8921066183;6964.825879353057;6965.616891071039;6974.930250697428;6978.441724662116;6979.092717946837;6828.624425656438;6878.105846239957;6913.481488888454;6957.930420695729;6969;6866.862662746817;6883.139607549057;6885.242623311532;6888.758893438706;6905.551139175937;7007.194172670208;7040.260772619006;7082.291770822876;7083.043789088613;7084.149902011792;6785.864282714417;6787.253402125861;6810.046593477016;6826.897596535957;6833.282505336868 16:19:36 INFO - PROCESS | 31881 | |5;yui.html;719.0508528742059;724.9782506524803;728.0208120078499;913.4656226107728;929.1312622697778;13886.722265554696;14027.579172624812;14096.929515352434;14108.576742697709;14109.082909610868;14041.929790351034;14042.08726432781;14105.153690778534;14111.717765644707;14120.78818817716;774.4656187230821;893.4862454088892;918.5177781664646;924.5793164110314;930.7905721212724;932.6968735161066;936.3539157981005;936.8735220745215;938.6057855700623;940.0223767282018;975.7414285214388;985.9901400986006;986.66453405842;989.0356902020544;990.9752256193581;975.1613612293422;980.5783513089368;980.843065109579;981.205223768746;985.1281615770024;722.0252658910481;723.8624661314334;728.8323685552352;729.9744508942161;730.9195988441268;14445.349959251858;14480.131192128507;14593.051451655609;14645.267736613127;14695.559133226021;13987.300634968313;14297.78553321701;14333.140011599233;14567.417303307855;14594.708105837824;11467.598634047852;11489.597864074802;11531.250468719507;11594.536218551248;12149.635510934597;3826.253880493305;3868.18768058708;3896.8636097736444;3897.610238976108;3918.804059796999;51986.480135198544;52895.999999999614;52927.47072529264;52995.73502132503;53203.46796532024;11343.092552595772;11489.368084755419;11516.539338426537;11614.187006909435;11738.295702257892;19486;19625.803741962398;19657.311994080424;19712.40862774119;19736.90131549333;7864.449488535862;7924.564148971862;7965.522068675898;8112.59437028158;8183.71357002502;4220.6412454941055;4225.233231881403;4302.225599392077;4337.262665346835;4354.847580334673;3431.0736101252523;3444.6727560881677;3444.793312401264;3453.620101788801;3462.7056700180765;631.4569470255576;634.4353525362432;635.2757856044113;636.6084857812413;662.0301258655995;561.3600495435207;588.9381614930456;671.7917445591883;693.4868197533789;707.8548897476005;8691.34814888886;8852.911470885208;8887.333449991276;8940.776480587907;9133.77165570866;529.370049640926;619.3249358199585;701.1866235167182;719.9388052015637;737.0344848248811;4141.937870931938;4174.582541745862;4200.957990420056;4213.073123912734;4239.788010599457;60545;63254;63656;63787.6810615944;63990;52749.7362513185;53651.73174134104;54014.45985540094;54453.183202251996;55047;48785.512144878805;48819.267710984364;49750.75124624354;50884.49115508798;51263.743681281354;8060.435769496079;8192.30365418946;8244.051934027664;8348.37387195975;8421.831563368576;34781.65218347885;35608.28783424265;35905.46141807823;36115.81942090273;36464;45597.54402455933;47505;47992.520074798806;48022.5197748018;48312.758436207594;11367.261128026652;11399.430028498708;11407.094949171937;11484.655460336204;11510.712232194262;12299.93850030744;12397.876021239672;12806.551770687982;12957.41691623898;13228.338583070616;11382.715432114263;11504.884951150381;12199.69500762488;12426.130170887951;12685.23888566689;12030.27818330903;12383.814242786546;12753.48986040548;12787.913027392404;13164.60506184816;10380.792384152426;11832.17174797756;12100.394980251129;12553;12592.685182870502;10396.844047339448;10755.946220268848;10852.782944341227;10943.781124377627;11222;10151.238657100599;10395;10489.895101048893;10520;10987.39569323695 16:19:36 INFO - PROCESS | 31881 | __end_tp_report 16:19:36 INFO - PROCESS | 31881 | __start_cc_report 16:19:36 INFO - PROCESS | 31881 | _x_x_mozilla_cycle_collect,321 16:19:36 INFO - PROCESS | 31881 | __end_cc_report 16:19:36 INFO - PROCESS | 31881 | __startTimestamp1457997576320__endTimestamp 16:19:36 INFO - PROCESS | 31881 | 16:19:36 INFO - PROCESS | 31881 | ------- Summary: start ------- 16:19:36 INFO - PROCESS | 31881 | Number of tests: 6 16:19:36 INFO - PROCESS | 31881 | 16:19:36 INFO - PROCESS | 31881 | [#0] dojo.html Cycles:165 Average:5540.43 Median:5815.97 stddev:620.30 (10.7%) stddev-sans-first:595.93 16:19:36 INFO - PROCESS | 31881 | Values: 3263.9 3369.0 3374.8 3412.8 3423.8 5391.8 5431.3 5437.2 5438.3 5475.4 5449.8 5479.5 5482.8 5483.6 5518.4 4926.5 4999.7 5064.1 5065.3 5078.2 4902.8 5032.9 5046.8 5058.6 5068.7 5050.7 5070.1 5116.8 5191.9 5192.2 5082.4 5102.3 5110.5 5130.5 5139.7 4886.4 4917.8 5080.3 5083.0 5122.1 5311.5 5332.2 5357.9 5366.7 5370.1 5929.8 5933.7 5980.7 5988.5 6013.2 5908.2 5956.3 5962.2 5969.7 5986.5 5580.9 5612.0 5629.0 5630.5 5639.3 5988.3 6126.8 6133.3 6133.7 6136.7 5886.8 5916.3 5918.4 5930.6 5946.4 5954.8 5963.3 5966.4 5973.2 5977.5 5789.7 5905.7 5911.8 5917.7 5918.3 5945.4 5969.2 5990.1 6010.1 6019.0 4525.1 4529.1 4547.7 4555.1 4584.6 4033.1 4051.9 4085.5 4093.7 4136.0 5519.3 5612.9 5667.8 5674.1 5678.1 5970.7 6011.1 6012.1 6016.2 6046.5 5573.8 5688.0 5689.2 5692.0 5720.7 5116.3 5124.4 5133.7 5149.7 5168.7 6102.6 6125.4 6131.9 6138.7 6148.8 5901.4 5913.8 5966.4 5975.9 5977.2 6147.6 6160.8 6193.6 6201.1 6216.4 5938.7 5940.4 5943.4 5943.7 5969.0 5899.7 5933.9 6036.0 6074.4 6091.1 5812.9 5816.0 5817.1 5849.3 5851.6 5831.7 5842.2 5852.3 5857.4 5868.4 5551.9 5782.5 5815.7 5859.1 5879.3 5930.9 5936.3 5944.9 5948.9 5963.2 5670.1 5800.0 5816.0 5819.2 5833.0 16:19:36 INFO - PROCESS | 31881 | 16:19:36 INFO - PROCESS | 31881 | [#1] ext.html Cycles:180 Average:56598.87 Median:40186.20 stddev:123089.73 (306.3%) stddev-sans-first:123363.01 16:19:36 INFO - PROCESS | 31881 | Values: 516.6 540.3 545.7 560.0 566.0 39452.2 39684.6 39713.2 39782.4 39793.2 41594.6 41882.6 42153.0 42173.2 42192.0 8797.9 8953.8 8972.7 8982.7 8996.3 8859.4 8899.4 8915.3 8964.4 9000.9 9203.0 9221.1 9221.3 9265.6 9303.5 9044.8 9193.2 9211.5 9221.4 9235.3 9088.7 9132.3 9199.3 9201.9 9202.6 42990.4 43311.1 43373.0 43421.3 43436.3 3128.0 3568.7 3701.1 3776.0 3776.0 29524.7 29575.3 29840.9 29986.4 30074.1 3614.8 3644.1 3685.8 3703.5 3760.9 198920.0 199120.0 200185.0 200558.0 202561.0 47315.0 62766.7 63267.4 63347.7 63379.0 44945.0 45309.1 45341.0 45521.3 45554.8 15903.9 16260.8 16270.8 16306.1 16411.1 13157.1 13249.3 13262.0 13279.4 13279.7 15303.6 15528.8 16005.0 16052.8 16058.1 6003.4 6176.4 6190.4 6268.8 6277.6 1043.0 1058.5 1060.3 1149.8 1245.1 30234.8 30375.2 30418.5 30657.7 31261.7 1115.1 1131.6 1154.5 1169.4 1188.8 15698.7 15763.9 15832.1 15962.7 15997.9 319949.0 749805.0 758618.0 767903.0 768786.0 61444.4 61706.0 61726.4 62086.7 62208.7 1485.1 1497.8 1499.0 1506.6 1518.5 32039.4 32671.5 32679.3 33846.3 35734.8 56020.4 56696.0 56799.4 56853.7 56958.1 311298.0 314691.0 316675.0 316779.0 317561.0 46040.3 48609.5 49164.8 49527.8 50967.7 47287.8 47962.3 48442.5 48515.9 48727.5 38637.2 40085.2 41018.6 41124.4 41413.6 40287.2 40306.0 41059.8 41076.6 41218.0 39784.4 39982.0 39985.2 40589.8 40769.4 35329.8 35339.0 35561.6 36026.0 36145.6 27317.9 27632.9 27723.0 27815.9 28093.2 16:19:36 INFO - PROCESS | 31881 | 16:19:36 INFO - PROCESS | 31881 | [#2] jquery.html Cycles:180 Average:25232.45 Median:2108.88 stddev:68139.41 (3231.1%) stddev-sans-first:68305.01 16:19:36 INFO - PROCESS | 31881 | Values: 384.4 387.2 390.8 398.1 398.1 17193.9 18966.2 19447.0 19579.4 19805.3 12265.0 12373.8 12520.8 17682.9 17716.3 5248.1 5446.5 5455.6 5483.2 5491.7 5332.2 5421.6 5493.0 5498.9 5537.1 5415.1 5487.1 5507.1 5818.7 5863.5 5743.5 5780.6 5792.8 5806.4 5808.3 5574.3 5618.0 5621.5 5659.7 5758.0 14329.9 14488.2 14505.1 14547.7 14628.6 2212.1 2311.7 2317.5 2437.5 2995.3 10900.5 13145.7 13757.1 13958.7 14023.6 1835.4 1923.0 1968.2 2003.5 2066.1 67598.0 67618.7 68985.0 69972.3 70110.0 11402.5 11543.2 11676.2 11685.0 11815.4 14595.2 15459.3 15498.8 15565.6 15624.2 8264.0 8401.4 8438.3 8495.5 8568.4 7950.6 7958.1 7959.4 8037.4 8104.1 4998.4 5003.1 5012.3 5013.1 5045.7 2035.2 2066.8 2076.5 2080.6 2137.2 999.8 1010.0 1049.0 1056.6 1087.1 16938.8 16940.4 17116.0 17466.7 17732.3 995.4 1005.1 1017.3 1018.9 1029.4 8124.4 10087.6 10096.0 10131.8 10231.2 403239.0 406421.0 408299.0 423800.0 431207.0 75359.6 76223.0 77399.6 79002.0 79656.6 1000.9 1002.4 1019.7 1020.5 1023.9 15632.9 15838.3 15874.9 15902.1 15906.7 26507.9 33118.8 35583.0 35613.1 35756.5 37764.0 46346.1 46715.0 46779.0 47182.3 8587.4 8677.1 8791.8 8851.6 8860.3 12489.3 13676.1 13704.9 13813.2 13846.8 11730.6 11790.2 11973.8 12043.5 12081.5 11555.7 11700.8 11992.8 12222.6 12326.8 12174.9 12281.4 12401.2 12465.6 12574.8 8235.4 8812.5 9072.1 9130.8 9203.6 10766.6 11451.4 11546.2 11587.5 11768.5 16:19:36 INFO - PROCESS | 31881 | 16:19:36 INFO - PROCESS | 31881 | [#3] mootools.html Cycles:180 Average:5954.58 Median:5240.70 stddev:3100.94 (59.2%) stddev-sans-first:3090.78 16:19:36 INFO - PROCESS | 31881 | Values: 1405.3 1427.3 1658.3 1933.8 1975.9 7710.8 8176.3 8178.5 8297.2 8308.7 8347.5 8382.1 8435.2 8461.3 8470.6 2414.7 2428.0 2436.0 2439.1 2440.2 2396.5 2408.2 2424.6 2426.6 2436.5 2362.7 2411.9 2413.3 2435.2 2436.2 2424.1 2430.9 2432.7 2434.6 2457.4 2414.3 2416.6 2417.0 2422.0 2428.0 8582.9 8614.8 8699.5 8709.7 8746.7 5119.9 5280.2 5296.0 5297.2 5305.0 3209.7 3240.4 3275.3 3302.2 3309.1 1002.4 1945.9 2038.0 2098.5 2118.0 11482.9 11576.7 11578.9 11631.4 11648.0 4388.8 4430.9 4488.7 4509.6 4554.0 9203.2 9249.2 9250.8 9263.5 9307.4 5195.1 5197.6 5199.1 5199.2 5201.2 4661.6 4751.1 4788.0 4848.3 4862.1 3859.8 3881.8 3891.1 3932.9 3938.0 1156.0 1156.2 1161.2 1162.7 1163.6 1495.8 1502.0 1503.1 1522.3 1525.3 8326.3 8327.5 8327.7 8344.3 8349.6 479.1 481.4 490.0 493.2 503.8 6351.0 6413.1 6446.6 6506.2 6536.1 10360.0 10699.7 10720.1 10800.9 10826.7 10440.3 10470.5 10498.6 10647.9 10673.9 7857.7 7872.3 7963.7 7970.7 7999.8 7883.4 7929.1 7937.0 8038.7 8105.4 9215.2 9321.5 9396.1 9445.9 9451.0 8910.4 9145.8 9333.1 9789.2 9861.8 6787.0 7174.8 7376.4 7487.7 7633.5 7950.1 8044.0 8047.9 8051.6 8069.6 7214.3 7335.8 7459.2 7514.1 7521.8 7161.6 7318.8 7322.7 7325.1 7336.7 7689.5 7700.6 7701.4 7754.5 7782.5 6957.7 6958.7 7011.6 7022.2 7047.8 7134.5 7153.7 7175.6 7193.9 7198.4 16:19:36 INFO - PROCESS | 31881 | 16:19:36 INFO - PROCESS | 31881 | [#4] prototype.html Cycles:180 Average:5756.71 Median:6477.77 stddev:1747.65 (27.0%) stddev-sans-first:1705.24 16:19:36 INFO - PROCESS | 31881 | Values: 376.0 378.6 381.6 385.9 391.9 6387.5 6403.6 6406.5 6409.2 6422.8 6310.6 6398.2 6413.0 6417.6 6425.1 4789.8 4881.6 4917.9 4922.4 4945.5 4891.7 4897.7 4898.1 4898.4 4902.9 4822.4 4829.5 4848.5 4850.7 4869.8 4849.2 4851.7 4857.3 4929.4 4931.6 4323.3 4325.8 4327.4 4331.6 4341.9 5804.4 6098.2 6098.4 6102.8 6109.7 5623.6 5675.6 5697.9 5701.6 5714.9 6785.1 6839.2 6849.7 6855.3 6861.9 4648.7 4666.2 4675.9 4684.7 4690.8 7024.8 7042.6 7122.7 7122.9 7128.5 4709.6 4872.4 4890.3 4895.6 4914.7 4863.7 4887.8 4903.0 4907.8 4935.7 5681.7 5696.8 5714.9 5719.0 5730.7 6831.9 6882.9 6887.3 6911.3 6918.7 1723.4 1768.5 1769.4 1772.0 1774.8 1151.4 1172.4 1187.7 1194.3 1203.0 6590.8 6603.0 6610.1 6611.6 6618.6 7094.6 7099.7 7102.6 7104.6 7112.2 6402.0 6530.4 6562.7 6568.0 6570.7 3839.5 3853.8 3872.9 3876.0 3886.9 7238.5 7311.4 7324.0 7328.4 7390.0 7337.0 7344.4 7357.7 7371.4 7386.4 7130.4 7437.3 7496.0 7497.2 7497.6 7155.9 7174.5 7187.3 7188.6 7192.2 7030.4 7042.0 7072.6 7083.9 7093.8 7315.5 7425.3 7434.7 7447.1 7478.4 4880.9 4928.6 4934.8 4936.8 4955.1 7133.6 7166.3 7184.2 7190.5 7192.9 6964.8 6965.6 6974.9 6978.4 6979.1 6828.6 6878.1 6913.5 6957.9 6969.0 6866.9 6883.1 6885.2 6888.8 6905.6 7007.2 7040.3 7082.3 7083.0 7084.1 6785.9 6787.3 6810.0 6826.9 6833.3 16:19:36 INFO - PROCESS | 31881 | 16:19:36 INFO - PROCESS | 31881 | [#5] yui.html Cycles:180 Average:14811.00 Median:4232.51 stddev:17147.81 (405.1%) stddev-sans-first:17163.26 16:19:36 INFO - PROCESS | 31881 | Values: 719.1 725.0 728.0 913.5 929.1 13886.7 14027.6 14096.9 14108.6 14109.1 14041.9 14042.1 14105.2 14111.7 14120.8 774.5 893.5 918.5 924.6 930.8 932.7 936.4 936.9 938.6 940.0 975.7 986.0 986.7 989.0 991.0 975.2 980.6 980.8 981.2 985.1 722.0 723.9 728.8 730.0 730.9 14445.3 14480.1 14593.1 14645.3 14695.6 13987.3 14297.8 14333.1 14567.4 14594.7 11467.6 11489.6 11531.3 11594.5 12149.6 3826.3 3868.2 3896.9 3897.6 3918.8 51986.5 52896.0 52927.5 52995.7 53203.5 11343.1 11489.4 11516.5 11614.2 11738.3 19486.0 19625.8 19657.3 19712.4 19736.9 7864.4 7924.6 7965.5 8112.6 8183.7 4220.6 4225.2 4302.2 4337.3 4354.8 3431.1 3444.7 3444.8 3453.6 3462.7 631.5 634.4 635.3 636.6 662.0 561.4 588.9 671.8 693.5 707.9 8691.3 8852.9 8887.3 8940.8 9133.8 529.4 619.3 701.2 719.9 737.0 4141.9 4174.6 4201.0 4213.1 4239.8 60545.0 63254.0 63656.0 63787.7 63990.0 52749.7 53651.7 54014.5 54453.2 55047.0 48785.5 48819.3 49750.8 50884.5 51263.7 8060.4 8192.3 8244.1 8348.4 8421.8 34781.7 35608.3 35905.5 36115.8 36464.0 45597.5 47505.0 47992.5 48022.5 48312.8 11367.3 11399.4 11407.1 11484.7 11510.7 12299.9 12397.9 12806.6 12957.4 13228.3 11382.7 11504.9 12199.7 12426.1 12685.2 12030.3 12383.8 12753.5 12787.9 13164.6 10380.8 11832.2 12100.4 12553.0 12592.7 10396.8 10755.9 10852.8 10943.8 11222.0 10151.2 10395.0 10489.9 10520.0 10987.4 16:19:36 INFO - PROCESS | 31881 | -------- Summary: end -------- 16:19:36 INFO - PROCESS | 31881 | 16:19:37 INFO - TEST-INFO | 31881: exit 0 16:19:37 INFO - TEST-OK | dromaeo_css | took 1109880ms 16:19:37 INFO - TEST-START | kraken 16:19:37 INFO - operating with platform_type : linux_ 16:19:37 INFO - Initialising browser for kraken test... 16:19:37 INFO - TEST-INFO | started process 32129 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUFxqSp/profile http://localhost:56173/getInfo.html) 16:19:41 INFO - PROCESS | 32129 | 16:19:41 INFO - PROCESS | 32129 | (process:32203): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:19:41 INFO - PROCESS | 32129 | __metrics Screen width/height:1600/1200 16:19:41 INFO - PROCESS | 32129 | colorDepth:24 16:19:41 INFO - PROCESS | 32129 | Browser inner width/height: 1024/697 16:19:41 INFO - PROCESS | 32129 | __metrics 16:19:42 ERROR - PROCESS | 32129 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:19:43 INFO - TEST-INFO | 32129: exit 0 16:19:43 INFO - Browser initialized. 16:19:43 INFO - Running cycle 1/1 for kraken test... 16:19:43 INFO - TEST-INFO | started process 32254 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUFxqSp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:19:45 INFO - PROCESS | 32254 | 16:19:45 INFO - PROCESS | 32254 | (process:32322): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:19:55 INFO - PROCESS | 32254 | RSS: Main: 154243072 16:19:55 INFO - PROCESS | 32254 | 16:19:57 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56173/tests/kraken/driver.html?testName=audio-beat-detection) 16:19:58 INFO - PROCESS | 32254 | RSS: Main: 157220864 16:19:58 INFO - PROCESS | 32254 | 16:20:01 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56173/tests/kraken/driver.html?testName=audio-dft) 16:20:01 INFO - PROCESS | 32254 | RSS: Main: 158228480 16:20:01 INFO - PROCESS | 32254 | 16:20:04 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56173/tests/kraken/driver.html?testName=audio-fft) 16:20:05 INFO - PROCESS | 32254 | RSS: Main: 158773248 16:20:05 INFO - PROCESS | 32254 | 16:20:07 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56173/tests/kraken/driver.html?testName=audio-oscillator) 16:20:07 INFO - PROCESS | 32254 | RSS: Main: 158085120 16:20:07 INFO - PROCESS | 32254 | 16:20:09 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56173/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:20:10 INFO - PROCESS | 32254 | RSS: Main: 157700096 16:20:10 INFO - PROCESS | 32254 | 16:20:13 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56173/tests/kraken/driver.html?testName=imaging-darkroom) 16:20:14 INFO - PROCESS | 32254 | RSS: Main: 158359552 16:20:14 INFO - PROCESS | 32254 | 16:20:17 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56173/tests/kraken/driver.html?testName=imaging-desaturate) 16:20:18 INFO - PROCESS | 32254 | RSS: Main: 159780864 16:20:18 INFO - PROCESS | 32254 | 16:20:20 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56173/tests/kraken/driver.html?testName=json-parse-financial) 16:20:21 INFO - PROCESS | 32254 | RSS: Main: 158785536 16:20:21 INFO - PROCESS | 32254 | 16:20:23 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56173/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:20:23 INFO - PROCESS | 32254 | RSS: Main: 157974528 16:20:23 INFO - PROCESS | 32254 | 16:20:25 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56173/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:20:26 INFO - PROCESS | 32254 | RSS: Main: 159428608 16:20:26 INFO - PROCESS | 32254 | 16:20:28 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56173/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:20:28 INFO - PROCESS | 32254 | RSS: Main: 159043584 16:20:28 INFO - PROCESS | 32254 | 16:20:31 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:20:31 INFO - PROCESS | 32254 | RSS: Main: 158924800 16:20:31 INFO - PROCESS | 32254 | 16:20:34 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:20:34 INFO - PROCESS | 32254 | RSS: Main: 158490624 16:20:34 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | Cycle 1(1): loaded http://localhost:56173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56173/tests/kraken/driver.html?testName=ai-astar) 16:20:36 INFO - PROCESS | 32254 | RSS: Main: 159903744 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | __start_tp_report 16:20:36 INFO - PROCESS | 32254 | _x_x_mozilla_page_load 16:20:36 INFO - PROCESS | 32254 | _x_x_mozilla_page_load_details 16:20:36 INFO - PROCESS | 32254 | |i|pagename|runs| 16:20:36 INFO - PROCESS | 32254 | |0;ai-astar;112;104;110;110;112;121;110;109;111;111 16:20:36 INFO - PROCESS | 32254 | |1;audio-beat-detection;152;130;147;169;129;155;155;130;169;126 16:20:36 INFO - PROCESS | 32254 | |2;audio-dft;162;164;162;164;163;161;164;166;166;161 16:20:36 INFO - PROCESS | 32254 | |3;audio-fft;76;77;76;155;77;75;73;79;172;79 16:20:36 INFO - PROCESS | 32254 | |4;audio-oscillator;93;92;143;93;92;93;142;93;93;135 16:20:36 INFO - PROCESS | 32254 | |5;imaging-gaussian-blur;118;117;117;117;116;116;117;117;117;118 16:20:36 INFO - PROCESS | 32254 | |6;imaging-darkroom;148;147;147;147;146;147;148;146;147;146 16:20:36 INFO - PROCESS | 32254 | |7;imaging-desaturate;96;96;95;97;97;97;95;97;96;96 16:20:36 INFO - PROCESS | 32254 | |8;json-parse-financial;56;56;57;54;55;54;59;61;54;53 16:20:36 INFO - PROCESS | 32254 | |9;json-stringify-tinderbox;63;65;65;64;64;65;65;64;65;65 16:20:36 INFO - PROCESS | 32254 | |10;stanford-crypto-aes;77;78;80;80;79;80;82;79;78;78 16:20:36 INFO - PROCESS | 32254 | |11;stanford-crypto-ccm;112;115;111;112;112;114;109;109;116;110 16:20:36 INFO - PROCESS | 32254 | |12;stanford-crypto-pbkdf2;136;139;139;141;153;135;139;148;147;127 16:20:36 INFO - PROCESS | 32254 | |13;stanford-crypto-sha256-iterative;66;67;67;69;70;68;71;65;66;68 16:20:36 INFO - PROCESS | 32254 | __end_tp_report 16:20:36 INFO - PROCESS | 32254 | __start_cc_report 16:20:36 INFO - PROCESS | 32254 | _x_x_mozilla_cycle_collect,834 16:20:36 INFO - PROCESS | 32254 | __end_cc_report 16:20:36 INFO - PROCESS | 32254 | __startTimestamp1457997636675__endTimestamp 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | ------- Summary: start ------- 16:20:36 INFO - PROCESS | 32254 | Number of tests: 14 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:4.19 (3.8%) stddev-sans-first:4.43 16:20:36 INFO - PROCESS | 32254 | Values: 112.0 104.0 110.0 110.0 112.0 121.0 110.0 109.0 111.0 111.0 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:153.50 stddev:16.52 (10.8%) stddev-sans-first:17.39 16:20:36 INFO - PROCESS | 32254 | Values: 152.0 130.0 147.0 169.0 129.0 155.0 155.0 130.0 169.0 126.0 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:1.83 (1.1%) stddev-sans-first:1.88 16:20:36 INFO - PROCESS | 32254 | Values: 162.0 164.0 162.0 164.0 163.0 161.0 164.0 166.0 166.0 161.0 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.50 stddev:36.94 (48.3%) stddev-sans-first:38.61 16:20:36 INFO - PROCESS | 32254 | Values: 76.0 77.0 76.0 155.0 77.0 75.0 73.0 79.0 172.0 79.0 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#4] audio-oscillator Cycles:10 Average:106.90 Median:93.00 stddev:22.94 (24.7%) stddev-sans-first:23.77 16:20:36 INFO - PROCESS | 32254 | Values: 93.0 92.0 143.0 93.0 92.0 93.0 142.0 93.0 93.0 135.0 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 16:20:36 INFO - PROCESS | 32254 | Values: 118.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 118.0 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 16:20:36 INFO - PROCESS | 32254 | Values: 148.0 147.0 147.0 147.0 146.0 147.0 148.0 146.0 147.0 146.0 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:0.79 (0.8%) stddev-sans-first:0.83 16:20:36 INFO - PROCESS | 32254 | Values: 96.0 96.0 95.0 97.0 97.0 97.0 95.0 97.0 96.0 96.0 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:2.51 (4.5%) stddev-sans-first:2.67 16:20:36 INFO - PROCESS | 32254 | Values: 56.0 56.0 57.0 54.0 55.0 54.0 59.0 61.0 54.0 53.0 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.71 (1.1%) stddev-sans-first:0.50 16:20:36 INFO - PROCESS | 32254 | Values: 63.0 65.0 65.0 64.0 64.0 65.0 65.0 64.0 65.0 65.0 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.50 stddev:1.45 (1.8%) stddev-sans-first:1.32 16:20:36 INFO - PROCESS | 32254 | Values: 77.0 78.0 80.0 80.0 79.0 80.0 82.0 79.0 78.0 78.0 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#11] stanford-crypto-ccm Cycles:10 Average:112.00 Median:112.00 stddev:2.40 (2.1%) stddev-sans-first:2.55 16:20:36 INFO - PROCESS | 32254 | Values: 112.0 115.0 111.0 112.0 112.0 114.0 109.0 109.0 116.0 110.0 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.40 Median:140.00 stddev:7.41 (5.3%) stddev-sans-first:7.69 16:20:36 INFO - PROCESS | 32254 | Values: 136.0 139.0 139.0 141.0 153.0 135.0 139.0 148.0 147.0 127.0 16:20:36 INFO - PROCESS | 32254 | 16:20:36 INFO - PROCESS | 32254 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.89 (2.8%) stddev-sans-first:1.90 16:20:36 INFO - PROCESS | 32254 | Values: 66.0 67.0 67.0 69.0 70.0 68.0 71.0 65.0 66.0 68.0 16:20:36 INFO - PROCESS | 32254 | -------- Summary: end -------- 16:20:36 INFO - PROCESS | 32254 | 16:20:37 INFO - TEST-INFO | 32254: exit 0 16:20:37 INFO - TEST-OK | kraken | took 60475ms 16:20:37 INFO - SUITE-END | took 1170s 16:20:37 INFO - Completed test suite (00:19:30) 16:20:37 INFO - javascript benchmark 16:20:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3263.8531266093023, 3369.03982365026, 3374.8312584370774, 3412.8293585320744, 3423.760336776425, 5391.838244852655, 5431.348238211411, 5437.238786569878, 5438.320209973754, 5475.425080366559, 5449.836504904849, 5479.4520547945185, 5482.753276102575, 5483.643563168392, 5518.448155184479, 4926.458089610149, 4999.650024498286, 5064.11378008847, 5065.341505604285, 5078.1874900016, 4902.828401005965, 5032.949670503303, 5046.798128074873, 5058.570021548173, 5068.72122033288, 5050.671706339094, 5070.08738427083, 5116.820911268106, 5191.935653191105, 5192.221166824987, 5082.390113186423, 5102.336696229485, 5110.463401342842, 5130.4613015633195, 5139.74301284938, 4886.389201349832, 4917.778699958475, 5080.263361812516, 5083.0, 5122.129238029544, 5311.495407936279, 5332.173513105475, 5357.874846282285, 5366.6779993200535, 5370.087085195526, 5929.822105336847, 5933.703314834284, 5980.700964951735, 5988.520918326523, 6013.218281623404, 5908.172855800191, 5956.344802071769, 5962.2249107615735, 5969.70151492428, 5986.521078313768, 5580.91628625571, 5612.045952188138, 5629.0, 5630.521405680481, 5639.3232812062, 5988.341282458926, 6126.846828829226, 6133.264008318941, 6133.723982420802, 6136.6624835633575, 5886.793962211302, 5916.319623243296, 5918.4377484139795, 5930.614510056833, 5946.405359464019, 5954.821355359346, 5963.344032156459, 5966.373530779206, 5973.163757074013, 5977.491913187341, 5789.739461724233, 5905.675187864623, 5911.793087241926, 5917.6745279010065, 5918.319393269829, 5945.4351836576325, 5969.164316995624, 5990.071538911476, 6010.068439391901, 6019.036954087325, 4525.117602067631, 4529.071540334289, 4547.704399214041, 4555.1117532080925, 4584.610308123847, 4033.092554175346, 4051.8784436466954, 4085.4688890444054, 4093.6520395766097, 4136.028033412145, 5519.2824932758485, 5612.859678507988, 5667.829965101054, 5674.148877668383, 5678.0915053591225, 5970.731317090741, 6011.12838638395, 6012.098185272157, 6016.157737916695, 6046.486048685823, 5573.777048918079, 5688.0, 5689.203511508392, 5692.0, 5720.685362305113, 5116.258142569381, 5124.436312005676, 5133.743312834344, 5149.716765577854, 5168.7415629218385, 6102.633841969496, 6125.418085281891, 6131.877362452726, 6138.7237574309265, 6148.815535533941, 5901.439363260483, 5913.822585322448, 5966.403359663999, 5975.940240597538, 5977.163197152315, 6147.600405973598, 6160.815175544741, 6193.628382296896, 6201.069839524108, 6216.409441103088, 5938.673372964528, 5940.405959404198, 5943.435373639497, 5943.673097979653, 5969.0, 5899.705014749159, 5933.851653708692, 6035.969820150871, 6074.362191969956, 6091.0558863376245, 5812.883742325214, 5815.9709201453725, 5817.127430885401, 5849.327327357239, 5851.561132914963, 5831.650100993954, 5842.2405087338375, 5852.297724273115, 5857.355690874086, 5868.413158684098, 5551.944480555143, 5782.508486778503, 5815.738291776795, 5859.121131830259, 5879.323877754113, 5930.940690593211, 5936.317323507679, 5944.910826337695, 5948.940510595012, 5963.165156878127, 5670.121131224667, 5800.042992906123, 5815.9709201453725, 5819.243498345188, 5832.9708351457975], "unit": "score", "name": "dojo.html", "value": 5500.0367193474485}, {"lowerIsBetter": false, "replicates": [516.5841497594437, 540.3488796000819, 545.7189547383099, 560.0143747005269, 566.0038332534739, 39452.210955780865, 39684.60315396845, 39713.20573588526, 39782.40326395099, 39793.204135917265, 41594.58405415945, 41882.58117418832, 42153.0, 42173.156536869246, 42192.0, 8797.868031979526, 8953.820923581525, 8972.730818075468, 8982.730518084436, 8996.280297576179, 8859.424137431079, 8899.421537600068, 8915.28677705782, 8964.417312874642, 9000.8649870252, 9202.953985230064, 9221.077892210793, 9221.308401869854, 9265.583048762788, 9303.488308143049, 9044.819103617923, 9193.172614464731, 9211.493367864765, 9221.446713197163, 9235.261179105722, 9088.727338179866, 9132.3150763693, 9199.310051746146, 9201.861972070425, 9202.585883635185, 42990.35514467254, 43311.13377732459, 43373.0, 43421.34867976983, 43436.3484547732, 3128.0, 3568.678818906285, 3701.1214916037648, 3775.9622403775884, 3776.037110536823, 29524.704752952624, 29575.260618484495, 29840.850795745882, 29986.400271994655, 30074.097777066723, 3614.7831130132276, 3644.0889777555612, 3685.7788532688123, 3703.4629978652943, 3760.9435858462143, 198920.0, 199120.0, 200185.0, 200558.0, 202561.0, 47315.0, 62766.68616656979, 63267.36732632707, 63347.683261584316, 63379.0, 44945.0, 45309.09381812345, 45341.0, 45521.317180242324, 45554.77222613866, 15903.920480397524, 16260.837391626168, 16270.83729162717, 16306.103164326076, 16411.097389643444, 13157.079004469595, 13249.271290078945, 13262.0, 13279.402426890812, 13279.66800829987, 15303.61740956485, 15528.767068493982, 16005.0, 16052.839471605368, 16058.116803575682, 6003.3996600339615, 6176.4441200292185, 6190.350013248634, 6268.843278917972, 6277.560570760094, 1042.9883013476915, 1058.5342449322275, 1060.3002018667796, 1149.781541507111, 1245.1284101129245, 30234.84882575573, 30375.24061898426, 30418.54372184419, 30657.69342306593, 31261.687383126333, 1115.0577761791274, 1131.6265632341308, 1154.468944285638, 1169.351010189336, 1188.7503624238834, 15698.68602627941, 15763.921180394025, 15832.129232892301, 15962.680746385007, 15997.920010399874, 319949.0, 749805.0, 758618.0, 767903.0, 768786.0, 61444.38555614387, 61706.0, 61726.38273617296, 62086.689566551875, 62208.68895655583, 1485.0866716969201, 1497.7528707763315, 1498.9550313490613, 1506.5706273712158, 1518.5444366689949, 32039.359212816078, 32671.509927351584, 32679.346413072082, 33846.3230735379, 35734.8213258932, 56020.439795601524, 56696.0, 56799.43200567942, 56853.71573142108, 56958.14562781479, 311298.0, 314691.0, 316675.0, 316779.0, 317561.0, 46040.30939535976, 48609.51390486192, 49164.75417622889, 49527.75236123941, 50967.74516127395, 47287.76356118197, 47962.28056579085, 48442.5155748438, 48515.85371904815, 48727.5127248723, 38637.22725545417, 40085.19829603333, 41018.58981410267, 41124.38313425361, 41413.58586414097, 40287.1942561153, 40306.0, 41059.7947010275, 41076.589234107276, 41218.0, 39784.403233950936, 39982.0, 39985.20029599334, 40589.782306530855, 40769.38845917373, 35329.82335088308, 35339.0, 35561.64438355687, 36026.0, 36145.63854361423, 27317.863410683614, 27632.86183569069, 27723.0, 27815.860920696075, 28093.157205283875], "unit": "score", "name": "ext.html", "value": 19695.83395657676}, {"lowerIsBetter": false, "replicates": [384.3945785388013, 387.21395566999, 390.7948327128257, 398.06057703819, 398.0625626649241, 17193.91403042986, 18966.241350346005, 19447.0, 19579.41261762146, 19805.306814261505, 12265.0, 12373.752524949496, 12520.81218781719, 17682.93902365859, 17716.29134834605, 5248.134057880445, 5446.509814116729, 5455.645383050109, 5483.150111732668, 5491.697956612385, 5332.200169974496, 5421.647592906468, 5492.972535137319, 5498.945010549884, 5537.1140617501205, 5415.13357862742, 5487.094629386146, 5507.063799154133, 5818.709064546756, 5863.530917526609, 5743.54051675865, 5780.595358324919, 5792.826215213571, 5806.419358064202, 5808.273965754281, 5574.331080270353, 5617.9719101404235, 5621.522170615503, 5659.745311460994, 5758.049921762904, 14329.928350358286, 14488.217233542062, 14505.05717128394, 14547.70904581913, 14628.561143165616, 2212.093041852833, 2311.653252012195, 2317.4669825940127, 2437.500312435964, 2995.2961054152256, 10900.50947707355, 13145.671358216025, 13757.10578812374, 13958.720825583532, 14023.64940876476, 1835.4034938644993, 1922.9903850480657, 1968.1832039703506, 2003.5391859872166, 2066.111572024029, 67598.0, 67618.66190669064, 68985.0, 69972.30027699709, 70110.0, 11402.486888090056, 11543.191976561728, 11676.241044332091, 11685.0, 11815.409229538489, 14595.197264150574, 15459.304331305118, 15498.845011549965, 15565.610859728371, 15624.218789060502, 8264.0, 8401.411901166983, 8438.282745966662, 8495.532745699045, 8568.400211985101, 7950.562719050507, 7958.08482024563, 7959.363250939911, 8037.397195210383, 8104.1085480597085, 4998.4251811042195, 5003.149464591028, 5012.273220383097, 5013.097642424325, 5045.697258164522, 2035.236786205173, 2066.772655007948, 2076.5016396064834, 2080.5942841146134, 2137.1665050630268, 999.8056210407823, 1009.9799202805073, 1048.9632862849764, 1056.6143357674393, 1087.075985412393, 16938.83061169397, 16940.40708575194, 17116.0, 17466.650666986843, 17732.29070837152, 995.3629677006721, 1005.100435110572, 1017.2624846985876, 1018.8675472188568, 1029.4441001858913, 8124.431289809775, 10087.596496140219, 10096.040876116756, 10131.797364052678, 10231.181505479544, 403239.0, 406421.0, 408299.0, 423800.0, 431207.0, 75359.62320188365, 76223.0, 77399.61300193463, 79002.0, 79656.60171699105, 1000.8798944126752, 1002.3634991780126, 1019.6991887393089, 1020.5356562763925, 1023.9488025598839, 15632.92183539075, 15838.28727707233, 15874.920625396799, 15902.125383104041, 15906.68186636284, 26507.867460662572, 33118.834405827816, 35583.0, 35613.109672258404, 35756.4636530447, 37764.0, 46346.07307853892, 46715.0, 46779.0, 47182.29226561535, 8587.355948304028, 8677.088905664814, 8791.824163516821, 8851.557422128739, 8860.291176705978, 12489.31308778026, 13676.111052781538, 13704.931475342559, 13813.240271784747, 13846.792298115335, 11730.589429369931, 11790.174687772116, 11973.76052478963, 12043.518259269882, 12081.456334464794, 11555.711107222387, 11700.824487632863, 11992.76014479723, 12222.572209972608, 12326.75346493083, 12174.93912530467, 12281.385930703607, 12401.193922395016, 12465.563705270271, 12574.811377829157, 8235.38234632417, 8812.471251724917, 9072.138146876036, 9130.817383652422, 9203.631854726003, 10766.623168189075, 11451.370174640475, 11546.249493782878, 11587.478563464832, 11768.52925882955], "unit": "score", "name": "jquery.html", "value": 8873.933635657535}, {"lowerIsBetter": false, "replicates": [1405.2622373254044, 1427.279223991884, 1658.2537857963919, 1933.82595566399, 1975.9407217783462, 7710.7686769397005, 8176.264136227738, 8178.4683995540245, 8297.211764882333, 8308.70919517817, 8347.499150051, 8382.07797142314, 8435.198656127674, 8461.323094152469, 8470.576471176448, 2414.6740190074333, 2427.9757202428013, 2436.049940523197, 2439.0731522021697, 2440.1825388494876, 2396.508715713275, 2408.1932552594903, 2424.5514579802707, 2426.5510880487077, 2436.500517393939, 2362.7400985891622, 2411.9397015074674, 2413.3122060212845, 2435.1598698449097, 2436.196055301746, 2424.103081859714, 2430.8541487510806, 2432.70807503099, 2434.573949558829, 2457.4347899982927, 2414.275717284825, 2416.6254230594286, 2417.0, 2422.0, 2428.0287884846025, 8582.87125693115, 8614.784630384227, 8699.478031318078, 8709.695160669346, 8746.650133994632, 5119.948800511985, 5280.2079688046715, 5296.0, 5297.17893726473, 5305.0, 3209.6629853865475, 3240.351929614063, 3275.328557645677, 3302.1909632140278, 3309.1396236978317, 1002.448653240722, 1945.8540609454349, 2037.9796202037937, 2098.5383215692677, 2117.9682304765442, 11482.885171148266, 11576.652700419001, 11578.884211157949, 11631.418429078596, 11648.0, 4388.780560971939, 4430.867073987785, 4488.708233964782, 4509.594136527729, 4553.977230113828, 9203.217726493323, 9249.213816825511, 9250.76873078165, 9263.53682315895, 9307.441553506676, 5195.064888320063, 5197.610179236573, 5199.090159222121, 5199.220116982483, 5201.193814958688, 4661.557152070548, 4751.097291514601, 4787.952120478821, 4848.272759086165, 4862.05189987949, 3859.807009649506, 3881.8253178606465, 3891.124496988155, 3932.8820135395413, 3938.0351813805228, 1155.96532104037, 1156.2484385149553, 1161.2451906260999, 1162.7325715085578, 1163.6334554615269, 1495.8279797823172, 1502.0, 1503.053076561759, 1522.3073501556987, 1525.260248779341, 8326.25063744266, 8327.458715183493, 8327.66689332432, 8344.290735287446, 8349.582520874053, 479.06821232702754, 481.3908615305055, 489.99755001224764, 493.2084005171719, 503.80603467665213, 6351.04734289851, 6413.102165696806, 6446.580972236789, 6506.186726659168, 6536.117624120778, 10360.0, 10699.73250668724, 10720.088792452572, 10800.945995269973, 10826.729331766612, 10440.321379110334, 10470.528826202839, 10498.632547860789, 10647.893521064845, 10673.946630266953, 7857.724979625686, 7872.330851877655, 7963.681452741941, 7970.681172753025, 7999.760007199793, 7883.369330453665, 7929.088154862265, 7936.960315198618, 8038.718644847402, 8105.351571874354, 9215.216706580015, 9321.533923303943, 9396.107369799858, 9445.858312125461, 9450.960394356478, 8910.37627366104, 9145.77135571616, 9333.066693330884, 9789.216862651114, 9861.753456163653, 6787.0, 7174.784756457315, 7376.446766492427, 7487.737929172453, 7633.5419874807685, 7950.125486196398, 8044.034715834137, 8047.919520804717, 8051.597420129087, 8069.556174410229, 7214.314640109181, 7335.77992660221, 7459.216782237787, 7514.0607424071995, 7521.849563008818, 7161.641917903979, 7318.780436586911, 7322.670479828527, 7325.084364454443, 7336.669849856876, 7689.461737678309, 7700.576468294297, 7701.422393320636, 7754.457187997012, 7782.455228133977, 6957.721691132298, 6958.721651133898, 7011.6494175292055, 7022.1924478685605, 7047.823804404931, 7134.500584959003, 7153.713851445884, 7175.569465832067, 7193.892091618525, 7198.352148306678], "unit": "score", "name": "mootools.html", "value": 4835.820888891195}, {"lowerIsBetter": false, "replicates": [375.96240375962407, 378.62137862137854, 381.62028781362534, 385.8572328238552, 391.9495751386285, 6387.5209359298005, 6403.551751377406, 6406.487481001521, 6409.166808314918, 6422.807315780528, 6310.589811662238, 6398.232212134539, 6413.038044293358, 6417.614943103417, 6425.13260709804, 4789.80840766369, 4881.633877459187, 4917.877053073666, 4922.384701912261, 4945.5301746334135, 4891.682040667363, 4897.730624815634, 4898.118338699032, 4898.387701537308, 4902.901941961159, 4822.445418776833, 4829.541193586604, 4848.5151484851585, 4850.733209673466, 4869.780859861297, 4849.199882019462, 4851.69004368822, 4857.29569212464, 4929.408470983469, 4931.605471562267, 4323.308270676708, 4325.84859529915, 4327.3725309830215, 4331.588499092612, 4341.869743907688, 5804.448577385184, 6098.207233059718, 6098.420650038239, 6102.786402475892, 6109.694515274263, 5623.578231632644, 5675.602707810455, 5697.857553561153, 5701.572382071361, 5714.942850571482, 6785.117934668461, 6839.247682754893, 6849.726010959555, 6855.348741869514, 6861.931380686229, 4648.697834640738, 4666.2067448533835, 4675.94791171987, 4684.718916864965, 4690.788914498856, 7024.789256322319, 7042.647867606599, 7122.715091396338, 7122.9287707122785, 7128.501004929657, 4709.646776491777, 4872.439669437989, 4890.290907818347, 4895.559399654048, 4914.655974081851, 4863.732494712754, 4887.755612219375, 4902.975485122623, 4907.754612269444, 4935.728534930541, 5681.659100453986, 5696.8006119785605, 5714.885702285931, 5718.971405142947, 5730.713464326767, 6831.863362732717, 6882.931170688229, 6887.345702158287, 6911.343422374866, 6918.688659010357, 1723.4312676816621, 1768.5409537131918, 1769.3718729850975, 1772.0, 1774.8047714751367, 1151.447305293447, 1172.4489489939715, 1187.7386974865515, 1194.2655267010725, 1202.9939850300693, 6590.8352291193105, 6602.966985165043, 6610.10763546915, 6611.570247933869, 6618.602883826986, 7094.574325540484, 7099.680514376865, 7102.60935648534, 7104.609246491493, 7112.182099058571, 6401.967990160112, 6530.412262896267, 6562.67186640666, 6568.0, 6570.737170513222, 3839.500864887603, 3853.845846166178, 3872.9225415491533, 3876.030992251937, 3886.941695874564, 7238.52949558277, 7311.415086793044, 7323.974643549907, 7328.413726901835, 7390.039294891737, 7337.0, 7344.375728063174, 7357.742479013209, 7371.447141464411, 7386.372158366492, 7130.393916517154, 7437.293457121565, 7496.0, 7497.212792656693, 7497.587632680255, 7155.8568828624175, 7174.497785154989, 7187.281271872771, 7188.6046267455795, 7192.244814294424, 7030.367266945999, 7041.964790176016, 7072.611006394492, 7083.929160708327, 7093.751718689821, 7315.524490908074, 7425.294597013275, 7434.702611895464, 7447.106347238366, 7478.401727861867, 4880.901212478669, 4928.581070609039, 4934.827281045146, 4936.827211047596, 4955.083309587738, 7133.607651579213, 7166.283371663, 7184.209736929038, 7190.4607154464675, 7192.8921066183, 6964.825879353057, 6965.616891071039, 6974.930250697428, 6978.441724662116, 6979.092717946837, 6828.624425656438, 6878.105846239957, 6913.481488888454, 6957.930420695729, 6969.0, 6866.862662746817, 6883.139607549057, 6885.242623311532, 6888.758893438706, 6905.551139175937, 7007.194172670208, 7040.260772619006, 7082.291770822876, 7083.043789088613, 7084.149902011792, 6785.864282714417, 6787.253402125861, 6810.046593477016, 6826.897596535957, 6833.282505336868], "unit": "score", "name": "prototype.html", "value": 5197.221595102384}, {"lowerIsBetter": false, "replicates": [719.0508528742059, 724.9782506524803, 728.0208120078499, 913.4656226107728, 929.1312622697778, 13886.722265554696, 14027.579172624812, 14096.929515352434, 14108.576742697709, 14109.082909610868, 14041.929790351034, 14042.08726432781, 14105.153690778534, 14111.717765644707, 14120.78818817716, 774.4656187230821, 893.4862454088892, 918.5177781664646, 924.5793164110314, 930.7905721212724, 932.6968735161066, 936.3539157981005, 936.8735220745215, 938.6057855700623, 940.0223767282018, 975.7414285214388, 985.9901400986006, 986.66453405842, 989.0356902020544, 990.9752256193581, 975.1613612293422, 980.5783513089368, 980.843065109579, 981.205223768746, 985.1281615770024, 722.0252658910481, 723.8624661314334, 728.8323685552352, 729.9744508942161, 730.9195988441268, 14445.349959251858, 14480.131192128507, 14593.051451655609, 14645.267736613127, 14695.559133226021, 13987.300634968313, 14297.78553321701, 14333.140011599233, 14567.417303307855, 14594.708105837824, 11467.598634047852, 11489.597864074802, 11531.250468719507, 11594.536218551248, 12149.635510934597, 3826.253880493305, 3868.18768058708, 3896.8636097736444, 3897.610238976108, 3918.804059796999, 51986.480135198544, 52895.999999999614, 52927.47072529264, 52995.73502132503, 53203.46796532024, 11343.092552595772, 11489.368084755419, 11516.539338426537, 11614.187006909435, 11738.295702257892, 19486.0, 19625.803741962398, 19657.311994080424, 19712.40862774119, 19736.90131549333, 7864.449488535862, 7924.564148971862, 7965.522068675898, 8112.59437028158, 8183.71357002502, 4220.6412454941055, 4225.233231881403, 4302.225599392077, 4337.262665346835, 4354.847580334673, 3431.0736101252523, 3444.6727560881677, 3444.793312401264, 3453.620101788801, 3462.7056700180765, 631.4569470255576, 634.4353525362432, 635.2757856044113, 636.6084857812413, 662.0301258655995, 561.3600495435207, 588.9381614930456, 671.7917445591883, 693.4868197533789, 707.8548897476005, 8691.34814888886, 8852.911470885208, 8887.333449991276, 8940.776480587907, 9133.77165570866, 529.370049640926, 619.3249358199585, 701.1866235167182, 719.9388052015637, 737.0344848248811, 4141.937870931938, 4174.582541745862, 4200.957990420056, 4213.073123912734, 4239.788010599457, 60545.0, 63254.0, 63656.0, 63787.6810615944, 63990.0, 52749.7362513185, 53651.73174134104, 54014.45985540094, 54453.183202251996, 55047.0, 48785.512144878805, 48819.267710984364, 49750.75124624354, 50884.49115508798, 51263.743681281354, 8060.435769496079, 8192.30365418946, 8244.051934027664, 8348.37387195975, 8421.831563368576, 34781.65218347885, 35608.28783424265, 35905.46141807823, 36115.81942090273, 36464.0, 45597.54402455933, 47505.0, 47992.520074798806, 48022.5197748018, 48312.758436207594, 11367.261128026652, 11399.430028498708, 11407.094949171937, 11484.655460336204, 11510.712232194262, 12299.93850030744, 12397.876021239672, 12806.551770687982, 12957.41691623898, 13228.338583070616, 11382.715432114263, 11504.884951150381, 12199.69500762488, 12426.130170887951, 12685.23888566689, 12030.27818330903, 12383.814242786546, 12753.48986040548, 12787.913027392404, 13164.60506184816, 10380.792384152426, 11832.17174797756, 12100.394980251129, 12553.0, 12592.685182870502, 10396.844047339448, 10755.946220268848, 10852.782944341227, 10943.781124377627, 11222.0, 10151.238657100599, 10395.0, 10489.895101048893, 10520.0, 10987.39569323695], "unit": "score", "name": "yui.html", "value": 6795.800881220188}], "name": "dromaeo_css", "value": 7399.951711098085}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 104.0, 110.0, 110.0, 112.0, 121.0, 110.0, 109.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [152.0, 130.0, 147.0, 169.0, 129.0, 155.0, 155.0, 130.0, 169.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 162.0, 164.0, 163.0, 161.0, 164.0, 166.0, 166.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 76.0, 155.0, 77.0, 75.0, 73.0, 79.0, 172.0, 79.0], "unit": "score", "name": "audio-fft", "value": 93.9}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 143.0, 93.0, 92.0, 93.0, 142.0, 93.0, 93.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 97.0, 97.0, 97.0, 95.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 54.0, 55.0, 54.0, 59.0, 61.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 80.0, 80.0, 79.0, 80.0, 82.0, 79.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.1}, {"lowerIsBetter": true, "replicates": [112.0, 115.0, 111.0, 112.0, 112.0, 114.0, 109.0, 109.0, 116.0, 110.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.0}, {"lowerIsBetter": true, "replicates": [136.0, 139.0, 139.0, 141.0, 153.0, 135.0, 139.0, 148.0, 147.0, 127.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.4}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 69.0, 70.0, 68.0, 71.0, 65.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1501.0}]} 16:20:37 INFO - Return code: 0 16:20:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:20:37 ERROR - # TBPL SUCCESS # 16:20:37 INFO - Running post-action listener: _resource_record_post_action 16:20:37 INFO - Running post-run listener: _resource_record_post_run 16:20:39 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 266240; Write bytes: 495874048; Read time: 28; Write time: 539464 16:20:39 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 244600832; Read time: 0; Write time: 358636 16:20:39 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251273216; Read time: 28; Write time: 180828 16:20:39 INFO - Running post-run listener: _upload_blobber_files 16:20:39 INFO - Blob upload gear active. 16:20:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:20:39 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:39 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:39 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:39 INFO - (blobuploader) - INFO - Open directory for files ... 16:20:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:20:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:20:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:40 INFO - (blobuploader) - INFO - Done attempting. 16:20:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:20:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:20:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:40 INFO - (blobuploader) - INFO - Done attempting. 16:20:40 INFO - (blobuploader) - INFO - Iteration through files over. 16:20:40 INFO - Return code: 0 16:20:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:20:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:20:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc09f28440742f1e9d71cbeb328d25d156a1484da1d70152856e223246c8e6a29bb30c061355754bcf34a279f44f7be87189579d41ad13c666a8ad288847b609", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c60b245688551668eda39d71464c04dc5ef5f4cb9c6467d75ecbc9d745c38eb0459ea9d45dcc0431bb79b9e427236b319442788336670593867ae265c22bb29d"} 16:20:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:20:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:20:40 INFO - Contents: 16:20:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc09f28440742f1e9d71cbeb328d25d156a1484da1d70152856e223246c8e6a29bb30c061355754bcf34a279f44f7be87189579d41ad13c666a8ad288847b609", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c60b245688551668eda39d71464c04dc5ef5f4cb9c6467d75ecbc9d745c38eb0459ea9d45dcc0431bb79b9e427236b319442788336670593867ae265c22bb29d"} 16:20:40 INFO - Running post-run listener: copy_logs_to_upload_dir 16:20:40 INFO - Copying logs to upload dir... 16:20:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:20:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.376108 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-14 16:20:40.781321) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 16:20:40.784655) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc09f28440742f1e9d71cbeb328d25d156a1484da1d70152856e223246c8e6a29bb30c061355754bcf34a279f44f7be87189579d41ad13c666a8ad288847b609", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c60b245688551668eda39d71464c04dc5ef5f4cb9c6467d75ecbc9d745c38eb0459ea9d45dcc0431bb79b9e427236b319442788336670593867ae265c22bb29d"} 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.011263 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc09f28440742f1e9d71cbeb328d25d156a1484da1d70152856e223246c8e6a29bb30c061355754bcf34a279f44f7be87189579d41ad13c666a8ad288847b609", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c60b245688551668eda39d71464c04dc5ef5f4cb9c6467d75ecbc9d745c38eb0459ea9d45dcc0431bb79b9e427236b319442788336670593867ae265c22bb29d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 16:20:40.812352) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:20:40.812767) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1457994041.767123-1526937667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 16:20:40.897347) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 16:20:40.897789) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 16:20:40.898139) ========= ========= Total master_lag: 0.41 =========