builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1457521804.51 results: success (0) buildid: 20160308043045 builduid: c80d6936f3c04de3adb20fe1cc8bf9af revision: 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.508661) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.509054) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.509419) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006366 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.577639) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.577931) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.657940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.658232) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.723134) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.723502) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.723892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.724168) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-09 03:10:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.7M=0s 2016-03-09 03:10:04 (35.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097780 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.852448) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.852795) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018401 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.906992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:04.907359) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 --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=8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-09 03:10:05,072 truncating revision to first 12 chars 2016-03-09 03:10:05,072 Setting DEBUG logging. 2016-03-09 03:10:05,072 attempt 1/10 2016-03-09 03:10:05,072 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/05c087337043?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 03:10:05,414 unpacking tar archive at: mozilla-central-05c087337043/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662307 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:05.582463) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:05.582760) ========= echo 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'05c087337043dd8e71cc27bdb5b9d55fd00aaa26'] 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=8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 program finished with exit code 0 elapsedTime=0.004656 script_repo_revision: '05c087337043dd8e71cc27bdb5b9d55fd00aaa26' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:05.631516) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:05.631815) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:05.641446) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-09 03:10:05.641726) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:10:05 INFO - MultiFileLogger online at 20160309 03:10:05 in /builds/slave/test-pgo 03:10:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:10:05 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:10:05 INFO - {'append_to_log': False, 03:10:05 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:10:05 INFO - 'blob_upload_branch': 'Firefox', 03:10:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:10:05 INFO - 'branch': 'Firefox', 03:10:05 INFO - 'buildbot_json_path': 'buildprops.json', 03:10:05 INFO - 'config_files': ('talos/linux_config.py',), 03:10:05 INFO - 'default_actions': ('clobber', 03:10:05 INFO - 'read-buildbot-config', 03:10:05 INFO - 'download-and-extract', 03:10:05 INFO - 'populate-webroot', 03:10:05 INFO - 'create-virtualenv', 03:10:05 INFO - 'install', 03:10:05 INFO - 'run-tests'), 03:10:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:10:05 INFO - 'download_minidump_stackwalk': True, 03:10:05 INFO - 'download_symbols': 'ondemand', 03:10:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:10:05 INFO - 'tooltool.py': '/tools/tooltool.py', 03:10:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:10:05 INFO - '/tools/misc-python/virtualenv.py')}, 03:10:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:10:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:10:05 INFO - 'installer_path': 'installer.exe', 03:10:05 INFO - 'log_level': 'info', 03:10:05 INFO - 'log_name': 'talos', 03:10:05 INFO - 'log_to_console': True, 03:10:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:10:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:10:05 INFO - 'opt_config_files': (), 03:10:05 INFO - 'pip_index': False, 03:10:05 INFO - 'sps_profile': False, 03:10:05 INFO - 'sps_profile_interval': 0, 03:10:05 INFO - 'suite': 'dromaeojs', 03:10:05 INFO - 'system_bits': '32', 03:10:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:10:05 INFO - 'title': 'talos-linux64-ix-001', 03:10:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:10:05 INFO - 'use_talos_json': True, 03:10:05 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:10:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:10:05 INFO - 'work_dir': 'build'} 03:10:05 INFO - ##### 03:10:05 INFO - ##### Running clobber step. 03:10:05 INFO - ##### 03:10:05 INFO - Running pre-action listener: _resource_record_pre_action 03:10:05 INFO - Running main action method: clobber 03:10:05 INFO - rmtree: /builds/slave/test-pgo/build 03:10:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:10:06 INFO - Running post-action listener: _resource_record_post_action 03:10:06 INFO - ##### 03:10:06 INFO - ##### Running read-buildbot-config step. 03:10:06 INFO - ##### 03:10:06 INFO - Running pre-action listener: _resource_record_pre_action 03:10:06 INFO - Running main action method: read_buildbot_config 03:10:06 INFO - Using buildbot properties: 03:10:06 INFO - { 03:10:06 INFO - "project": "", 03:10:06 INFO - "product": "firefox", 03:10:06 INFO - "script_repo_revision": "production", 03:10:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:10:06 INFO - "repository": "", 03:10:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 03:10:06 INFO - "buildid": "20160308043045", 03:10:06 INFO - "pgo_build": "True", 03:10:06 INFO - "basedir": "/builds/slave/test-pgo", 03:10:06 INFO - "buildnumber": 214, 03:10:06 INFO - "slavename": "talos-linux64-ix-001", 03:10:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:10:06 INFO - "platform": "ubuntu64_hw", 03:10:06 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 03:10:06 INFO - "branch": "mozilla-central", 03:10:06 INFO - "repo_path": "mozilla-central", 03:10:06 INFO - "revision": "05c087337043dd8e71cc27bdb5b9d55fd00aaa26", 03:10:06 INFO - "stage_platform": "linux64-pgo", 03:10:06 INFO - "builduid": "c80d6936f3c04de3adb20fe1cc8bf9af", 03:10:06 INFO - "slavebuilddir": "test" 03:10:06 INFO - } 03:10:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 03:10:06 INFO - Running post-action listener: _resource_record_post_action 03:10:06 INFO - ##### 03:10:06 INFO - ##### Running download-and-extract step. 03:10:06 INFO - ##### 03:10:06 INFO - Running pre-action listener: _resource_record_pre_action 03:10:06 INFO - Running main action method: download_and_extract 03:10:06 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:10:06 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')]} 03:10:06 INFO - https://queue.taskcluster.net/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:10:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:10:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:10:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:10:08 INFO - Downloaded 1448 bytes. 03:10:08 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:10:08 INFO - Using the following test package requirements: 03:10:08 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:10:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:10:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:10:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:08 INFO - u'jsshell-linux-x86_64.zip'], 03:10:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:10:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:10:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:10:08 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:10:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:10:08 INFO - u'webapprt': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:10:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:10:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:10:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:10:08 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')]} 03:10:08 INFO - https://queue.taskcluster.net/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:10:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:10:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:10:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:10:14 INFO - Downloaded 23405145 bytes. 03:10:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:10:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:10:15 INFO - Return code: 0 03:10:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:15 INFO - https://queue.taskcluster.net/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:10:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:10:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:10:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:10:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:10:20 INFO - Downloaded 23405145 bytes. 03:10:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:10:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:10:21 INFO - Return code: 0 03:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:21 INFO - https://queue.taskcluster.net/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:10:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:10:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:10:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:10:23 INFO - Downloaded 10845161 bytes. 03:10:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:10:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 03:10:23 INFO - Return code: 0 03:10: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')]} 03:10:23 INFO - https://queue.taskcluster.net/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:10:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:10:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:10:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:10:24 INFO - Downloaded 56188423 bytes. 03:10:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:10:24 INFO - mkdir: /builds/slave/test-pgo/properties 03:10:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:10:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:10:24 INFO - Contents: 03:10:24 INFO - build_url:https://queue.taskcluster.net/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:10:25 INFO - Running post-action listener: _resource_record_post_action 03:10:25 INFO - Running post-action listener: set_extra_try_arguments 03:10:25 INFO - ##### 03:10:25 INFO - ##### Running populate-webroot step. 03:10:25 INFO - ##### 03:10:25 INFO - Running pre-action listener: _resource_record_pre_action 03:10:25 INFO - Running main action method: populate_webroot 03:10:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:10:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:10:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:10:25 INFO - '--tppagecycles', 03:10:25 INFO - '7'], 03:10:25 INFO - 'tests': ['tsvgm']}}, 03:10:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:10:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:10:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:10:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:10:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:10:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:10:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:25 INFO - 'talos_options': ['--e10s'], 03:10:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:25 INFO - 'tests': ['damp', 'tps']}, 03:10:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:25 INFO - 'talos_options': ['--e10s'], 03:10:25 INFO - 'tests': ['damp', 'tps']}, 03:10:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:10:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:10:25 INFO - 'other': {'tests': ['a11yr', 03:10:25 INFO - 'ts_paint', 03:10:25 INFO - 'tpaint', 03:10:25 INFO - 'sessionrestore', 03:10:25 INFO - 'sessionrestore_no_auto_restore', 03:10:25 INFO - 'tabpaint']}, 03:10:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:10:25 INFO - 'tests': ['a11yr', 03:10:25 INFO - 'ts_paint', 03:10:25 INFO - 'tpaint', 03:10:25 INFO - 'sessionrestore', 03:10:25 INFO - 'sessionrestore_no_auto_restore', 03:10:25 INFO - 'tabpaint']}, 03:10:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:10:25 INFO - 'tests': ['a11yr', 03:10:25 INFO - 'ts_paint', 03:10:25 INFO - 'tpaint', 03:10:25 INFO - 'sessionrestore', 03:10:25 INFO - 'sessionrestore_no_auto_restore', 03:10:25 INFO - 'tabpaint']}, 03:10:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:10:25 INFO - 'tests': ['a11yr', 03:10:25 INFO - 'ts_paint', 03:10:25 INFO - 'tpaint', 03:10:25 INFO - 'sessionrestore', 03:10:25 INFO - 'sessionrestore_no_auto_restore', 03:10:25 INFO - 'tabpaint']}, 03:10:25 INFO - 'other_l64': {'tests': ['a11yr', 03:10:25 INFO - 'ts_paint', 03:10:25 INFO - 'tpaint', 03:10:25 INFO - 'sessionrestore', 03:10:25 INFO - 'sessionrestore_no_auto_restore', 03:10:25 INFO - 'tabpaint']}, 03:10:25 INFO - 'other_nol64': {'tests': ['a11yr', 03:10:25 INFO - 'ts_paint', 03:10:25 INFO - 'tpaint', 03:10:25 INFO - 'sessionrestore', 03:10:25 INFO - 'sessionrestore_no_auto_restore', 03:10:25 INFO - 'tabpaint']}, 03:10:25 INFO - 'svgr': {'tests': ['tsvgx', 03:10:25 INFO - 'tsvgr_opacity', 03:10:25 INFO - 'tart', 03:10:25 INFO - 'tscrollx', 03:10:25 INFO - 'cart']}, 03:10:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:10:25 INFO - 'tests': ['tsvgx', 03:10:25 INFO - 'tsvgr_opacity', 03:10:25 INFO - 'tart', 03:10:25 INFO - 'tscrollx', 03:10:25 INFO - 'cart']}, 03:10:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:25 INFO - 'tests': ['tp5o']}, 03:10:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:25 INFO - 'talos_options': ['--e10s'], 03:10:25 INFO - 'tests': ['tp5o']}, 03:10:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:25 INFO - 'talos_options': ['--xperf_path', 03:10:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:25 INFO - 'tests': ['tp5n']}, 03:10:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:25 INFO - 'talos_options': ['--e10s', 03:10:25 INFO - '--xperf_path', 03:10:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:25 INFO - 'tests': ['tp5n']}}, 03:10:25 INFO - 'talos.zip': {'path': '', 03:10:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:10:25 INFO - Running post-action listener: _resource_record_post_action 03:10:25 INFO - ##### 03:10:25 INFO - ##### Running create-virtualenv step. 03:10:25 INFO - ##### 03:10:25 INFO - Running pre-action listener: _resource_record_pre_action 03:10:25 INFO - Running main action method: create_virtualenv 03:10:25 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:10:25 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 03:10:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:10:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:10:25 INFO - Using real prefix '/usr' 03:10:25 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:10:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:10:27 INFO - Installing pip.................done. 03:10:27 INFO - Return code: 0 03:10:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:10:27 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')]} 03:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:27 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')]} 03:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:27 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 0x7f2814b7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633920>, '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 0x2634820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', '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 03:10:27 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 03:10:27 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 03:10:27 INFO - Using env: {'DISPLAY': ':0', 03:10:27 INFO - 'HOME': '/home/cltbld', 03:10:27 INFO - 'LANG': 'en_US.UTF-8', 03:10:27 INFO - 'LANGUAGE': 'en_US:en', 03:10:27 INFO - 'LOGNAME': 'cltbld', 03:10:27 INFO - 'MAIL': '/var/mail/cltbld', 03:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:27 INFO - 'MOZ_NO_REMOTE': '1', 03:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:27 INFO - 'NO_EM_RESTART': '1', 03:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:10:27 INFO - 'PWD': '/builds/slave/test-pgo', 03:10:27 INFO - 'SHELL': '/bin/bash', 03:10:27 INFO - 'SHLVL': '1', 03:10:27 INFO - 'TERM': 'linux', 03:10:27 INFO - 'TMOUT': '86400', 03:10:27 INFO - 'USER': 'cltbld', 03:10:27 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', 03:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:27 INFO - '_': '/tools/buildbot/bin/python'} 03:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:28 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 03:10:28 INFO - Cleaning up... 03:10:28 INFO - Return code: 0 03:10:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:10:28 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')]} 03:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:28 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')]} 03:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:28 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 0x7f2814b7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633920>, '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 0x2634820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', '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 03:10:28 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 03:10:28 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 03:10:28 INFO - Using env: {'DISPLAY': ':0', 03:10:28 INFO - 'HOME': '/home/cltbld', 03:10:28 INFO - 'LANG': 'en_US.UTF-8', 03:10:28 INFO - 'LANGUAGE': 'en_US:en', 03:10:28 INFO - 'LOGNAME': 'cltbld', 03:10:28 INFO - 'MAIL': '/var/mail/cltbld', 03:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:28 INFO - 'MOZ_NO_REMOTE': '1', 03:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:28 INFO - 'NO_EM_RESTART': '1', 03:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:10:28 INFO - 'PWD': '/builds/slave/test-pgo', 03:10:28 INFO - 'SHELL': '/bin/bash', 03:10:28 INFO - 'SHLVL': '1', 03:10:28 INFO - 'TERM': 'linux', 03:10:28 INFO - 'TMOUT': '86400', 03:10:28 INFO - 'USER': 'cltbld', 03:10:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', 03:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:28 INFO - '_': '/tools/buildbot/bin/python'} 03:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:28 INFO - Downloading/unpacking psutil>=0.7.1 03:10:28 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 03:10:28 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 03:10:28 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 03:10:28 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 03:10:28 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 03:10:28 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 03:10:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:10:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:30 INFO - Installing collected packages: psutil 03:10:30 INFO - Running setup.py install for psutil 03:10:30 INFO - building 'psutil._psutil_linux' extension 03:10:30 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 03:10:30 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 03:10:30 INFO - building 'psutil._psutil_posix' extension 03:10:30 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 03:10:30 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 03:10:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:30 INFO - Successfully installed psutil 03:10:30 INFO - Cleaning up... 03:10:30 INFO - Return code: 0 03:10:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:30 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 0x7f2814b7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633920>, '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 0x2634820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', '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 03:10:30 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 03:10:30 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 03:10:30 INFO - Using env: {'DISPLAY': ':0', 03:10:30 INFO - 'HOME': '/home/cltbld', 03:10:30 INFO - 'LANG': 'en_US.UTF-8', 03:10:30 INFO - 'LANGUAGE': 'en_US:en', 03:10:30 INFO - 'LOGNAME': 'cltbld', 03:10:30 INFO - 'MAIL': '/var/mail/cltbld', 03:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:30 INFO - 'MOZ_NO_REMOTE': '1', 03:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:30 INFO - 'NO_EM_RESTART': '1', 03:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:10:30 INFO - 'PWD': '/builds/slave/test-pgo', 03:10:30 INFO - 'SHELL': '/bin/bash', 03:10:30 INFO - 'SHLVL': '1', 03:10:30 INFO - 'TERM': 'linux', 03:10:30 INFO - 'TMOUT': '86400', 03:10:30 INFO - 'USER': 'cltbld', 03:10:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', 03:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:30 INFO - '_': '/tools/buildbot/bin/python'} 03:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:10:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:10:32 INFO - Installing collected packages: mozsystemmonitor 03:10:32 INFO - Running setup.py install for mozsystemmonitor 03:10:33 INFO - Successfully installed mozsystemmonitor 03:10:33 INFO - Cleaning up... 03:10:33 INFO - Return code: 0 03:10:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:33 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 0x7f2814b7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633920>, '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 0x2634820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', '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 03:10:33 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 03:10:33 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 03:10:33 INFO - Using env: {'DISPLAY': ':0', 03:10:33 INFO - 'HOME': '/home/cltbld', 03:10:33 INFO - 'LANG': 'en_US.UTF-8', 03:10:33 INFO - 'LANGUAGE': 'en_US:en', 03:10:33 INFO - 'LOGNAME': 'cltbld', 03:10:33 INFO - 'MAIL': '/var/mail/cltbld', 03:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:33 INFO - 'MOZ_NO_REMOTE': '1', 03:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:33 INFO - 'NO_EM_RESTART': '1', 03:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:10:33 INFO - 'PWD': '/builds/slave/test-pgo', 03:10:33 INFO - 'SHELL': '/bin/bash', 03:10:33 INFO - 'SHLVL': '1', 03:10:33 INFO - 'TERM': 'linux', 03:10:33 INFO - 'TMOUT': '86400', 03:10:33 INFO - 'USER': 'cltbld', 03:10:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', 03:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:33 INFO - '_': '/tools/buildbot/bin/python'} 03:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:33 INFO - Downloading/unpacking blobuploader==1.2.4 03:10:33 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 03:10:33 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 03:10:33 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 03:10:33 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 03:10:33 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 03:10:33 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 03:10:35 INFO - Downloading blobuploader-1.2.4.tar.gz 03:10:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:10:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:10:35 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 03:10:35 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 03:10:35 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 03:10:35 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 03:10:35 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 03:10:35 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 03:10:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:10:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:10:35 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 03:10:35 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 03:10:35 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 03:10:35 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 03:10:35 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 03:10:35 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 03:10:35 INFO - Downloading docopt-0.6.1.tar.gz 03:10:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:10:35 INFO - Installing collected packages: blobuploader, requests, docopt 03:10:35 INFO - Running setup.py install for blobuploader 03:10:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:10:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:10:36 INFO - Running setup.py install for requests 03:10:36 INFO - Running setup.py install for docopt 03:10:36 INFO - Successfully installed blobuploader requests docopt 03:10:36 INFO - Cleaning up... 03:10:36 INFO - Return code: 0 03:10:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:36 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 0x7f2814b7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633920>, '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 0x2634820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', '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 03:10:36 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 03:10:36 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 03:10:36 INFO - Using env: {'DISPLAY': ':0', 03:10:36 INFO - 'HOME': '/home/cltbld', 03:10:36 INFO - 'LANG': 'en_US.UTF-8', 03:10:36 INFO - 'LANGUAGE': 'en_US:en', 03:10:36 INFO - 'LOGNAME': 'cltbld', 03:10:36 INFO - 'MAIL': '/var/mail/cltbld', 03:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:36 INFO - 'MOZ_NO_REMOTE': '1', 03:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:36 INFO - 'NO_EM_RESTART': '1', 03:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:10:36 INFO - 'PWD': '/builds/slave/test-pgo', 03:10:36 INFO - 'SHELL': '/bin/bash', 03:10:36 INFO - 'SHLVL': '1', 03:10:36 INFO - 'TERM': 'linux', 03:10:36 INFO - 'TMOUT': '86400', 03:10:36 INFO - 'USER': 'cltbld', 03:10:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', 03:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:36 INFO - '_': '/tools/buildbot/bin/python'} 03:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:10:36 INFO - Running setup.py (path:/tmp/pip-YUuM6M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:10:36 INFO - Running setup.py (path:/tmp/pip-uXoKvF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:10:36 INFO - Running setup.py (path:/tmp/pip-AOZF2I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:10:36 INFO - Running setup.py (path:/tmp/pip-kcZCyC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:10:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:10:37 INFO - Running setup.py (path:/tmp/pip-m7vZQW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:10:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:10:37 INFO - Running setup.py (path:/tmp/pip-74avte-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:10:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:10:37 INFO - Running setup.py (path:/tmp/pip-AzFKBL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:10:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:10:37 INFO - Running setup.py (path:/tmp/pip-qfL7Ts-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:10:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:10:37 INFO - Running setup.py (path:/tmp/pip-ymx6WK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:10:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:10:37 INFO - Running setup.py (path:/tmp/pip-m4ZRF9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:10:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:10:37 INFO - Running setup.py (path:/tmp/pip-mSA0EZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:10:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:10:37 INFO - Running setup.py (path:/tmp/pip-OT8bH7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:10:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:10:37 INFO - Running setup.py (path:/tmp/pip-QyZtfW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:10:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:10:37 INFO - Running setup.py (path:/tmp/pip-WNVTH0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:10:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:10:37 INFO - Running setup.py (path:/tmp/pip-xPCmRB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:10:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:10:37 INFO - Running setup.py (path:/tmp/pip-ErwbWW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:10:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:10:37 INFO - Running setup.py (path:/tmp/pip-HcQRwJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:10:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:10:37 INFO - Running setup.py install for manifestparser 03:10:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:10:38 INFO - Running setup.py install for mozcrash 03:10:38 INFO - Running setup.py install for mozdebug 03:10:38 INFO - Running setup.py install for mozdevice 03:10:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:10:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:10:38 INFO - Running setup.py install for mozfile 03:10:38 INFO - Running setup.py install for mozhttpd 03:10:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:10:38 INFO - Running setup.py install for mozinfo 03:10:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:10:38 INFO - Running setup.py install for mozInstall 03:10:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:10:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:10:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:10:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:10:38 INFO - Running setup.py install for mozleak 03:10:38 INFO - Running setup.py install for mozlog 03:10:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:10:38 INFO - Running setup.py install for moznetwork 03:10:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:10:39 INFO - Running setup.py install for mozprocess 03:10:39 INFO - Running setup.py install for mozprofile 03:10:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:10:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:10:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:10:39 INFO - Running setup.py install for mozrunner 03:10:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:10:39 INFO - Running setup.py install for mozscreenshot 03:10:39 INFO - Running setup.py install for moztest 03:10:39 INFO - Running setup.py install for mozversion 03:10:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:10:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:10:39 INFO - Cleaning up... 03:10:39 INFO - Return code: 0 03:10:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:39 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 0x7f2814b7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633920>, '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 0x2634820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', '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 03:10:39 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 03:10:39 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 03:10:39 INFO - Using env: {'DISPLAY': ':0', 03:10:39 INFO - 'HOME': '/home/cltbld', 03:10:39 INFO - 'LANG': 'en_US.UTF-8', 03:10:39 INFO - 'LANGUAGE': 'en_US:en', 03:10:39 INFO - 'LOGNAME': 'cltbld', 03:10:39 INFO - 'MAIL': '/var/mail/cltbld', 03:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:39 INFO - 'MOZ_NO_REMOTE': '1', 03:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:39 INFO - 'NO_EM_RESTART': '1', 03:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:10:39 INFO - 'PWD': '/builds/slave/test-pgo', 03:10:39 INFO - 'SHELL': '/bin/bash', 03:10:39 INFO - 'SHLVL': '1', 03:10:39 INFO - 'TERM': 'linux', 03:10:39 INFO - 'TMOUT': '86400', 03:10:39 INFO - 'USER': 'cltbld', 03:10:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', 03:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:39 INFO - '_': '/tools/buildbot/bin/python'} 03:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:10:39 INFO - Running setup.py (path:/tmp/pip-IohwgN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:10:40 INFO - Running setup.py (path:/tmp/pip-H9TGcC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:10:40 INFO - Running setup.py (path:/tmp/pip-BNmUzc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:10:40 INFO - Running setup.py (path:/tmp/pip-E67lFJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:10:40 INFO - Running setup.py (path:/tmp/pip-_6eOXW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:10:40 INFO - Running setup.py (path:/tmp/pip-G6lJRF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:10:40 INFO - Running setup.py (path:/tmp/pip-NVA3o3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:10:40 INFO - Running setup.py (path:/tmp/pip-RBAaiM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:10:40 INFO - Running setup.py (path:/tmp/pip-RsncLb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:10:40 INFO - Running setup.py (path:/tmp/pip-fhAV2Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:10:40 INFO - Running setup.py (path:/tmp/pip-sLlMVJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:10:40 INFO - Running setup.py (path:/tmp/pip-5ZPw51-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:10:40 INFO - Running setup.py (path:/tmp/pip-zbVgbt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:10:40 INFO - Running setup.py (path:/tmp/pip-LElHc8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:10:40 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)) 03:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:10:40 INFO - Running setup.py (path:/tmp/pip-2pyULO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:10:41 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)) 03:10:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:10:41 INFO - Running setup.py (path:/tmp/pip-Lye0Xd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:10:41 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)) 03:10:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:10:41 INFO - Running setup.py (path:/tmp/pip-JTY1Ol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:10:41 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)) 03:10:41 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)) 03:10:41 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)) 03:10:41 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)) 03:10:41 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)) 03:10:41 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)) 03:10:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:42 INFO - Downloading blessings-1.6.tar.gz 03:10:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:10:43 INFO - Installing collected packages: blessings 03:10:43 INFO - Running setup.py install for blessings 03:10:43 INFO - Successfully installed blessings 03:10:43 INFO - Cleaning up... 03:10:43 INFO - Return code: 0 03:10:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:10:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:10:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:10:43 INFO - Reading from file tmpfile_stdout 03:10:43 INFO - Current package versions: 03:10:43 INFO - argparse == 1.2.1 03:10:43 INFO - blessings == 1.6 03:10:43 INFO - blobuploader == 1.2.4 03:10:43 INFO - docopt == 0.6.1 03:10:43 INFO - manifestparser == 1.1 03:10:43 INFO - mozInstall == 1.12 03:10:43 INFO - mozcrash == 0.17 03:10:43 INFO - mozdebug == 0.1 03:10:43 INFO - mozdevice == 0.48 03:10:43 INFO - mozfile == 1.2 03:10:43 INFO - mozhttpd == 0.7 03:10:43 INFO - mozinfo == 0.9 03:10:43 INFO - mozleak == 0.1 03:10:43 INFO - mozlog == 3.1 03:10:43 INFO - moznetwork == 0.27 03:10:43 INFO - mozprocess == 0.22 03:10:43 INFO - mozprofile == 0.28 03:10:43 INFO - mozrunner == 6.11 03:10:43 INFO - mozscreenshot == 0.1 03:10:43 INFO - mozsystemmonitor == 0.0 03:10:43 INFO - moztest == 0.7 03:10:43 INFO - mozversion == 1.4 03:10:43 INFO - psutil == 3.1.1 03:10:43 INFO - requests == 1.2.3 03:10:43 INFO - wsgiref == 0.1.2 03:10:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:10:43 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')]} 03:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:43 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')]} 03:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:43 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 0x7f2814b7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633920>, '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 0x2634820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', '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 03:10:43 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 03:10:43 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 03:10:43 INFO - Using env: {'DISPLAY': ':0', 03:10:43 INFO - 'HOME': '/home/cltbld', 03:10:43 INFO - 'LANG': 'en_US.UTF-8', 03:10:43 INFO - 'LANGUAGE': 'en_US:en', 03:10:43 INFO - 'LOGNAME': 'cltbld', 03:10:43 INFO - 'MAIL': '/var/mail/cltbld', 03:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:43 INFO - 'MOZ_NO_REMOTE': '1', 03:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:43 INFO - 'NO_EM_RESTART': '1', 03:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:10:43 INFO - 'PWD': '/builds/slave/test-pgo', 03:10:43 INFO - 'SHELL': '/bin/bash', 03:10:43 INFO - 'SHLVL': '1', 03:10:43 INFO - 'TERM': 'linux', 03:10:43 INFO - 'TMOUT': '86400', 03:10:43 INFO - 'USER': 'cltbld', 03:10:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', 03:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:43 INFO - '_': '/tools/buildbot/bin/python'} 03:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:43 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)) 03:10:43 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)) 03:10:43 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)) 03:10:43 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)) 03:10:43 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)) 03:10:43 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)) 03:10:43 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)) 03:10:43 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)) 03:10:43 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)) 03:10:43 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)) 03:10:43 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)) 03:10:43 INFO - Cleaning up... 03:10:43 INFO - Return code: 0 03:10:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:10:43 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')]} 03:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:43 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')]} 03:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:43 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 0x7f2814b7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633920>, '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 0x2634820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', '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 03:10:43 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 03:10:43 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 03:10:43 INFO - Using env: {'DISPLAY': ':0', 03:10:43 INFO - 'HOME': '/home/cltbld', 03:10:43 INFO - 'LANG': 'en_US.UTF-8', 03:10:43 INFO - 'LANGUAGE': 'en_US:en', 03:10:43 INFO - 'LOGNAME': 'cltbld', 03:10:43 INFO - 'MAIL': '/var/mail/cltbld', 03:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:43 INFO - 'MOZ_NO_REMOTE': '1', 03:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:43 INFO - 'NO_EM_RESTART': '1', 03:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:10:43 INFO - 'PWD': '/builds/slave/test-pgo', 03:10:43 INFO - 'SHELL': '/bin/bash', 03:10:43 INFO - 'SHLVL': '1', 03:10:43 INFO - 'TERM': 'linux', 03:10:43 INFO - 'TMOUT': '86400', 03:10:43 INFO - 'USER': 'cltbld', 03:10:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', 03:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:43 INFO - '_': '/tools/buildbot/bin/python'} 03:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:43 INFO - Downloading/unpacking jsonschema 03:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:10:45 INFO - Downloading/unpacking functools32 (from jsonschema) 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:45 INFO - Downloading functools32-3.2.3-2.tar.gz 03:10:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:10:45 INFO - warning: no files found matching '*.txt' 03:10:45 INFO - no previously-included directories found matching 'build' 03:10:45 INFO - no previously-included directories found matching 'dist' 03:10:45 INFO - no previously-included directories found matching '.git*' 03:10:45 INFO - Installing collected packages: jsonschema, functools32 03:10:46 INFO - Running setup.py install for functools32 03:10:46 INFO - warning: no files found matching '*.txt' 03:10:46 INFO - no previously-included directories found matching 'build' 03:10:46 INFO - no previously-included directories found matching 'dist' 03:10:46 INFO - no previously-included directories found matching '.git*' 03:10:46 INFO - Successfully installed jsonschema functools32 03:10:46 INFO - Cleaning up... 03:10:46 INFO - Return code: 0 03:10:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2814b7ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2633920>, '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 0x2634820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', '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 03:10:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 03:10:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:10:46 INFO - Using env: {'DISPLAY': ':0', 03:10:46 INFO - 'HOME': '/home/cltbld', 03:10:46 INFO - 'LANG': 'en_US.UTF-8', 03:10:46 INFO - 'LANGUAGE': 'en_US:en', 03:10:46 INFO - 'LOGNAME': 'cltbld', 03:10:46 INFO - 'MAIL': '/var/mail/cltbld', 03:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:46 INFO - 'MOZ_NO_REMOTE': '1', 03:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:46 INFO - 'NO_EM_RESTART': '1', 03:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:10:46 INFO - 'PWD': '/builds/slave/test-pgo', 03:10:46 INFO - 'SHELL': '/bin/bash', 03:10:46 INFO - 'SHLVL': '1', 03:10:46 INFO - 'TERM': 'linux', 03:10:46 INFO - 'TMOUT': '86400', 03:10:46 INFO - 'USER': 'cltbld', 03:10:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', 03:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:46 INFO - '_': '/tools/buildbot/bin/python'} 03:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:46 INFO - Downloading/unpacking flake8 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:10:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:10:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:10:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:10:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:10:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:10:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:10:48 INFO - no previously-included directories found matching 'docs/_build' 03:10:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:10:48 INFO - Running setup.py install for pep8 03:10:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:10:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:10:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:10:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:10:49 INFO - no previously-included directories found matching 'docs/_build' 03:10:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:10:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:10:49 INFO - Cleaning up... 03:10:49 INFO - Return code: 0 03:10:49 INFO - Running post-action listener: _resource_record_post_action 03:10:49 INFO - Running post-action listener: _start_resource_monitoring 03:10:49 INFO - Starting resource monitoring. 03:10:49 INFO - ##### 03:10:49 INFO - ##### Running install step. 03:10:49 INFO - ##### 03:10:49 INFO - Running pre-action listener: _resource_record_pre_action 03:10:49 INFO - Running main action method: install 03:10:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:10:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:10:49 INFO - Reading from file tmpfile_stdout 03:10:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:10:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:10:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:10:49 INFO - Reading from file tmpfile_stdout 03:10:49 INFO - Output received: 03:10:49 INFO - Usage: mozinstall [options] installer 03:10:49 INFO - Options: 03:10:49 INFO - -h, --help show this help message and exit 03:10:49 INFO - -d DEST, --destination=DEST 03:10:49 INFO - Directory to install application into. [default: 03:10:49 INFO - "/builds/slave/test-pgo"] 03:10:49 INFO - --app=APP Application being installed. [default: firefox] 03:10:49 INFO - mkdir: /builds/slave/test-pgo/build/application 03:10:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:10:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:11:05 INFO - Reading from file tmpfile_stdout 03:11:05 INFO - Output received: 03:11:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:11:05 INFO - Running post-action listener: _resource_record_post_action 03:11:05 INFO - ##### 03:11:05 INFO - ##### Running run-tests step. 03:11:05 INFO - ##### 03:11:05 INFO - Running pre-action listener: _resource_record_pre_action 03:11:05 INFO - Running main action method: run_tests 03:11:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:11:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:11:05 INFO - Python 2.7.3 03:11:05 INFO - Return code: 0 03:11:05 INFO - grabbing minidump binary from tooltool 03:11: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')]} 03:11: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 0x2633920>, '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 0x2634820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2634cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:11: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 03:11: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 03:11:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:11:05 INFO - Return code: 0 03:11:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:11:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:11:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:11:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:11:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:11:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:11:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:11:06 INFO - Return code: 0 03:11:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 03:11:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 03:11:06 INFO - Using env: {'DISPLAY': ':0', 03:11:06 INFO - 'HOME': '/home/cltbld', 03:11:06 INFO - 'LANG': 'en_US.UTF-8', 03:11:06 INFO - 'LANGUAGE': 'en_US:en', 03:11:06 INFO - 'LOGNAME': 'cltbld', 03:11:06 INFO - 'MAIL': '/var/mail/cltbld', 03:11:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:11:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:06 INFO - 'MOZ_NO_REMOTE': '1', 03:11:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:06 INFO - 'NO_EM_RESTART': '1', 03:11:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:11:06 INFO - 'SHELL': '/bin/bash', 03:11:06 INFO - 'SHLVL': '1', 03:11:06 INFO - 'TERM': 'linux', 03:11:06 INFO - 'TMOUT': '86400', 03:11:06 INFO - 'USER': 'cltbld', 03:11:06 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034', 03:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:06 INFO - '_': '/tools/buildbot/bin/python'} 03:11:06 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:11:06 INFO - mozversion application_buildid: 20160308043045 03:11:06 INFO - mozversion application_changeset: 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 03:11:06 INFO - mozversion application_display_name: Nightly 03:11:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:11:06 INFO - mozversion application_name: Firefox 03:11:06 INFO - mozversion application_remotingname: firefox 03:11:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:11:06 INFO - mozversion application_vendor: Mozilla 03:11:06 INFO - mozversion application_version: 48.0a1 03:11:06 INFO - mozversion platform_buildid: 20160308043045 03:11:06 INFO - mozversion platform_changeset: 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 03:11:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:11:06 INFO - mozversion platform_version: 48.0a1 03:11:06 INFO - using testdate: 1457521866 03:11:06 INFO - actual date: 1457521866 03:11:06 INFO - starting webserver on 'localhost:42863' 03:11:06 INFO - SUITE-START | Running 2 tests 03:11:06 INFO - TEST-START | dromaeo_css 03:11:06 INFO - operating with platform_type : linux_ 03:11:06 INFO - Initialising browser for dromaeo_css test... 03:11:06 INFO - TEST-INFO | started process 22263 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGHBA74/profile http://localhost:42863/getInfo.html) 03:11:10 INFO - PROCESS | 22263 | __metrics Screen width/height:1600/1200 03:11:10 INFO - PROCESS | 22263 | colorDepth:24 03:11:10 INFO - PROCESS | 22263 | Browser inner width/height: 1024/697 03:11:10 INFO - PROCESS | 22263 | __metrics 03:11:12 INFO - PROCESS | 22263 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:11:12 INFO - TEST-INFO | 22263: exit 0 03:11:12 INFO - Browser initialized. 03:11:12 INFO - Running cycle 1/1 for dromaeo_css test... 03:11:12 INFO - TEST-INFO | started process 22358 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGHBA74/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:24 INFO - PROCESS | 22358 | RSS: Main: 157175808 03:11:24 INFO - PROCESS | 22358 | 03:12:16 INFO - PROCESS | 22358 | 1457521936247 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] 03:14:24 INFO - PROCESS | 22358 | Cycle 1(1): loaded http://localhost:42863/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42863/tests/dromaeo/cssquery-ext.html) 03:14:25 INFO - PROCESS | 22358 | RSS: Main: 277299200 03:14:25 INFO - PROCESS | 22358 | 03:17:27 INFO - PROCESS | 22358 | Cycle 1(1): loaded http://localhost:42863/tests/dromaeo/cssquery-ext.html (next: http://localhost:42863/tests/dromaeo/cssquery-jquery.html) 03:17:28 INFO - PROCESS | 22358 | RSS: Main: 246272000 03:17:28 INFO - PROCESS | 22358 | 03:20:30 INFO - PROCESS | 22358 | Cycle 1(1): loaded http://localhost:42863/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42863/tests/dromaeo/cssquery-mootools.html) 03:20:31 INFO - PROCESS | 22358 | RSS: Main: 242597888 03:20:31 INFO - PROCESS | 22358 | 03:23:32 INFO - PROCESS | 22358 | Cycle 1(1): loaded http://localhost:42863/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42863/tests/dromaeo/cssquery-prototype.html) 03:23:33 INFO - PROCESS | 22358 | RSS: Main: 221593600 03:23:33 INFO - PROCESS | 22358 | 03:26:36 INFO - PROCESS | 22358 | Cycle 1(1): loaded http://localhost:42863/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42863/tests/dromaeo/cssquery-yui.html) 03:26:36 INFO - PROCESS | 22358 | RSS: Main: 227565568 03:26:36 INFO - PROCESS | 22358 | 03:29:39 INFO - PROCESS | 22358 | Cycle 1(1): loaded http://localhost:42863/tests/dromaeo/cssquery-yui.html (next: http://localhost:42863/tests/dromaeo/cssquery-dojo.html) 03:29:39 INFO - PROCESS | 22358 | RSS: Main: 298864640 03:29:39 INFO - PROCESS | 22358 | 03:29:39 INFO - PROCESS | 22358 | __start_tp_report 03:29:39 INFO - PROCESS | 22358 | _x_x_mozilla_page_load 03:29:39 INFO - PROCESS | 22358 | _x_x_mozilla_page_load_details 03:29:39 INFO - PROCESS | 22358 | |i|pagename|runs| 03:29:39 INFO - PROCESS | 22358 | |0;dojo.html;3089.382123575285;3114.4394009078355;3121.5005599104147;3136.984315078424;3163.01946396617;5097.311862898512;5118.181091025437;5124.820631277906;5159.71621560814;5258.684478931257;5214.478552144793;5233.1103712368895;5261.8947621047555;5278.181881808317;5280.023195708796;4793.32893394925;4803.135435621587;4837.129316722989;4863.975680121612;4879.780409881564;4710.081534100852;4813.855584332476;4832.226843705008;4871.829485967992;4895.0944075346;4787.13831510328;4807.206810876201;4818.180909245437;4821.7589120543835;4870.561649451549;4781.306710526954;4786.305985632064;4801.783919723586;4805.591524720403;4816.446108697474;4698.976505117486;4772.308015337757;4775.5463230993;4792.544708252711;4821.059893320804;5075.923861142086;5103.489651034867;5109.105906466353;5119.923201151985;5120.385553733576;5584.664920104807;5636.605437619368;5647;5673.290838645169;5682.034054210794;5592.161175823619;5593.608447408683;5603.887922241533;5609.35492418373;5657.603967722261;5251.894962100775;5253.789848406059;5254.238135470336;5258.894822103536;5268.525832675039;5565.30433695788;5651.547876169897;5697.914531282034;5700.6009579329875;5744;5568.443155684399;5611.551075913917;5612.663240205601;5618.410066942994;5621.297337832771;5684;5688.914666280009;5693.430656934273;5696.458836410535;5698.601097923106;5452.863678407992;5625.6905870176715;5675.4324567543745;5698.202251684767;5721.914171287434;5658.943410565924;5659.037963546207;5662.68855212959;5667.574931880125;5671.17767923657;4283.357496375506;4369.847055353048;4375.124975005012;4380.189664912002;4417.072414792865;3895.2599006188734;3936.173403585222;3954.426608141803;3959.2279505496726;3978.6618137458063;5236.659617124875;5252.65857719247;5253.868653283622;5258.8948221036135;5259.474052594786;5573.554115670737;5587.217789509472;5634.7182640867795;5639.295088113986;5688.317401911797;5209.661372010807;5232.189010703347;5233.712145832016;5239.318888544541;5285.550728188147;4760.357351757538;4763.237881938873;4764.30917516965;4771.594414474739;4807.134715751198;5722.599418040697;5819.981503236917;5820.679862607512;5894.557908156906;5991.251093613386;5594.888102237851;5606.187102870143;5613.438656134354;5613.887722245614;5653.717314134359;5821.417858214145;5821.563382746226;5822.475977162076;5822.7670893163795;5826.796062137805;5460.290162278879;5538.972305138448;5570.721463926869;5629.634073785354;5664;5654.321481422256;5658.688772117573;5697.943020569907;5703.458171473703;5706;5523.8066667666435;5529.585281104014;5555.3611334697025;5556.027695153412;5557.610967232416;5445.26488924006;5510.173473978775;5572.916406253828;5578.888422231614;5623.578231632562;5379;5414.918776218438;5419.105847535113;5423.132298832168;5428.83713488596;5385.892282154413;5516.641418307797;5528.032594295902;5533.197686335378;5551.583631227755;5323.866903327448;5401.405845356929;5425.294711687613;5461.699606521679;5508.173773933942 03:29:39 INFO - PROCESS | 22358 | |1;ext.html;496.42166875589936;504.153022921492;509.41162956784916;522.6472131311366;547.2529996554704;28931;37925.810370948144;38595.22809543811;38622.42066369;38709;42014.579854201445;42258.788706056504;42353.7882310588;42518.362224566656;42526.574734252725;8568.700095496642;8770.824583508325;8775.166359195866;8778.2099611035;8781.560921953876;8542.44474109184;8668.783280417976;8672.653093876268;8674.739757807276;8681.82636347276;8626.439281446717;8937.642494300253;8943.239824614915;8943.731688049369;8947.552622368856;8772.517511536864;8805.295576353876;8881.200691937756;8910.465372077697;8914.197722204968;8610.268127209194;8760.780980475476;8763.649454021896;8788.692395766182;8825.735227943107;41115.177696445906;41497.585024149674;41499.7925010373;41512.792436037926;41520.584794151975;3249.658785827478;3331.3337332533592;3379.459286514146;3476.0788391076385;3687.2625474905126;30711.38577228465;30909.536356954664;30936.845315773277;31013.534796978063;31060.689393106004;3705.1292946157632;3741.4761933329355;3883.8834834954996;3913.9217215655526;3918.784466854322;272419;273165;273600;273758;273862;59046;59384;59500;59500.40499594949;59650.70174649186;61294.38705612976;61647.691761540904;61654.69172654108;61780.69109654513;61814.381856180866;15499.225038748018;16090.919545402432;16407.671846563;16407.91796041036;16429.424970125987;11208.27146235492;11233.213675042833;11239.157063220127;11276.887231127748;11278.492467838803;20600.690989635168;20807.58384832295;21055;21097.156113755584;21136.577268454854;7984.520928744294;8191.385646076568;8212.425130240827;8237.734622978609;8606.741797746077;909.5588639509832;971.7376308396694;1002.6490728245202;1053.0732954999705;1060.0936199549428;28648.427031459254;28788.568171477444;28807;29141.56287655687;29195.708042919723;1053.899879511445;1074.7742973975553;1089.515165751249;1110.8444817725524;1118.0887576625025;14753.77869331961;15013.924930375279;15083.4720784772;15366.462173823862;15373.308201130976;339159;488090;495994;496134;496159;55661.16508252299;56125.71937140288;56633.71683141558;56638.7168064157;56654.716726416926;1249.194269696041;1397.8741913227655;1411.2379315169694;1418.822647169104;1468.6328417895527;28755.712442875305;31148.68851311458;31319;31585.461854944733;31661;44002.33996490119;44360.55639443564;44661;44690;44724;202712;203584;203590;203917;219772;27963.580546291414;31518;33347.83326083354;33756;33803.15492112717;41990.79004604957;52394.73802630963;52481.47518524766;53287.733561331945;54269.72865135649;38072.27957512948;38266;38594.61405386023;39098.804505977285;39705.60294397019;38195.23609527738;41509.58490415057;42446;42505.96193361626;42568.57431425646;37483.43774843434;37881;38467.80766096152;38733.03167420725;38964.80517597394;33618.49572256369;34875.107321845615;35104.648953510135;35421.46867797037;35793.642063580075;26542.734572654026;27144;27331.863340683965;28266.561084853296;28852.278693032844 03:29:39 INFO - PROCESS | 22358 | |2;jquery.html;346.17955445593947;353.99823000884993;356.4813196798658;364.62443683006495;365.1018494503521;16523.75214371784;16823.747643785337;16935.3225870965;17305.82694173058;17506.912465437672;15433.151176685278;15812.683746325067;17021.40425085122;17022.659546809056;17039.233234504445;5264.447233040533;5334.786608535664;5452.073147564904;6102.694865256742;6104.9389506105035;6050.757969681207;6068.27180738312;6087.908681369783;6091.177691011723;6112.266528016644;5871.9412805871825;5973.402659734035;6140.53945954053;6159.661218632973;6159.7536098556;5989.610675306091;6003.159557661931;6014.12795144706;6026.5178785697035;6034.5172386209;5195.636305458619;5207.791688332462;5321.760520776575;5337.226102215157;5338.332708411449;19302;19827.40517784469;20076.498087547927;20134.69797953032;20169.0923908423;1956.8238858502802;2018.3036852285938;2326.8836558172025;2340.6372012337943;2609.4781043791318;12642.178258413174;12736.36318184087;12824.615261542169;13133.408996595175;13555.796663050061;1744.9127543622767;1769.840714335716;1806.1872157529165;1807.7830660320715;1822.1982327775868;43365.56634433647;54468.91062178774;55412;57599;59254.11118833221;8753.343499237582;9453.90546094544;9490.667826626035;9615;9809.166220871306;12684.80972785409;12699.809502857464;12753.426095825711;12797.104202705721;12805.807912881315;7110;7184.568925864361;7216.134063912364;7278.642163915281;7368.668409921459;6734.46124310054;6778.118844550276;6826.385625293748;6895.965520172467;6916.273791251947;5806.1581070744505;5968.104784282305;5979.1629171915965;6046.365131661112;6064.514838812885;1731.2988239762665;1755.385615034753;1763.6649036682988;1794.443722446046;1816.5186225650214;923.2014307623991;925.3753716241511;928.1924725488868;938.9624415023322;1087.722630729159;16451.83548164503;16965.91517042407;17047.31810727557;17159.227834747468;17241;837.4012581004611;921.1525396635112;950.2160717408028;992.0773680477081;1007.6120693533043;10014.449205293633;10081.19350451962;10152.593896244216;10198.33710808795;10361.222908281909;384764;424373;432357;432527;435911;76979;77015.61492192616;78150.6092469534;80202;82975;990.2127808392345;1013.7516308504316;1041.5573381313063;1042.8122937871103;1043.2957753516498;14915.627109322353;15110.697786044437;15284.15937123469;15379.615834574943;15666.608334791721;27202.863985679945;28012.579811303254;28867;32377;34856.47715284222;37404.625953741204;38440.42339364856;38866.805665971486;39192.60807392003;39388.21223575455;7501.174870764321;7522.059742532184;7536.24637536242;7601.733939312097;7652.73215437457;12356.691082723004;12545.560905368267;12565.811512827133;12626.36868156607;12942.288174150512;10037.297389182688;10881.891181088087;11057.944710276397;11377.203595748219;11391;10521.947390263305;10523.736906577396;10869.836952445878;10921.453927303444;10949.890501094887;11038.00657940757;11075.501602427748;11154.442277886235;11196.654974378187;11385.699035228648;7592.81017974555;7625.961870190614;7705.922940770744;7770.766876993699;8148;8283.668653253802;10750.408727519749;10900.672979810619;11083.556657733601;11261.042811360798 03:29:39 INFO - PROCESS | 22358 | |3;mootools.html;1366.4124426496603;1502.556745760001;1510.335452400944;1686.4013275287273;1857.8885266883988;7672.424568157389;7859.056913170421;7886.921130788691;7888.723894663688;7900.644470998797;7691.576963267018;7864.213578642133;7867.645955931983;7891.684332626688;7895.486793358427;1967.616314818611;2238.272561417538;2281.0761641535205;2303.6544518322216;2309.3072078376504;2286;2308.0998410619873;2314.67594536765;2318.211807985285;2323.53529294141;2227.8217742580637;2314.618088015475;2315.780000899912;2315.9652605210936;2318.802901753353;2240.215924426454;2266.4900397410534;2280.315905228425;2282.7032485776826;2284.8743319117443;2213.7786221377733;2239.8432109752325;2244.371575958734;2246.7753224677563;2249.9775002250094;8051.879221811619;8110.553919534424;8121.269085782249;8141.104478507359;8141.715039973632;4794.232922732346;4875.341828853095;4915.410150781893;4916.0905232532095;4916.164252077156;3177.666345033784;3185.5221716742444;3239.9352012959844;3249.8700051997894;3310.8013519188926;975.8731364922586;982.3614650477175;1002.3935519010967;1010.7523656704082;1019.306871327497;11319.773604527945;11344.716382090348;11352.205345625809;11357.772844543062;11358.94320528392;4247.532771395144;4407.206702793464;4466.798994045275;4470.418845550123;4490.528494508095;9489.66786162481;9577.616895324109;9605.087516685904;9608.375455595364;9613.567389467491;4329.415528903558;4792.0895029944195;4804.567588916944;4805.567498925044;4809.831655892027;4248.787560621957;4319.870403887889;4336.176126535948;4375.518692943773;4376.562343765661;3695.5565332159777;3773.9433908491396;3781.5840257571645;3809.504764380613;3846.288436639231;1171.6133675886938;1191.2911817468591;1196.9820452693216;1208;1227.4660522672666;1043.4886905416292;1052.8210204265292;1062.123747907979;1218.7379713361493;1378.9655258618616;7563.9621801891735;7662.846743065107;7708.421868359784;7716.42126840478;7725.961370193113;470.80696914264985;486.365293292257;490.9828156014522;492.4189456441434;492.93345398370764;5574.9721251393485;5677.943220567824;5687.260656114761;5689.487946084872;5705.600607957486;9189.632414703337;9190.90809091914;9216.400933939272;9272.258219342437;9359.017303183204;9117.908820911838;9127.77180570491;9210.447373157633;9263.073692630818;9274.814503709888;7544.849103017909;7611;7673.961630191813;7678.270564296383;7756.806079848049;7389.630518473948;7443.069616297963;7444.218357072429;7445.255474452511;7447.851042979219;8208.753737387888;8249.340052795882;8373.58132093405;8508.319334453352;8588.22705956467;8427.831443370975;8557.614907329309;8735.912640873765;8754.51850148248;8770.780730481789;5842.649441033552;6701.798946031627;6824.965875170592;6828.044073829568;6993.510454268152;7583.582902940391;7586.051743532059;7615.619219039137;7633.923660763321;7645.426593005435;6566.6388348641285;6717.462602991846;6733.494987875831;6769;6863.279355667583;6583.242927063449;6604.240512341143;6608.4052435281055;6687.230968438692;6837.1111755471475;6885.139357580302;6904.206016308189;6949.096617439903;6954.756583519553;6959.0257363970095;6561.081448597105;6592.637404942774;6629.138212032405;6648.1025061616065;6653.367930046637;6628.204615446178;6683.933160668331;6708.094407254958;6709.429698475489;6710.060591517094 03:29:39 INFO - PROCESS | 22358 | |4;prototype.html;316.88275338124896;328.87667124828187;331.9684629960153;335.4967548676984;339.43484098975193;5875.853103672411;5883.058710606304;5908.261467316585;5923.407659234074;5937.67342796146;5807.912881306784;5855.385184555625;5861.120831875221;5869.442402971711;5873.650539784088;4293.184294983943;4375.584319489643;4412.3160910059;4472.1502914446155;4524.434445694288;4470.26240670289;4470.910581788362;4478.149151661174;4497.527759585246;4506.053728716957;4455.420795296607;4458.821647134111;4460.219461594224;4468.285074388098;4474.552544745532;4266.552012038738;4397.670174736908;4472.262076757331;4526.841560545398;4531.932021019687;3942.329803933338;3947.960520394788;3951.920961580781;3966.3852102923806;3970;5569.749361278712;5578.86052848682;5588.105903055492;5590.413006634326;5592.5246354059955;5265.183896496049;5272.472752724735;5275.762590683428;5276.182191760283;5281.8151364702435;6206.131141640174;6226.688665566749;6236.189295391616;6246.906296405557;6276.152719382871;4251.638610718092;4358.237308471036;4370.147821174841;4414.1171765647;4417.558244175589;6245.843853903643;6264;6283.340249273851;6348.492120630339;6384.904226436561;4436.6672499562665;4438.201123797683;4440.178566965122;4441.200583894865;4450.265706158448;4487.887802804956;4499.437570303712;4502.099580083996;4503.504614492404;4514.164879497303;5149.253358263031;5159.948400516022;5163.483651634807;5163.715995620202;5166;6044.758209671564;6166.167567378437;6172.567920245539;6189.81430557084;6191.226096737908;1589.0386316278716;1602.3190144188673;1609.2114863716695;1609.903405795656;1613.1692178528067;990.1089019882164;1061.368485750977;1061.946902654864;1072.0458791675414;1086.1853609792656;5814.447627475383;5821.446962538552;5825.825225243249;5877.500412464989;5893.233879595711;6363.172787537591;6371.617702937839;6372.681365931778;6394;6397.488200943913;5884.382139875337;5885.5585831062845;5887.116932460165;5892.646441213541;5893.057110862242;3369.713574346159;3392.0332705178907;3392.1519620094978;3394.0496660934978;3394.6775056369606;6461.224653041571;6542.21493420783;6557.573757705733;6783.491238157158;6812.943993680988;6556.147700798866;6639.136912201479;6641.933580664228;6662.633555154416;6718.160229971254;6824.556403833735;6829.965850170717;6830.146231721035;6832.658367081626;6835.4189893859575;6486.027095935648;6486.675666216576;6494.6103233806125;6555.737770489318;6561.40947314744;6214.533909956681;6402.743890244338;6404.039394090923;6405.295417504164;6417.48660107181;6749.763758268437;6764.3573860483175;6776.830579235559;6781.254062053269;6794.558353706993;4322.740635561876;4334.523202447791;4350.891227719332;4351.216780979454;4357.8256869724855;6492.610443373413;6498.187726534184;6498.220213574401;6498.610083395011;6500.772472963424;6279.874402511833;6286;6292.2449306081735;6292.370762923671;6303.432691057827;6122.357152498924;6276.058591211355;6285.874282514415;6287.654179020198;6288.402601752826;6144.969275153596;6159.969200153971;6177;6178.938210617836;6187.226596675416;6308.842278943063;6317.178766760292;6318.115463835159;6321.367863213642;6328.303886572566;5908.409159084057;5997.100434934795;6185.783497577743;6198.752049918133;6202.472789812736 03:29:39 INFO - PROCESS | 22358 | |5;yui.html;691.2051141187634;716.949813513054;734.9375303099237;813.6419975210911;822.4736168851936;12856.357182140902;12975.870241297596;12990.61028169154;13040.478380864777;13046.086773925828;12287.877121228807;14148.858511414883;14477.203753793563;14485.78271325931;14487;839.236294971576;840.8822764812932;842.9409941304111;845.1632883445407;847.267113946435;694.3230350408362;837.4807619276057;851.0213254757017;853.7353420439653;854.4318028511033;866.1035827918106;885.4510203673731;889.2263730554427;889.5463313710022;889.6085722282176;716.3409663109951;863.5466380150408;875.9649614015432;881.9426737262057;883.0022075055178;648.2577448821121;654.3358491131505;655.8786624474487;656.0782101147847;656.291205498061;13662.93168534161;14442.638934026629;14461.13233206011;14483.565493035227;14504.202268875208;11794.646160615195;12323.69190770229;12465.127441079128;12479;12584.4337004835;10113.08982191599;10136.949315253376;10219.795604087876;10317.742056448575;10361.171106311476;3476.4090104682264;3511.3679537683206;3551.058969373118;3553.662402071799;3666.651668091527;45384;45622.771886140355;45818.312725309144;45932;46157.76921115407;8997.37018408705;9505;9569.090936361174;9583.712488625353;9878.863930647924;17984.190711418018;18011.369602064126;18020.549486262687;18032.549186270448;18038;6944.583325000516;7048.083749112582;7334.66993985272;7336.559806411632;7416.7774966751085;4003.259397011562;4100.6924480664065;4177.143685544456;4248.129133527619;4297.119090586422;3136.7961082529564;3168.6197656281392;3180.173154979722;3182.8885988990273;3184.188032051812;554.938956714761;561.2479277767729;561.7528287553463;564.8870225954826;593.4658906726161;527.9841604751864;613.8189234175928;621.4841681404423;622.5237693164732;628.6448156791398;7707.113681926538;7797.649105790253;7982.560959147187;8077.83844323122;8361.205685459872;574.2219292858117;597.3339726205337;611.703323887914;616.2297128589263;627.9372062793775;3758.793266370376;3851.422286657024;3933.8033098344968;3987.940180897289;4063.4920634920636;53400.73299633477;53824.19263711048;59341.40658593445;60310.698446507486;60832.695836520536;46896.76551617288;47398.28902566464;47455.5254447458;47871.52128478671;47995.280070798966;43687.344689829675;43898;43922.34116488255;44015.55984440115;44336.77831610821;8365.28895043928;8399.454035487674;8415.663373464993;8472.49165050099;8483.44857584255;32325.51511727373;32909.341813163126;33149.00552983415;33351.49972750362;34226.48660270048;36947.261054779294;39252.80373598228;42164.578354217294;42194.36708449437;42603.36094958516;10796.514156863117;11050.171237157407;11226.943865280948;11518.596849110241;11535.653930382103;11311.830322545004;11398.20212585111;11547.595834145764;11728.41357932117;12056.819147712617;10927.289726167774;11122.666320010412;11154;11448.828267575826;11701.06391488696;10928.344299342065;11058.778824423305;11245.325280483197;11402.94298528502;11445.313281203154;10833.187510936554;11001.339919604849;11146.865876525113;11236.775264494829;11618.477168527268;9542.236621070158;9601.183899368632;9702.369345992487;9724.95137524308;9784.608615655294;8808.91191088081;9524.85712714296;9534;9543.90456095458;9553.474558899326 03:29:39 INFO - PROCESS | 22358 | __end_tp_report 03:29:39 INFO - PROCESS | 22358 | __start_cc_report 03:29:39 INFO - PROCESS | 22358 | _x_x_mozilla_cycle_collect,1010 03:29:39 INFO - PROCESS | 22358 | __end_cc_report 03:29:39 INFO - PROCESS | 22358 | __startTimestamp1457522979739__endTimestamp 03:29:39 INFO - PROCESS | 22358 | 03:29:39 INFO - PROCESS | 22358 | ------- Summary: start ------- 03:29:39 INFO - PROCESS | 22358 | Number of tests: 6 03:29:39 INFO - PROCESS | 22358 | 03:29:39 INFO - PROCESS | 22358 | [#0] dojo.html Cycles:165 Average:5231.74 Median:5425.29 stddev:577.37 (10.6%) stddev-sans-first:554.14 03:29:39 INFO - PROCESS | 22358 | Values: 3089.4 3114.4 3121.5 3137.0 3163.0 5097.3 5118.2 5124.8 5159.7 5258.7 5214.5 5233.1 5261.9 5278.2 5280.0 4793.3 4803.1 4837.1 4864.0 4879.8 4710.1 4813.9 4832.2 4871.8 4895.1 4787.1 4807.2 4818.2 4821.8 4870.6 4781.3 4786.3 4801.8 4805.6 4816.4 4699.0 4772.3 4775.5 4792.5 4821.1 5075.9 5103.5 5109.1 5119.9 5120.4 5584.7 5636.6 5647.0 5673.3 5682.0 5592.2 5593.6 5603.9 5609.4 5657.6 5251.9 5253.8 5254.2 5258.9 5268.5 5565.3 5651.5 5697.9 5700.6 5744.0 5568.4 5611.6 5612.7 5618.4 5621.3 5684.0 5688.9 5693.4 5696.5 5698.6 5452.9 5625.7 5675.4 5698.2 5721.9 5658.9 5659.0 5662.7 5667.6 5671.2 4283.4 4369.8 4375.1 4380.2 4417.1 3895.3 3936.2 3954.4 3959.2 3978.7 5236.7 5252.7 5253.9 5258.9 5259.5 5573.6 5587.2 5634.7 5639.3 5688.3 5209.7 5232.2 5233.7 5239.3 5285.6 4760.4 4763.2 4764.3 4771.6 4807.1 5722.6 5820.0 5820.7 5894.6 5991.3 5594.9 5606.2 5613.4 5613.9 5653.7 5821.4 5821.6 5822.5 5822.8 5826.8 5460.3 5539.0 5570.7 5629.6 5664.0 5654.3 5658.7 5697.9 5703.5 5706.0 5523.8 5529.6 5555.4 5556.0 5557.6 5445.3 5510.2 5572.9 5578.9 5623.6 5379.0 5414.9 5419.1 5423.1 5428.8 5385.9 5516.6 5528.0 5533.2 5551.6 5323.9 5401.4 5425.3 5461.7 5508.2 03:29:39 INFO - PROCESS | 22358 | 03:29:39 INFO - PROCESS | 22358 | [#1] ext.html Cycles:180 Average:49083.76 Median:38608.82 stddev:88601.46 (229.5%) stddev-sans-first:88774.91 03:29:39 INFO - PROCESS | 22358 | Values: 496.4 504.2 509.4 522.6 547.3 28931.0 37925.8 38595.2 38622.4 38709.0 42014.6 42258.8 42353.8 42518.4 42526.6 8568.7 8770.8 8775.2 8778.2 8781.6 8542.4 8668.8 8672.7 8674.7 8681.8 8626.4 8937.6 8943.2 8943.7 8947.6 8772.5 8805.3 8881.2 8910.5 8914.2 8610.3 8760.8 8763.6 8788.7 8825.7 41115.2 41497.6 41499.8 41512.8 41520.6 3249.7 3331.3 3379.5 3476.1 3687.3 30711.4 30909.5 30936.8 31013.5 31060.7 3705.1 3741.5 3883.9 3913.9 3918.8 272419.0 273165.0 273600.0 273758.0 273862.0 59046.0 59384.0 59500.0 59500.4 59650.7 61294.4 61647.7 61654.7 61780.7 61814.4 15499.2 16090.9 16407.7 16407.9 16429.4 11208.3 11233.2 11239.2 11276.9 11278.5 20600.7 20807.6 21055.0 21097.2 21136.6 7984.5 8191.4 8212.4 8237.7 8606.7 909.6 971.7 1002.6 1053.1 1060.1 28648.4 28788.6 28807.0 29141.6 29195.7 1053.9 1074.8 1089.5 1110.8 1118.1 14753.8 15013.9 15083.5 15366.5 15373.3 339159.0 488090.0 495994.0 496134.0 496159.0 55661.2 56125.7 56633.7 56638.7 56654.7 1249.2 1397.9 1411.2 1418.8 1468.6 28755.7 31148.7 31319.0 31585.5 31661.0 44002.3 44360.6 44661.0 44690.0 44724.0 202712.0 203584.0 203590.0 203917.0 219772.0 27963.6 31518.0 33347.8 33756.0 33803.2 41990.8 52394.7 52481.5 53287.7 54269.7 38072.3 38266.0 38594.6 39098.8 39705.6 38195.2 41509.6 42446.0 42506.0 42568.6 37483.4 37881.0 38467.8 38733.0 38964.8 33618.5 34875.1 35104.6 35421.5 35793.6 26542.7 27144.0 27331.9 28266.6 28852.3 03:29:39 INFO - PROCESS | 22358 | 03:29:39 INFO - PROCESS | 22358 | [#2] jquery.html Cycles:180 Average:24567.50 Median:17605.24 stddev:69193.08 (393.0%) stddev-sans-first:69363.29 03:29:39 INFO - PROCESS | 22358 | Values: 346.2 354.0 356.5 364.6 365.1 16523.8 16823.7 16935.3 17305.8 17506.9 15433.2 15812.7 17021.4 17022.7 17039.2 5264.4 5334.8 5452.1 6102.7 6104.9 6050.8 6068.3 6087.9 6091.2 6112.3 5871.9 5973.4 6140.5 6159.7 6159.8 5989.6 6003.2 6014.1 6026.5 6034.5 5195.6 5207.8 5321.8 5337.2 5338.3 19302.0 19827.4 20076.5 20134.7 20169.1 1956.8 2018.3 2326.9 2340.6 2609.5 12642.2 12736.4 12824.6 13133.4 13555.8 1744.9 1769.8 1806.2 1807.8 1822.2 43365.6 54468.9 55412.0 57599.0 59254.1 8753.3 9453.9 9490.7 9615.0 9809.2 12684.8 12699.8 12753.4 12797.1 12805.8 7110.0 7184.6 7216.1 7278.6 7368.7 6734.5 6778.1 6826.4 6896.0 6916.3 5806.2 5968.1 5979.2 6046.4 6064.5 1731.3 1755.4 1763.7 1794.4 1816.5 923.2 925.4 928.2 939.0 1087.7 16451.8 16965.9 17047.3 17159.2 17241.0 837.4 921.2 950.2 992.1 1007.6 10014.4 10081.2 10152.6 10198.3 10361.2 384764.0 424373.0 432357.0 432527.0 435911.0 76979.0 77015.6 78150.6 80202.0 82975.0 990.2 1013.8 1041.6 1042.8 1043.3 14915.6 15110.7 15284.2 15379.6 15666.6 27202.9 28012.6 28867.0 32377.0 34856.5 37404.6 38440.4 38866.8 39192.6 39388.2 7501.2 7522.1 7536.2 7601.7 7652.7 12356.7 12545.6 12565.8 12626.4 12942.3 10037.3 10881.9 11057.9 11377.2 11391.0 10521.9 10523.7 10869.8 10921.5 10949.9 11038.0 11075.5 11154.4 11196.7 11385.7 7592.8 7626.0 7705.9 7770.8 8148.0 8283.7 10750.4 10900.7 11083.6 11261.0 03:29:39 INFO - PROCESS | 22358 | 03:29:39 INFO - PROCESS | 22358 | [#3] mootools.html Cycles:180 Average:5517.34 Median:6574.94 stddev:2911.35 (44.3%) stddev-sans-first:2902.80 03:29:39 INFO - PROCESS | 22358 | Values: 1366.4 1502.6 1510.3 1686.4 1857.9 7672.4 7859.1 7886.9 7888.7 7900.6 7691.6 7864.2 7867.6 7891.7 7895.5 1967.6 2238.3 2281.1 2303.7 2309.3 2286.0 2308.1 2314.7 2318.2 2323.5 2227.8 2314.6 2315.8 2316.0 2318.8 2240.2 2266.5 2280.3 2282.7 2284.9 2213.8 2239.8 2244.4 2246.8 2250.0 8051.9 8110.6 8121.3 8141.1 8141.7 4794.2 4875.3 4915.4 4916.1 4916.2 3177.7 3185.5 3239.9 3249.9 3310.8 975.9 982.4 1002.4 1010.8 1019.3 11319.8 11344.7 11352.2 11357.8 11358.9 4247.5 4407.2 4466.8 4470.4 4490.5 9489.7 9577.6 9605.1 9608.4 9613.6 4329.4 4792.1 4804.6 4805.6 4809.8 4248.8 4319.9 4336.2 4375.5 4376.6 3695.6 3773.9 3781.6 3809.5 3846.3 1171.6 1191.3 1197.0 1208.0 1227.5 1043.5 1052.8 1062.1 1218.7 1379.0 7564.0 7662.8 7708.4 7716.4 7726.0 470.8 486.4 491.0 492.4 492.9 5575.0 5677.9 5687.3 5689.5 5705.6 9189.6 9190.9 9216.4 9272.3 9359.0 9117.9 9127.8 9210.4 9263.1 9274.8 7544.8 7611.0 7674.0 7678.3 7756.8 7389.6 7443.1 7444.2 7445.3 7447.9 8208.8 8249.3 8373.6 8508.3 8588.2 8427.8 8557.6 8735.9 8754.5 8770.8 5842.6 6701.8 6825.0 6828.0 6993.5 7583.6 7586.1 7615.6 7633.9 7645.4 6566.6 6717.5 6733.5 6769.0 6863.3 6583.2 6604.2 6608.4 6687.2 6837.1 6885.1 6904.2 6949.1 6954.8 6959.0 6561.1 6592.6 6629.1 6648.1 6653.4 6628.2 6683.9 6708.1 6709.4 6710.1 03:29:39 INFO - PROCESS | 22358 | 03:29:39 INFO - PROCESS | 22358 | [#4] prototype.html Cycles:180 Average:5215.73 Median:5884.97 stddev:1580.18 (26.9%) stddev-sans-first:1541.24 03:29:39 INFO - PROCESS | 22358 | Values: 316.9 328.9 332.0 335.5 339.4 5875.9 5883.1 5908.3 5923.4 5937.7 5807.9 5855.4 5861.1 5869.4 5873.7 4293.2 4375.6 4412.3 4472.2 4524.4 4470.3 4470.9 4478.1 4497.5 4506.1 4455.4 4458.8 4460.2 4468.3 4474.6 4266.6 4397.7 4472.3 4526.8 4531.9 3942.3 3948.0 3951.9 3966.4 3970.0 5569.7 5578.9 5588.1 5590.4 5592.5 5265.2 5272.5 5275.8 5276.2 5281.8 6206.1 6226.7 6236.2 6246.9 6276.2 4251.6 4358.2 4370.1 4414.1 4417.6 6245.8 6264.0 6283.3 6348.5 6384.9 4436.7 4438.2 4440.2 4441.2 4450.3 4487.9 4499.4 4502.1 4503.5 4514.2 5149.3 5159.9 5163.5 5163.7 5166.0 6044.8 6166.2 6172.6 6189.8 6191.2 1589.0 1602.3 1609.2 1609.9 1613.2 990.1 1061.4 1061.9 1072.0 1086.2 5814.4 5821.4 5825.8 5877.5 5893.2 6363.2 6371.6 6372.7 6394.0 6397.5 5884.4 5885.6 5887.1 5892.6 5893.1 3369.7 3392.0 3392.2 3394.0 3394.7 6461.2 6542.2 6557.6 6783.5 6812.9 6556.1 6639.1 6641.9 6662.6 6718.2 6824.6 6830.0 6830.1 6832.7 6835.4 6486.0 6486.7 6494.6 6555.7 6561.4 6214.5 6402.7 6404.0 6405.3 6417.5 6749.8 6764.4 6776.8 6781.3 6794.6 4322.7 4334.5 4350.9 4351.2 4357.8 6492.6 6498.2 6498.2 6498.6 6500.8 6279.9 6286.0 6292.2 6292.4 6303.4 6122.4 6276.1 6285.9 6287.7 6288.4 6145.0 6160.0 6177.0 6178.9 6187.2 6308.8 6317.2 6318.1 6321.4 6328.3 5908.4 5997.1 6185.8 6198.8 6202.5 03:29:39 INFO - PROCESS | 22358 | 03:29:39 INFO - PROCESS | 22358 | [#5] yui.html Cycles:180 Average:13348.93 Median:45503.39 stddev:15191.61 (33.4%) stddev-sans-first:15204.48 03:29:39 INFO - PROCESS | 22358 | Values: 691.2 716.9 734.9 813.6 822.5 12856.4 12975.9 12990.6 13040.5 13046.1 12287.9 14148.9 14477.2 14485.8 14487.0 839.2 840.9 842.9 845.2 847.3 694.3 837.5 851.0 853.7 854.4 866.1 885.5 889.2 889.5 889.6 716.3 863.5 876.0 881.9 883.0 648.3 654.3 655.9 656.1 656.3 13662.9 14442.6 14461.1 14483.6 14504.2 11794.6 12323.7 12465.1 12479.0 12584.4 10113.1 10136.9 10219.8 10317.7 10361.2 3476.4 3511.4 3551.1 3553.7 3666.7 45384.0 45622.8 45818.3 45932.0 46157.8 8997.4 9505.0 9569.1 9583.7 9878.9 17984.2 18011.4 18020.5 18032.5 18038.0 6944.6 7048.1 7334.7 7336.6 7416.8 4003.3 4100.7 4177.1 4248.1 4297.1 3136.8 3168.6 3180.2 3182.9 3184.2 554.9 561.2 561.8 564.9 593.5 528.0 613.8 621.5 622.5 628.6 7707.1 7797.6 7982.6 8077.8 8361.2 574.2 597.3 611.7 616.2 627.9 3758.8 3851.4 3933.8 3987.9 4063.5 53400.7 53824.2 59341.4 60310.7 60832.7 46896.8 47398.3 47455.5 47871.5 47995.3 43687.3 43898.0 43922.3 44015.6 44336.8 8365.3 8399.5 8415.7 8472.5 8483.4 32325.5 32909.3 33149.0 33351.5 34226.5 36947.3 39252.8 42164.6 42194.4 42603.4 10796.5 11050.2 11226.9 11518.6 11535.7 11311.8 11398.2 11547.6 11728.4 12056.8 10927.3 11122.7 11154.0 11448.8 11701.1 10928.3 11058.8 11245.3 11402.9 11445.3 10833.2 11001.3 11146.9 11236.8 11618.5 9542.2 9601.2 9702.4 9725.0 9784.6 8808.9 9524.9 9534.0 9543.9 9553.5 03:29:39 INFO - PROCESS | 22358 | -------- Summary: end -------- 03:29:39 INFO - PROCESS | 22358 | 03:29:40 INFO - TEST-INFO | 22358: exit 0 03:29:40 INFO - TEST-OK | dromaeo_css | took 1113719ms 03:29:40 INFO - TEST-START | kraken 03:29:40 INFO - operating with platform_type : linux_ 03:29:40 INFO - Initialising browser for kraken test... 03:29:40 INFO - TEST-INFO | started process 22549 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphzjI8m/profile http://localhost:42863/getInfo.html) 03:29:44 INFO - PROCESS | 22549 | __metrics Screen width/height:1600/1200 03:29:44 INFO - PROCESS | 22549 | colorDepth:24 03:29:44 INFO - PROCESS | 22549 | Browser inner width/height: 1024/697 03:29:44 INFO - PROCESS | 22549 | __metrics 03:29:45 INFO - PROCESS | 22549 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:29:46 INFO - TEST-INFO | 22549: exit 0 03:29:46 INFO - Browser initialized. 03:29:46 INFO - Running cycle 1/1 for kraken test... 03:29:46 INFO - TEST-INFO | started process 22634 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphzjI8m/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:58 INFO - PROCESS | 22634 | RSS: Main: 156569600 03:29:58 INFO - PROCESS | 22634 | 03:30:00 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42863/tests/kraken/driver.html?testName=audio-beat-detection) 03:30:01 INFO - PROCESS | 22634 | RSS: Main: 199704576 03:30:01 INFO - PROCESS | 22634 | 03:30:04 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42863/tests/kraken/driver.html?testName=audio-dft) 03:30:04 INFO - PROCESS | 22634 | RSS: Main: 189284352 03:30:04 INFO - PROCESS | 22634 | 03:30:07 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42863/tests/kraken/driver.html?testName=audio-fft) 03:30:08 INFO - PROCESS | 22634 | RSS: Main: 172261376 03:30:08 INFO - PROCESS | 22634 | 03:30:10 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42863/tests/kraken/driver.html?testName=audio-oscillator) 03:30:10 INFO - PROCESS | 22634 | RSS: Main: 173314048 03:30:10 INFO - PROCESS | 22634 | 03:30:13 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42863/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:30:13 INFO - PROCESS | 22634 | RSS: Main: 175366144 03:30:13 INFO - PROCESS | 22634 | 03:30:16 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42863/tests/kraken/driver.html?testName=imaging-darkroom) 03:30:17 INFO - PROCESS | 22634 | RSS: Main: 176160768 03:30:17 INFO - PROCESS | 22634 | 03:30:20 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42863/tests/kraken/driver.html?testName=imaging-desaturate) 03:30:21 INFO - PROCESS | 22634 | RSS: Main: 178016256 03:30:21 INFO - PROCESS | 22634 | 03:30:24 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42863/tests/kraken/driver.html?testName=json-parse-financial) 03:30:24 INFO - PROCESS | 22634 | RSS: Main: 176271360 03:30:24 INFO - PROCESS | 22634 | 03:30:26 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42863/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:30:26 INFO - PROCESS | 22634 | RSS: Main: 185835520 03:30:26 INFO - PROCESS | 22634 | 03:30:28 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42863/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:30:29 INFO - PROCESS | 22634 | RSS: Main: 183926784 03:30:29 INFO - PROCESS | 22634 | 03:30:31 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42863/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:30:31 INFO - PROCESS | 22634 | RSS: Main: 196997120 03:30:31 INFO - PROCESS | 22634 | 03:30:34 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:30:34 INFO - PROCESS | 22634 | RSS: Main: 200323072 03:30:34 INFO - PROCESS | 22634 | 03:30:37 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:30:38 INFO - PROCESS | 22634 | RSS: Main: 200400896 03:30:38 INFO - PROCESS | 22634 | 03:30:39 INFO - PROCESS | 22634 | Cycle 1(1): loaded http://localhost:42863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42863/tests/kraken/driver.html?testName=ai-astar) 03:30:40 INFO - PROCESS | 22634 | RSS: Main: 261361664 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | __start_tp_report 03:30:40 INFO - PROCESS | 22634 | _x_x_mozilla_page_load 03:30:40 INFO - PROCESS | 22634 | _x_x_mozilla_page_load_details 03:30:40 INFO - PROCESS | 22634 | |i|pagename|runs| 03:30:40 INFO - PROCESS | 22634 | |0;ai-astar;110;112;106;110;111;110;98;109;109;110 03:30:40 INFO - PROCESS | 22634 | |1;audio-beat-detection;148;127;157;170;133;160;161;137;176;128 03:30:40 INFO - PROCESS | 22634 | |2;audio-dft;162;161;160;160;161;161;161;165;162;161 03:30:40 INFO - PROCESS | 22634 | |3;audio-fft;75;73;128;101;75;76;75;109;97;71 03:30:40 INFO - PROCESS | 22634 | |4;audio-oscillator;94;95;137;94;94;94;145;94;94;151 03:30:40 INFO - PROCESS | 22634 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 03:30:40 INFO - PROCESS | 22634 | |6;imaging-darkroom;145;146;145;146;146;145;145;145;145;145 03:30:40 INFO - PROCESS | 22634 | |7;imaging-desaturate;96;95;96;95;96;95;96;95;95;96 03:30:40 INFO - PROCESS | 22634 | |8;json-parse-financial;57;56;57;55;55;55;58;64;55;53 03:30:40 INFO - PROCESS | 22634 | |9;json-stringify-tinderbox;67;68;68;69;69;75;69;69;70;69 03:30:40 INFO - PROCESS | 22634 | |10;stanford-crypto-aes;84;83;83;81;82;82;82;82;82;83 03:30:40 INFO - PROCESS | 22634 | |11;stanford-crypto-ccm;117;124;114;115;118;128;118;114;114;120 03:30:40 INFO - PROCESS | 22634 | |12;stanford-crypto-pbkdf2;151;140;150;148;148;146;161;154;149;160 03:30:40 INFO - PROCESS | 22634 | |13;stanford-crypto-sha256-iterative;70;69;71;74;69;68;72;69;71;68 03:30:40 INFO - PROCESS | 22634 | __end_tp_report 03:30:40 INFO - PROCESS | 22634 | __start_cc_report 03:30:40 INFO - PROCESS | 22634 | _x_x_mozilla_cycle_collect,1141 03:30:40 INFO - PROCESS | 22634 | __end_cc_report 03:30:40 INFO - PROCESS | 22634 | __startTimestamp1457523040110__endTimestamp 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | ------- Summary: start ------- 03:30:40 INFO - PROCESS | 22634 | Number of tests: 14 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:4.01 (3.6%) stddev-sans-first:4.21 03:30:40 INFO - PROCESS | 22634 | Values: 110.0 112.0 106.0 110.0 111.0 110.0 98.0 109.0 109.0 110.0 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:158.50 stddev:17.70 (11.2%) stddev-sans-first:18.76 03:30:40 INFO - PROCESS | 22634 | Values: 148.0 127.0 157.0 170.0 133.0 160.0 161.0 137.0 176.0 128.0 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.43 (0.9%) stddev-sans-first:1.50 03:30:40 INFO - PROCESS | 22634 | Values: 162.0 161.0 160.0 160.0 161.0 161.0 161.0 165.0 162.0 161.0 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#3] audio-fft Cycles:10 Average:88.00 Median:75.00 stddev:19.60 (26.1%) stddev-sans-first:20.21 03:30:40 INFO - PROCESS | 22634 | Values: 75.0 73.0 128.0 101.0 75.0 76.0 75.0 109.0 97.0 71.0 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:94.00 stddev:24.47 (26.0%) stddev-sans-first:25.33 03:30:40 INFO - PROCESS | 22634 | Values: 94.0 95.0 137.0 94.0 94.0 94.0 145.0 94.0 94.0 151.0 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:30:40 INFO - PROCESS | 22634 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 03:30:40 INFO - PROCESS | 22634 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:30:40 INFO - PROCESS | 22634 | Values: 96.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.50 stddev:2.99 (5.3%) stddev-sans-first:3.17 03:30:40 INFO - PROCESS | 22634 | Values: 57.0 56.0 57.0 55.0 55.0 55.0 58.0 64.0 55.0 53.0 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:2.16 (3.1%) stddev-sans-first:2.13 03:30:40 INFO - PROCESS | 22634 | Values: 67.0 68.0 68.0 69.0 69.0 75.0 69.0 69.0 70.0 69.0 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:0.84 (1.0%) stddev-sans-first:0.67 03:30:40 INFO - PROCESS | 22634 | Values: 84.0 83.0 83.0 81.0 82.0 82.0 82.0 82.0 82.0 83.0 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:118.00 stddev:4.69 (4.0%) stddev-sans-first:4.95 03:30:40 INFO - PROCESS | 22634 | Values: 117.0 124.0 114.0 115.0 118.0 128.0 118.0 114.0 114.0 120.0 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:150.50 stddev:6.31 (4.2%) stddev-sans-first:6.69 03:30:40 INFO - PROCESS | 22634 | Values: 151.0 140.0 150.0 148.0 148.0 146.0 161.0 154.0 149.0 160.0 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - PROCESS | 22634 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:1.91 (2.7%) stddev-sans-first:2.03 03:30:40 INFO - PROCESS | 22634 | Values: 70.0 69.0 71.0 74.0 69.0 68.0 72.0 69.0 71.0 68.0 03:30:40 INFO - PROCESS | 22634 | -------- Summary: end -------- 03:30:40 INFO - PROCESS | 22634 | 03:30:40 INFO - TEST-INFO | 22634: exit 0 03:30:40 INFO - TEST-OK | kraken | took 60468ms 03:30:40 INFO - SUITE-END | took 1174s 03:30:41 INFO - Completed test suite (00:19:34) 03:30:41 INFO - javascript benchmark 03:30:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3089.382123575285, 3114.4394009078355, 3121.5005599104147, 3136.984315078424, 3163.01946396617, 5097.311862898512, 5118.181091025437, 5124.820631277906, 5159.71621560814, 5258.684478931257, 5214.478552144793, 5233.1103712368895, 5261.8947621047555, 5278.181881808317, 5280.023195708796, 4793.32893394925, 4803.135435621587, 4837.129316722989, 4863.975680121612, 4879.780409881564, 4710.081534100852, 4813.855584332476, 4832.226843705008, 4871.829485967992, 4895.0944075346, 4787.13831510328, 4807.206810876201, 4818.180909245437, 4821.7589120543835, 4870.561649451549, 4781.306710526954, 4786.305985632064, 4801.783919723586, 4805.591524720403, 4816.446108697474, 4698.976505117486, 4772.308015337757, 4775.5463230993, 4792.544708252711, 4821.059893320804, 5075.923861142086, 5103.489651034867, 5109.105906466353, 5119.923201151985, 5120.385553733576, 5584.664920104807, 5636.605437619368, 5647.0, 5673.290838645169, 5682.034054210794, 5592.161175823619, 5593.608447408683, 5603.887922241533, 5609.35492418373, 5657.603967722261, 5251.894962100775, 5253.789848406059, 5254.238135470336, 5258.894822103536, 5268.525832675039, 5565.30433695788, 5651.547876169897, 5697.914531282034, 5700.6009579329875, 5744.0, 5568.443155684399, 5611.551075913917, 5612.663240205601, 5618.410066942994, 5621.297337832771, 5684.0, 5688.914666280009, 5693.430656934273, 5696.458836410535, 5698.601097923106, 5452.863678407992, 5625.6905870176715, 5675.4324567543745, 5698.202251684767, 5721.914171287434, 5658.943410565924, 5659.037963546207, 5662.68855212959, 5667.574931880125, 5671.17767923657, 4283.357496375506, 4369.847055353048, 4375.124975005012, 4380.189664912002, 4417.072414792865, 3895.2599006188734, 3936.173403585222, 3954.426608141803, 3959.2279505496726, 3978.6618137458063, 5236.659617124875, 5252.65857719247, 5253.868653283622, 5258.8948221036135, 5259.474052594786, 5573.554115670737, 5587.217789509472, 5634.7182640867795, 5639.295088113986, 5688.317401911797, 5209.661372010807, 5232.189010703347, 5233.712145832016, 5239.318888544541, 5285.550728188147, 4760.357351757538, 4763.237881938873, 4764.30917516965, 4771.594414474739, 4807.134715751198, 5722.599418040697, 5819.981503236917, 5820.679862607512, 5894.557908156906, 5991.251093613386, 5594.888102237851, 5606.187102870143, 5613.438656134354, 5613.887722245614, 5653.717314134359, 5821.417858214145, 5821.563382746226, 5822.475977162076, 5822.7670893163795, 5826.796062137805, 5460.290162278879, 5538.972305138448, 5570.721463926869, 5629.634073785354, 5664.0, 5654.321481422256, 5658.688772117573, 5697.943020569907, 5703.458171473703, 5706.0, 5523.8066667666435, 5529.585281104014, 5555.3611334697025, 5556.027695153412, 5557.610967232416, 5445.26488924006, 5510.173473978775, 5572.916406253828, 5578.888422231614, 5623.578231632562, 5379.0, 5414.918776218438, 5419.105847535113, 5423.132298832168, 5428.83713488596, 5385.892282154413, 5516.641418307797, 5528.032594295902, 5533.197686335378, 5551.583631227755, 5323.866903327448, 5401.405845356929, 5425.294711687613, 5461.699606521679, 5508.173773933942], "unit": "score", "name": "dojo.html", "value": 5194.404663468734}, {"lowerIsBetter": false, "replicates": [496.42166875589936, 504.153022921492, 509.41162956784916, 522.6472131311366, 547.2529996554704, 28931.0, 37925.810370948144, 38595.22809543811, 38622.42066369, 38709.0, 42014.579854201445, 42258.788706056504, 42353.7882310588, 42518.362224566656, 42526.574734252725, 8568.700095496642, 8770.824583508325, 8775.166359195866, 8778.2099611035, 8781.560921953876, 8542.44474109184, 8668.783280417976, 8672.653093876268, 8674.739757807276, 8681.82636347276, 8626.439281446717, 8937.642494300253, 8943.239824614915, 8943.731688049369, 8947.552622368856, 8772.517511536864, 8805.295576353876, 8881.200691937756, 8910.465372077697, 8914.197722204968, 8610.268127209194, 8760.780980475476, 8763.649454021896, 8788.692395766182, 8825.735227943107, 41115.177696445906, 41497.585024149674, 41499.7925010373, 41512.792436037926, 41520.584794151975, 3249.658785827478, 3331.3337332533592, 3379.459286514146, 3476.0788391076385, 3687.2625474905126, 30711.38577228465, 30909.536356954664, 30936.845315773277, 31013.534796978063, 31060.689393106004, 3705.1292946157632, 3741.4761933329355, 3883.8834834954996, 3913.9217215655526, 3918.784466854322, 272419.0, 273165.0, 273600.0, 273758.0, 273862.0, 59046.0, 59384.0, 59500.0, 59500.40499594949, 59650.70174649186, 61294.38705612976, 61647.691761540904, 61654.69172654108, 61780.69109654513, 61814.381856180866, 15499.225038748018, 16090.919545402432, 16407.671846563, 16407.91796041036, 16429.424970125987, 11208.27146235492, 11233.213675042833, 11239.157063220127, 11276.887231127748, 11278.492467838803, 20600.690989635168, 20807.58384832295, 21055.0, 21097.156113755584, 21136.577268454854, 7984.520928744294, 8191.385646076568, 8212.425130240827, 8237.734622978609, 8606.741797746077, 909.5588639509832, 971.7376308396694, 1002.6490728245202, 1053.0732954999705, 1060.0936199549428, 28648.427031459254, 28788.568171477444, 28807.0, 29141.56287655687, 29195.708042919723, 1053.899879511445, 1074.7742973975553, 1089.515165751249, 1110.8444817725524, 1118.0887576625025, 14753.77869331961, 15013.924930375279, 15083.4720784772, 15366.462173823862, 15373.308201130976, 339159.0, 488090.0, 495994.0, 496134.0, 496159.0, 55661.16508252299, 56125.71937140288, 56633.71683141558, 56638.7168064157, 56654.716726416926, 1249.194269696041, 1397.8741913227655, 1411.2379315169694, 1418.822647169104, 1468.6328417895527, 28755.712442875305, 31148.68851311458, 31319.0, 31585.461854944733, 31661.0, 44002.33996490119, 44360.55639443564, 44661.0, 44690.0, 44724.0, 202712.0, 203584.0, 203590.0, 203917.0, 219772.0, 27963.580546291414, 31518.0, 33347.83326083354, 33756.0, 33803.15492112717, 41990.79004604957, 52394.73802630963, 52481.47518524766, 53287.733561331945, 54269.72865135649, 38072.27957512948, 38266.0, 38594.61405386023, 39098.804505977285, 39705.60294397019, 38195.23609527738, 41509.58490415057, 42446.0, 42505.96193361626, 42568.57431425646, 37483.43774843434, 37881.0, 38467.80766096152, 38733.03167420725, 38964.80517597394, 33618.49572256369, 34875.107321845615, 35104.648953510135, 35421.46867797037, 35793.642063580075, 26542.734572654026, 27144.0, 27331.863340683965, 28266.561084853296, 28852.278693032844], "unit": "score", "name": "ext.html", "value": 18982.091657411238}, {"lowerIsBetter": false, "replicates": [346.17955445593947, 353.99823000884993, 356.4813196798658, 364.62443683006495, 365.1018494503521, 16523.75214371784, 16823.747643785337, 16935.3225870965, 17305.82694173058, 17506.912465437672, 15433.151176685278, 15812.683746325067, 17021.40425085122, 17022.659546809056, 17039.233234504445, 5264.447233040533, 5334.786608535664, 5452.073147564904, 6102.694865256742, 6104.9389506105035, 6050.757969681207, 6068.27180738312, 6087.908681369783, 6091.177691011723, 6112.266528016644, 5871.9412805871825, 5973.402659734035, 6140.53945954053, 6159.661218632973, 6159.7536098556, 5989.610675306091, 6003.159557661931, 6014.12795144706, 6026.5178785697035, 6034.5172386209, 5195.636305458619, 5207.791688332462, 5321.760520776575, 5337.226102215157, 5338.332708411449, 19302.0, 19827.40517784469, 20076.498087547927, 20134.69797953032, 20169.0923908423, 1956.8238858502802, 2018.3036852285938, 2326.8836558172025, 2340.6372012337943, 2609.4781043791318, 12642.178258413174, 12736.36318184087, 12824.615261542169, 13133.408996595175, 13555.796663050061, 1744.9127543622767, 1769.840714335716, 1806.1872157529165, 1807.7830660320715, 1822.1982327775868, 43365.56634433647, 54468.91062178774, 55412.0, 57599.0, 59254.11118833221, 8753.343499237582, 9453.90546094544, 9490.667826626035, 9615.0, 9809.166220871306, 12684.80972785409, 12699.809502857464, 12753.426095825711, 12797.104202705721, 12805.807912881315, 7110.0, 7184.568925864361, 7216.134063912364, 7278.642163915281, 7368.668409921459, 6734.46124310054, 6778.118844550276, 6826.385625293748, 6895.965520172467, 6916.273791251947, 5806.1581070744505, 5968.104784282305, 5979.1629171915965, 6046.365131661112, 6064.514838812885, 1731.2988239762665, 1755.385615034753, 1763.6649036682988, 1794.443722446046, 1816.5186225650214, 923.2014307623991, 925.3753716241511, 928.1924725488868, 938.9624415023322, 1087.722630729159, 16451.83548164503, 16965.91517042407, 17047.31810727557, 17159.227834747468, 17241.0, 837.4012581004611, 921.1525396635112, 950.2160717408028, 992.0773680477081, 1007.6120693533043, 10014.449205293633, 10081.19350451962, 10152.593896244216, 10198.33710808795, 10361.222908281909, 384764.0, 424373.0, 432357.0, 432527.0, 435911.0, 76979.0, 77015.61492192616, 78150.6092469534, 80202.0, 82975.0, 990.2127808392345, 1013.7516308504316, 1041.5573381313063, 1042.8122937871103, 1043.2957753516498, 14915.627109322353, 15110.697786044437, 15284.15937123469, 15379.615834574943, 15666.608334791721, 27202.863985679945, 28012.579811303254, 28867.0, 32377.0, 34856.47715284222, 37404.625953741204, 38440.42339364856, 38866.805665971486, 39192.60807392003, 39388.21223575455, 7501.174870764321, 7522.059742532184, 7536.24637536242, 7601.733939312097, 7652.73215437457, 12356.691082723004, 12545.560905368267, 12565.811512827133, 12626.36868156607, 12942.288174150512, 10037.297389182688, 10881.891181088087, 11057.944710276397, 11377.203595748219, 11391.0, 10521.947390263305, 10523.736906577396, 10869.836952445878, 10921.453927303444, 10949.890501094887, 11038.00657940757, 11075.501602427748, 11154.442277886235, 11196.654974378187, 11385.699035228648, 7592.81017974555, 7625.961870190614, 7705.922940770744, 7770.766876993699, 8148.0, 8283.668653253802, 10750.408727519749, 10900.672979810619, 11083.556657733601, 11261.042811360798], "unit": "score", "name": "jquery.html", "value": 8446.066002440724}, {"lowerIsBetter": false, "replicates": [1366.4124426496603, 1502.556745760001, 1510.335452400944, 1686.4013275287273, 1857.8885266883988, 7672.424568157389, 7859.056913170421, 7886.921130788691, 7888.723894663688, 7900.644470998797, 7691.576963267018, 7864.213578642133, 7867.645955931983, 7891.684332626688, 7895.486793358427, 1967.616314818611, 2238.272561417538, 2281.0761641535205, 2303.6544518322216, 2309.3072078376504, 2286.0, 2308.0998410619873, 2314.67594536765, 2318.211807985285, 2323.53529294141, 2227.8217742580637, 2314.618088015475, 2315.780000899912, 2315.9652605210936, 2318.802901753353, 2240.215924426454, 2266.4900397410534, 2280.315905228425, 2282.7032485776826, 2284.8743319117443, 2213.7786221377733, 2239.8432109752325, 2244.371575958734, 2246.7753224677563, 2249.9775002250094, 8051.879221811619, 8110.553919534424, 8121.269085782249, 8141.104478507359, 8141.715039973632, 4794.232922732346, 4875.341828853095, 4915.410150781893, 4916.0905232532095, 4916.164252077156, 3177.666345033784, 3185.5221716742444, 3239.9352012959844, 3249.8700051997894, 3310.8013519188926, 975.8731364922586, 982.3614650477175, 1002.3935519010967, 1010.7523656704082, 1019.306871327497, 11319.773604527945, 11344.716382090348, 11352.205345625809, 11357.772844543062, 11358.94320528392, 4247.532771395144, 4407.206702793464, 4466.798994045275, 4470.418845550123, 4490.528494508095, 9489.66786162481, 9577.616895324109, 9605.087516685904, 9608.375455595364, 9613.567389467491, 4329.415528903558, 4792.0895029944195, 4804.567588916944, 4805.567498925044, 4809.831655892027, 4248.787560621957, 4319.870403887889, 4336.176126535948, 4375.518692943773, 4376.562343765661, 3695.5565332159777, 3773.9433908491396, 3781.5840257571645, 3809.504764380613, 3846.288436639231, 1171.6133675886938, 1191.2911817468591, 1196.9820452693216, 1208.0, 1227.4660522672666, 1043.4886905416292, 1052.8210204265292, 1062.123747907979, 1218.7379713361493, 1378.9655258618616, 7563.9621801891735, 7662.846743065107, 7708.421868359784, 7716.42126840478, 7725.961370193113, 470.80696914264985, 486.365293292257, 490.9828156014522, 492.4189456441434, 492.93345398370764, 5574.9721251393485, 5677.943220567824, 5687.260656114761, 5689.487946084872, 5705.600607957486, 9189.632414703337, 9190.90809091914, 9216.400933939272, 9272.258219342437, 9359.017303183204, 9117.908820911838, 9127.77180570491, 9210.447373157633, 9263.073692630818, 9274.814503709888, 7544.849103017909, 7611.0, 7673.961630191813, 7678.270564296383, 7756.806079848049, 7389.630518473948, 7443.069616297963, 7444.218357072429, 7445.255474452511, 7447.851042979219, 8208.753737387888, 8249.340052795882, 8373.58132093405, 8508.319334453352, 8588.22705956467, 8427.831443370975, 8557.614907329309, 8735.912640873765, 8754.51850148248, 8770.780730481789, 5842.649441033552, 6701.798946031627, 6824.965875170592, 6828.044073829568, 6993.510454268152, 7583.582902940391, 7586.051743532059, 7615.619219039137, 7633.923660763321, 7645.426593005435, 6566.6388348641285, 6717.462602991846, 6733.494987875831, 6769.0, 6863.279355667583, 6583.242927063449, 6604.240512341143, 6608.4052435281055, 6687.230968438692, 6837.1111755471475, 6885.139357580302, 6904.206016308189, 6949.096617439903, 6954.756583519553, 6959.0257363970095, 6561.081448597105, 6592.637404942774, 6629.138212032405, 6648.1025061616065, 6653.367930046637, 6628.204615446178, 6683.933160668331, 6708.094407254958, 6709.429698475489, 6710.060591517094], "unit": "score", "name": "mootools.html", "value": 4437.26164898291}, {"lowerIsBetter": false, "replicates": [316.88275338124896, 328.87667124828187, 331.9684629960153, 335.4967548676984, 339.43484098975193, 5875.853103672411, 5883.058710606304, 5908.261467316585, 5923.407659234074, 5937.67342796146, 5807.912881306784, 5855.385184555625, 5861.120831875221, 5869.442402971711, 5873.650539784088, 4293.184294983943, 4375.584319489643, 4412.3160910059, 4472.1502914446155, 4524.434445694288, 4470.26240670289, 4470.910581788362, 4478.149151661174, 4497.527759585246, 4506.053728716957, 4455.420795296607, 4458.821647134111, 4460.219461594224, 4468.285074388098, 4474.552544745532, 4266.552012038738, 4397.670174736908, 4472.262076757331, 4526.841560545398, 4531.932021019687, 3942.329803933338, 3947.960520394788, 3951.920961580781, 3966.3852102923806, 3970.0, 5569.749361278712, 5578.86052848682, 5588.105903055492, 5590.413006634326, 5592.5246354059955, 5265.183896496049, 5272.472752724735, 5275.762590683428, 5276.182191760283, 5281.8151364702435, 6206.131141640174, 6226.688665566749, 6236.189295391616, 6246.906296405557, 6276.152719382871, 4251.638610718092, 4358.237308471036, 4370.147821174841, 4414.1171765647, 4417.558244175589, 6245.843853903643, 6264.0, 6283.340249273851, 6348.492120630339, 6384.904226436561, 4436.6672499562665, 4438.201123797683, 4440.178566965122, 4441.200583894865, 4450.265706158448, 4487.887802804956, 4499.437570303712, 4502.099580083996, 4503.504614492404, 4514.164879497303, 5149.253358263031, 5159.948400516022, 5163.483651634807, 5163.715995620202, 5166.0, 6044.758209671564, 6166.167567378437, 6172.567920245539, 6189.81430557084, 6191.226096737908, 1589.0386316278716, 1602.3190144188673, 1609.2114863716695, 1609.903405795656, 1613.1692178528067, 990.1089019882164, 1061.368485750977, 1061.946902654864, 1072.0458791675414, 1086.1853609792656, 5814.447627475383, 5821.446962538552, 5825.825225243249, 5877.500412464989, 5893.233879595711, 6363.172787537591, 6371.617702937839, 6372.681365931778, 6394.0, 6397.488200943913, 5884.382139875337, 5885.5585831062845, 5887.116932460165, 5892.646441213541, 5893.057110862242, 3369.713574346159, 3392.0332705178907, 3392.1519620094978, 3394.0496660934978, 3394.6775056369606, 6461.224653041571, 6542.21493420783, 6557.573757705733, 6783.491238157158, 6812.943993680988, 6556.147700798866, 6639.136912201479, 6641.933580664228, 6662.633555154416, 6718.160229971254, 6824.556403833735, 6829.965850170717, 6830.146231721035, 6832.658367081626, 6835.4189893859575, 6486.027095935648, 6486.675666216576, 6494.6103233806125, 6555.737770489318, 6561.40947314744, 6214.533909956681, 6402.743890244338, 6404.039394090923, 6405.295417504164, 6417.48660107181, 6749.763758268437, 6764.3573860483175, 6776.830579235559, 6781.254062053269, 6794.558353706993, 4322.740635561876, 4334.523202447791, 4350.891227719332, 4351.216780979454, 4357.8256869724855, 6492.610443373413, 6498.187726534184, 6498.220213574401, 6498.610083395011, 6500.772472963424, 6279.874402511833, 6286.0, 6292.2449306081735, 6292.370762923671, 6303.432691057827, 6122.357152498924, 6276.058591211355, 6285.874282514415, 6287.654179020198, 6288.402601752826, 6144.969275153596, 6159.969200153971, 6177.0, 6178.938210617836, 6187.226596675416, 6308.842278943063, 6317.178766760292, 6318.115463835159, 6321.367863213642, 6328.303886572566, 5908.409159084057, 5997.100434934795, 6185.783497577743, 6198.752049918133, 6202.472789812736], "unit": "score", "name": "prototype.html", "value": 4702.924834230042}, {"lowerIsBetter": false, "replicates": [691.2051141187634, 716.949813513054, 734.9375303099237, 813.6419975210911, 822.4736168851936, 12856.357182140902, 12975.870241297596, 12990.61028169154, 13040.478380864777, 13046.086773925828, 12287.877121228807, 14148.858511414883, 14477.203753793563, 14485.78271325931, 14487.0, 839.236294971576, 840.8822764812932, 842.9409941304111, 845.1632883445407, 847.267113946435, 694.3230350408362, 837.4807619276057, 851.0213254757017, 853.7353420439653, 854.4318028511033, 866.1035827918106, 885.4510203673731, 889.2263730554427, 889.5463313710022, 889.6085722282176, 716.3409663109951, 863.5466380150408, 875.9649614015432, 881.9426737262057, 883.0022075055178, 648.2577448821121, 654.3358491131505, 655.8786624474487, 656.0782101147847, 656.291205498061, 13662.93168534161, 14442.638934026629, 14461.13233206011, 14483.565493035227, 14504.202268875208, 11794.646160615195, 12323.69190770229, 12465.127441079128, 12479.0, 12584.4337004835, 10113.08982191599, 10136.949315253376, 10219.795604087876, 10317.742056448575, 10361.171106311476, 3476.4090104682264, 3511.3679537683206, 3551.058969373118, 3553.662402071799, 3666.651668091527, 45384.0, 45622.771886140355, 45818.312725309144, 45932.0, 46157.76921115407, 8997.37018408705, 9505.0, 9569.090936361174, 9583.712488625353, 9878.863930647924, 17984.190711418018, 18011.369602064126, 18020.549486262687, 18032.549186270448, 18038.0, 6944.583325000516, 7048.083749112582, 7334.66993985272, 7336.559806411632, 7416.7774966751085, 4003.259397011562, 4100.6924480664065, 4177.143685544456, 4248.129133527619, 4297.119090586422, 3136.7961082529564, 3168.6197656281392, 3180.173154979722, 3182.8885988990273, 3184.188032051812, 554.938956714761, 561.2479277767729, 561.7528287553463, 564.8870225954826, 593.4658906726161, 527.9841604751864, 613.8189234175928, 621.4841681404423, 622.5237693164732, 628.6448156791398, 7707.113681926538, 7797.649105790253, 7982.560959147187, 8077.83844323122, 8361.205685459872, 574.2219292858117, 597.3339726205337, 611.703323887914, 616.2297128589263, 627.9372062793775, 3758.793266370376, 3851.422286657024, 3933.8033098344968, 3987.940180897289, 4063.4920634920636, 53400.73299633477, 53824.19263711048, 59341.40658593445, 60310.698446507486, 60832.695836520536, 46896.76551617288, 47398.28902566464, 47455.5254447458, 47871.52128478671, 47995.280070798966, 43687.344689829675, 43898.0, 43922.34116488255, 44015.55984440115, 44336.77831610821, 8365.28895043928, 8399.454035487674, 8415.663373464993, 8472.49165050099, 8483.44857584255, 32325.51511727373, 32909.341813163126, 33149.00552983415, 33351.49972750362, 34226.48660270048, 36947.261054779294, 39252.80373598228, 42164.578354217294, 42194.36708449437, 42603.36094958516, 10796.514156863117, 11050.171237157407, 11226.943865280948, 11518.596849110241, 11535.653930382103, 11311.830322545004, 11398.20212585111, 11547.595834145764, 11728.41357932117, 12056.819147712617, 10927.289726167774, 11122.666320010412, 11154.0, 11448.828267575826, 11701.06391488696, 10928.344299342065, 11058.778824423305, 11245.325280483197, 11402.94298528502, 11445.313281203154, 10833.187510936554, 11001.339919604849, 11146.865876525113, 11236.775264494829, 11618.477168527268, 9542.236621070158, 9601.183899368632, 9702.369345992487, 9724.95137524308, 9784.608615655294, 8808.91191088081, 9524.85712714296, 9534.0, 9543.90456095458, 9553.474558899326], "unit": "score", "name": "yui.html", "value": 6197.342025592938}], "name": "dromaeo_css", "value": 6897.799195159826}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 110.0, 111.0, 110.0, 98.0, 109.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [148.0, 127.0, 157.0, 170.0, 133.0, 160.0, 161.0, 137.0, 176.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 160.0, 161.0, 161.0, 161.0, 165.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 128.0, 101.0, 75.0, 76.0, 75.0, 109.0, 97.0, 71.0], "unit": "score", "name": "audio-fft", "value": 88.0}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 137.0, 94.0, 94.0, 94.0, 145.0, 94.0, 94.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 55.0, 55.0, 55.0, 58.0, 64.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 69.0, 69.0, 75.0, 69.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 83.0, 81.0, 82.0, 82.0, 82.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [117.0, 124.0, 114.0, 115.0, 118.0, 128.0, 118.0, 114.0, 114.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.2}, {"lowerIsBetter": true, "replicates": [151.0, 140.0, 150.0, 148.0, 148.0, 146.0, 161.0, 154.0, 149.0, 160.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 71.0, 74.0, 69.0, 68.0, 72.0, 69.0, 71.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1521.8000000000002}]} 03:30:41 INFO - Return code: 0 03:30:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:30:41 INFO - # TBPL SUCCESS # 03:30:41 INFO - Running post-action listener: _resource_record_post_action 03:30:41 INFO - Running post-run listener: _resource_record_post_run 03:30:42 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 533110784; Read time: 128; Write time: 479620 03:30:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240828416; Read time: 0; Write time: 279044 03:30:42 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292282368; Read time: 128; Write time: 200576 03:30:42 INFO - Running post-run listener: _upload_blobber_files 03:30:42 INFO - Blob upload gear active. 03:30:42 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 03:30:42 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 03:30:42 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 03:30:42 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 03:30:42 INFO - (blobuploader) - INFO - Open directory for files ... 03:30:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 03:30:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:30:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:43 INFO - (blobuploader) - INFO - Done attempting. 03:30:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:30:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:30:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:44 INFO - (blobuploader) - INFO - Done attempting. 03:30:44 INFO - (blobuploader) - INFO - Iteration through files over. 03:30:44 INFO - Return code: 0 03:30:44 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 03:30:44 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 03:30:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24a1b0b72e940d4ece542f01734a7f754e22668c7c681c970a36e4817f4807e7a2275128d42bb73ac0c9a715a410ed54c6ca9b7e2db86caa67784fd06a7029ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74098e9becea4e474159af8ce1cad6ca1203ebe626795968b10231ba673f8f966d858a3900435087323e0347d6eb325be35983be0b6a8b409b48c8d73642a0d0"} 03:30:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 03:30:44 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 03:30:44 INFO - Contents: 03:30:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24a1b0b72e940d4ece542f01734a7f754e22668c7c681c970a36e4817f4807e7a2275128d42bb73ac0c9a715a410ed54c6ca9b7e2db86caa67784fd06a7029ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74098e9becea4e474159af8ce1cad6ca1203ebe626795968b10231ba673f8f966d858a3900435087323e0347d6eb325be35983be0b6a8b409b48c8d73642a0d0"} 03:30:44 INFO - Running post-run listener: copy_logs_to_upload_dir 03:30:44 INFO - Copying logs to upload dir... 03:30:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 03:30:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.714945 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-09 03:30:44.432718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 03:30:44.437878) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24a1b0b72e940d4ece542f01734a7f754e22668c7c681c970a36e4817f4807e7a2275128d42bb73ac0c9a715a410ed54c6ca9b7e2db86caa67784fd06a7029ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74098e9becea4e474159af8ce1cad6ca1203ebe626795968b10231ba673f8f966d858a3900435087323e0347d6eb325be35983be0b6a8b409b48c8d73642a0d0"} build_url:https://queue.taskcluster.net/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011096 build_url: 'https://queue.taskcluster.net/v1/task/MCQjFZ42RAOmHwBA2LgTCQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24a1b0b72e940d4ece542f01734a7f754e22668c7c681c970a36e4817f4807e7a2275128d42bb73ac0c9a715a410ed54c6ca9b7e2db86caa67784fd06a7029ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74098e9becea4e474159af8ce1cad6ca1203ebe626795968b10231ba673f8f966d858a3900435087323e0347d6eb325be35983be0b6a8b409b48c8d73642a0d0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 03:30:44.471963) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:30:44.472536) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457521254.849020-1536679034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 03:30:44.553304) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 03:30:44.553618) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 03:30:44.553919) ========= ========= Total master_lag: 0.42 =========