builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1458616139.31 results: success (0) buildid: 20160321173022 builduid: 06a0a40281744d13bfb25f41abe08549 revision: 98189434eea16c181df0c7e8d60af76feceaf492 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.307459) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.308300) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.308594) ========= 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=1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006250 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.357643) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.357920) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.401730) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.402072) ========= 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=1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023822 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.468369) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.468666) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.469100) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.469533) ========= 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=1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-21 20:08:59-- 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% 97.2M=0s 2016-03-21 20:08:59 (97.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.183955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.673963) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.674249) ========= 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=1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.156932 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.849254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 20:08:59.849587) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98189434eea16c181df0c7e8d60af76feceaf492 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 98189434eea16c181df0c7e8d60af76feceaf492 --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=1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-21 20:08:59,904 truncating revision to first 12 chars 2016-03-21 20:08:59,904 Setting DEBUG logging. 2016-03-21 20:08:59,904 attempt 1/10 2016-03-21 20:08:59,904 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98189434eea1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-21 20:09:00,176 unpacking tar archive at: fx-team-98189434eea1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.553214 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 20:09:00.417897) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 20:09:00.418828) ========= echo 98189434eea16c181df0c7e8d60af76feceaf492 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'98189434eea16c181df0c7e8d60af76feceaf492'] 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=1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 98189434eea16c181df0c7e8d60af76feceaf492 program finished with exit code 0 elapsedTime=0.004562 script_repo_revision: '98189434eea16c181df0c7e8d60af76feceaf492' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 20:09:00.467744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 20:09:00.468081) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 20:09:00.480022) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-03-21 20:09:00.480317) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:09:00 INFO - MultiFileLogger online at 20160321 20:09:00 in /builds/slave/test-pgo 20:09:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:09:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:09:00 INFO - {'append_to_log': False, 20:09:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:09:00 INFO - 'blob_upload_branch': 'Fx-Team', 20:09:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:09:00 INFO - 'branch': 'Fx-Team', 20:09:00 INFO - 'buildbot_json_path': 'buildprops.json', 20:09:00 INFO - 'config_files': ('talos/linux_config.py',), 20:09:00 INFO - 'default_actions': ('clobber', 20:09:00 INFO - 'read-buildbot-config', 20:09:00 INFO - 'download-and-extract', 20:09:00 INFO - 'populate-webroot', 20:09:00 INFO - 'create-virtualenv', 20:09:00 INFO - 'install', 20:09:00 INFO - 'run-tests'), 20:09:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:09:00 INFO - 'download_minidump_stackwalk': True, 20:09:00 INFO - 'download_symbols': 'ondemand', 20:09:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:09:00 INFO - 'tooltool.py': '/tools/tooltool.py', 20:09:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:09:00 INFO - '/tools/misc-python/virtualenv.py')}, 20:09:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:09:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:09:00 INFO - 'installer_path': 'installer.exe', 20:09:00 INFO - 'log_level': 'info', 20:09:00 INFO - 'log_name': 'talos', 20:09:00 INFO - 'log_to_console': True, 20:09:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:09:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:09:00 INFO - 'opt_config_files': (), 20:09:00 INFO - 'pip_index': False, 20:09:00 INFO - 'sps_profile': False, 20:09:00 INFO - 'sps_profile_interval': 0, 20:09:00 INFO - 'suite': 'dromaeojs', 20:09:00 INFO - 'system_bits': '32', 20:09:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:09:00 INFO - 'title': 'talos-linux64-ix-045', 20:09:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:09:00 INFO - 'use_talos_json': True, 20:09:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:09:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:09:00 INFO - 'work_dir': 'build'} 20:09:00 INFO - ##### 20:09:00 INFO - ##### Running clobber step. 20:09:00 INFO - ##### 20:09:00 INFO - Running pre-action listener: _resource_record_pre_action 20:09:00 INFO - Running main action method: clobber 20:09:00 INFO - rmtree: /builds/slave/test-pgo/build 20:09:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:09:05 INFO - Running post-action listener: _resource_record_post_action 20:09:05 INFO - ##### 20:09:05 INFO - ##### Running read-buildbot-config step. 20:09:05 INFO - ##### 20:09:05 INFO - Running pre-action listener: _resource_record_pre_action 20:09:05 INFO - Running main action method: read_buildbot_config 20:09:05 INFO - Using buildbot properties: 20:09:05 INFO - { 20:09:05 INFO - "project": "", 20:09:05 INFO - "product": "firefox", 20:09:05 INFO - "script_repo_revision": "production", 20:09:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:09:05 INFO - "repository": "", 20:09:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:09:05 INFO - "buildid": "20160321173022", 20:09:05 INFO - "pgo_build": "True", 20:09:05 INFO - "basedir": "/builds/slave/test-pgo", 20:09:05 INFO - "buildnumber": 552, 20:09:05 INFO - "slavename": "talos-linux64-ix-045", 20:09:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:09:05 INFO - "platform": "ubuntu64_hw", 20:09:05 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:09:05 INFO - "branch": "fx-team", 20:09:05 INFO - "repo_path": "integration/fx-team", 20:09:05 INFO - "revision": "98189434eea16c181df0c7e8d60af76feceaf492", 20:09:05 INFO - "stage_platform": "linux64-pgo", 20:09:05 INFO - "builduid": "06a0a40281744d13bfb25f41abe08549", 20:09:05 INFO - "slavebuilddir": "test" 20:09:05 INFO - } 20:09:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 20:09:05 INFO - Running post-action listener: _resource_record_post_action 20:09:05 INFO - ##### 20:09:05 INFO - ##### Running download-and-extract step. 20:09:05 INFO - ##### 20:09:05 INFO - Running pre-action listener: _resource_record_pre_action 20:09:05 INFO - Running main action method: download_and_extract 20:09:05 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:09: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')]} 20:09:05 INFO - https://queue.taskcluster.net/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:09:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:09:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:09:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/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 20:09:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/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 20:09:08 INFO - Downloaded 1361 bytes. 20:09:08 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:09:08 INFO - Using the following test package requirements: 20:09:08 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:09:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:09:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:08 INFO - u'jsshell-linux-x86_64.zip'], 20:09:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:09:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:09:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:09:08 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:09:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:09:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:09:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:09:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:09: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')]} 20:09:08 INFO - https://queue.taskcluster.net/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:09:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:09:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/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 20:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/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 20:09:11 INFO - Downloaded 23570463 bytes. 20:09:11 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'] 20:09:11 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 20:09:12 INFO - Return code: 0 20:09:12 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 20:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:12 INFO - https://queue.taskcluster.net/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/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 20:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/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 20:09:14 INFO - Downloaded 23570463 bytes. 20:09: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'] 20:09: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 20:09:16 INFO - Return code: 0 20:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:16 INFO - https://queue.taskcluster.net/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:09:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:09:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/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 20:09:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/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 20:09:17 INFO - Downloaded 10847637 bytes. 20:09:17 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'] 20:09:17 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 20:09:17 INFO - Return code: 0 20:09:17 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')]} 20:09:17 INFO - https://queue.taskcluster.net/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:09:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:09:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:09:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/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 20:09:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/axZeBe9CQj6SIuIEXfq-SA/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 20:09:19 INFO - Downloaded 57730693 bytes. 20:09:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:09:19 INFO - mkdir: /builds/slave/test-pgo/properties 20:09:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:09:19 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:09:19 INFO - Contents: 20:09:19 INFO - build_url:https://queue.taskcluster.net/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:09:20 INFO - Running post-action listener: _resource_record_post_action 20:09:20 INFO - Running post-action listener: set_extra_try_arguments 20:09:20 INFO - ##### 20:09:20 INFO - ##### Running populate-webroot step. 20:09:20 INFO - ##### 20:09:20 INFO - Running pre-action listener: _resource_record_pre_action 20:09:20 INFO - Running main action method: populate_webroot 20:09:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:09:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:09:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:09:20 INFO - '--tppagecycles', 20:09:20 INFO - '7'], 20:09:20 INFO - 'tests': ['tsvgm']}}, 20:09:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:09:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:09:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:09:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:09:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:09:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:09:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:20 INFO - 'talos_options': ['--e10s'], 20:09:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:20 INFO - 'tests': ['damp', 'tps']}, 20:09:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:20 INFO - 'talos_options': ['--e10s'], 20:09:20 INFO - 'tests': ['damp', 'tps']}, 20:09:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:09:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:09:20 INFO - 'other': {'tests': ['a11yr', 20:09:20 INFO - 'ts_paint', 20:09:20 INFO - 'tpaint', 20:09:20 INFO - 'sessionrestore', 20:09:20 INFO - 'sessionrestore_no_auto_restore', 20:09:20 INFO - 'tabpaint']}, 20:09:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:09:20 INFO - 'tests': ['a11yr', 20:09:20 INFO - 'ts_paint', 20:09:20 INFO - 'tpaint', 20:09:20 INFO - 'sessionrestore', 20:09:20 INFO - 'sessionrestore_no_auto_restore', 20:09:20 INFO - 'tabpaint']}, 20:09:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:09:20 INFO - 'tests': ['a11yr', 20:09:20 INFO - 'ts_paint', 20:09:20 INFO - 'tpaint', 20:09:20 INFO - 'sessionrestore', 20:09:20 INFO - 'sessionrestore_no_auto_restore', 20:09:20 INFO - 'tabpaint']}, 20:09:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:09:20 INFO - 'tests': ['a11yr', 20:09:20 INFO - 'ts_paint', 20:09:20 INFO - 'tpaint', 20:09:20 INFO - 'sessionrestore', 20:09:20 INFO - 'sessionrestore_no_auto_restore', 20:09:20 INFO - 'tabpaint']}, 20:09:20 INFO - 'other_l64': {'tests': ['a11yr', 20:09:20 INFO - 'ts_paint', 20:09:20 INFO - 'tpaint', 20:09:20 INFO - 'sessionrestore', 20:09:20 INFO - 'sessionrestore_no_auto_restore', 20:09:20 INFO - 'tabpaint']}, 20:09:20 INFO - 'other_nol64': {'tests': ['a11yr', 20:09:20 INFO - 'ts_paint', 20:09:20 INFO - 'tpaint', 20:09:20 INFO - 'sessionrestore', 20:09:20 INFO - 'sessionrestore_no_auto_restore', 20:09:20 INFO - 'tabpaint']}, 20:09:20 INFO - 'svgr': {'tests': ['tsvgx', 20:09:20 INFO - 'tsvgr_opacity', 20:09:20 INFO - 'tart', 20:09:20 INFO - 'tscrollx', 20:09:20 INFO - 'cart']}, 20:09:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:09:20 INFO - 'tests': ['tsvgx', 20:09:20 INFO - 'tsvgr_opacity', 20:09:20 INFO - 'tart', 20:09:20 INFO - 'tscrollx', 20:09:20 INFO - 'cart']}, 20:09:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:20 INFO - 'tests': ['tp5o']}, 20:09:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:20 INFO - 'talos_options': ['--e10s'], 20:09:20 INFO - 'tests': ['tp5o']}, 20:09:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:20 INFO - 'talos_options': ['--xperf_path', 20:09:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:20 INFO - 'tests': ['tp5n']}, 20:09:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:20 INFO - 'talos_options': ['--e10s', 20:09:20 INFO - '--xperf_path', 20:09:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:20 INFO - 'tests': ['tp5n']}}, 20:09:20 INFO - 'talos.zip': {'path': '', 20:09:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:09:20 INFO - Running post-action listener: _resource_record_post_action 20:09:20 INFO - ##### 20:09:20 INFO - ##### Running create-virtualenv step. 20:09:20 INFO - ##### 20:09:20 INFO - Running pre-action listener: _resource_record_pre_action 20:09:20 INFO - Running main action method: create_virtualenv 20:09:20 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:09:20 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 20:09:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:09:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:09:20 INFO - Using real prefix '/usr' 20:09:20 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:09:20 INFO - Installing distribute.............................................................................................................................................................................................done. 20:09:23 INFO - Installing pip.................done. 20:09:23 INFO - Return code: 0 20:09:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:09: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')]} 20:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:23 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 0x7fa98be71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c881d0>, '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 0x2c8b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbe0>, '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': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', '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 20:09:23 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 20:09:23 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 20:09:23 INFO - Using env: {'DISPLAY': ':0', 20:09:23 INFO - 'HOME': '/home/cltbld', 20:09:23 INFO - 'LANG': 'en_US.UTF-8', 20:09:23 INFO - 'LANGUAGE': 'en_US:en', 20:09:23 INFO - 'LOGNAME': 'cltbld', 20:09:23 INFO - 'MAIL': '/var/mail/cltbld', 20:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:23 INFO - 'MOZ_NO_REMOTE': '1', 20:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:23 INFO - 'NO_EM_RESTART': '1', 20:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:09:23 INFO - 'PWD': '/builds/slave/test-pgo', 20:09:23 INFO - 'SHELL': '/bin/bash', 20:09:23 INFO - 'SHLVL': '1', 20:09:23 INFO - 'TERM': 'linux', 20:09:23 INFO - 'TMOUT': '86400', 20:09:23 INFO - 'USER': 'cltbld', 20:09:23 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', 20:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:23 INFO - '_': '/tools/buildbot/bin/python'} 20:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:23 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 20:09:23 INFO - Cleaning up... 20:09:23 INFO - Return code: 0 20:09:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:09: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')]} 20:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:23 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 0x7fa98be71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c881d0>, '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 0x2c8b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbe0>, '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': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', '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 20:09:23 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 20:09:23 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 20:09:23 INFO - Using env: {'DISPLAY': ':0', 20:09:23 INFO - 'HOME': '/home/cltbld', 20:09:23 INFO - 'LANG': 'en_US.UTF-8', 20:09:23 INFO - 'LANGUAGE': 'en_US:en', 20:09:23 INFO - 'LOGNAME': 'cltbld', 20:09:23 INFO - 'MAIL': '/var/mail/cltbld', 20:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:23 INFO - 'MOZ_NO_REMOTE': '1', 20:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:23 INFO - 'NO_EM_RESTART': '1', 20:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:09:23 INFO - 'PWD': '/builds/slave/test-pgo', 20:09:23 INFO - 'SHELL': '/bin/bash', 20:09:23 INFO - 'SHLVL': '1', 20:09:23 INFO - 'TERM': 'linux', 20:09:23 INFO - 'TMOUT': '86400', 20:09:23 INFO - 'USER': 'cltbld', 20:09:23 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', 20:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:23 INFO - '_': '/tools/buildbot/bin/python'} 20:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:24 INFO - Downloading/unpacking psutil>=0.7.1 20:09:24 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 20:09:24 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 20:09:24 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 20:09:24 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 20:09:24 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 20:09:24 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 20:09:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:09:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:26 INFO - Installing collected packages: psutil 20:09:26 INFO - Running setup.py install for psutil 20:09:26 INFO - building 'psutil._psutil_linux' extension 20:09:26 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 20:09:27 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 20:09:27 INFO - building 'psutil._psutil_posix' extension 20:09:27 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 20:09:27 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 20:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:27 INFO - Successfully installed psutil 20:09:27 INFO - Cleaning up... 20:09:27 INFO - Return code: 0 20:09:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:09: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')]} 20:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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', '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 0x7fa98be71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c881d0>, '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 0x2c8b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbe0>, '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': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', '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 20:09: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 20:09: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 mozsystemmonitor==0.0.0 20:09:27 INFO - Using env: {'DISPLAY': ':0', 20:09:27 INFO - 'HOME': '/home/cltbld', 20:09:27 INFO - 'LANG': 'en_US.UTF-8', 20:09:27 INFO - 'LANGUAGE': 'en_US:en', 20:09:27 INFO - 'LOGNAME': 'cltbld', 20:09:27 INFO - 'MAIL': '/var/mail/cltbld', 20:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:27 INFO - 'MOZ_NO_REMOTE': '1', 20:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:27 INFO - 'NO_EM_RESTART': '1', 20:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:09:27 INFO - 'PWD': '/builds/slave/test-pgo', 20:09:27 INFO - 'SHELL': '/bin/bash', 20:09:27 INFO - 'SHLVL': '1', 20:09:27 INFO - 'TERM': 'linux', 20:09:27 INFO - 'TMOUT': '86400', 20:09:27 INFO - 'USER': 'cltbld', 20:09:27 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', 20:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:27 INFO - '_': '/tools/buildbot/bin/python'} 20:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:09:27 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 20:09:27 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 20:09:27 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 20:09:27 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 20:09:27 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 20:09:27 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 20:09:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:09:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:09:29 INFO - Installing collected packages: mozsystemmonitor 20:09:29 INFO - Running setup.py install for mozsystemmonitor 20:09:29 INFO - Successfully installed mozsystemmonitor 20:09:29 INFO - Cleaning up... 20:09:29 INFO - Return code: 0 20:09:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa98be71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c881d0>, '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 0x2c8b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbe0>, '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': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', '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 20:09:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 20:09:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:09:29 INFO - Using env: {'DISPLAY': ':0', 20:09:29 INFO - 'HOME': '/home/cltbld', 20:09:29 INFO - 'LANG': 'en_US.UTF-8', 20:09:29 INFO - 'LANGUAGE': 'en_US:en', 20:09:29 INFO - 'LOGNAME': 'cltbld', 20:09:29 INFO - 'MAIL': '/var/mail/cltbld', 20:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:29 INFO - 'MOZ_NO_REMOTE': '1', 20:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:29 INFO - 'NO_EM_RESTART': '1', 20:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:09:29 INFO - 'PWD': '/builds/slave/test-pgo', 20:09:29 INFO - 'SHELL': '/bin/bash', 20:09:29 INFO - 'SHLVL': '1', 20:09:29 INFO - 'TERM': 'linux', 20:09:29 INFO - 'TMOUT': '86400', 20:09:29 INFO - 'USER': 'cltbld', 20:09:29 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', 20:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:29 INFO - '_': '/tools/buildbot/bin/python'} 20:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:30 INFO - Downloading/unpacking blobuploader==1.2.4 20:09:30 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 20:09:30 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 20:09:30 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 20:09:30 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 20:09:30 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 20:09:30 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 20:09:31 INFO - Downloading blobuploader-1.2.4.tar.gz 20:09:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:09:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:09:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:32 INFO - Downloading docopt-0.6.1.tar.gz 20:09:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:09:32 INFO - Installing collected packages: blobuploader, requests, docopt 20:09:32 INFO - Running setup.py install for blobuploader 20:09:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:09:32 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:09:32 INFO - Running setup.py install for requests 20:09:33 INFO - Running setup.py install for docopt 20:09:33 INFO - Successfully installed blobuploader requests docopt 20:09:33 INFO - Cleaning up... 20:09:33 INFO - Return code: 0 20:09:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:09: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')]} 20:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:33 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 0x7fa98be71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c881d0>, '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 0x2c8b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbe0>, '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': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', '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 20:09:33 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 20:09:33 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 20:09:33 INFO - Using env: {'DISPLAY': ':0', 20:09:33 INFO - 'HOME': '/home/cltbld', 20:09:33 INFO - 'LANG': 'en_US.UTF-8', 20:09:33 INFO - 'LANGUAGE': 'en_US:en', 20:09:33 INFO - 'LOGNAME': 'cltbld', 20:09:33 INFO - 'MAIL': '/var/mail/cltbld', 20:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:33 INFO - 'MOZ_NO_REMOTE': '1', 20:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:33 INFO - 'NO_EM_RESTART': '1', 20:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:09:33 INFO - 'PWD': '/builds/slave/test-pgo', 20:09:33 INFO - 'SHELL': '/bin/bash', 20:09:33 INFO - 'SHLVL': '1', 20:09:33 INFO - 'TERM': 'linux', 20:09:33 INFO - 'TMOUT': '86400', 20:09:33 INFO - 'USER': 'cltbld', 20:09:33 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', 20:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:33 INFO - '_': '/tools/buildbot/bin/python'} 20:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:09:33 INFO - Running setup.py (path:/tmp/pip-wjVsNQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:09:33 INFO - Running setup.py (path:/tmp/pip-uqlWTX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:09:33 INFO - Running setup.py (path:/tmp/pip-99ilTX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:09:33 INFO - Running setup.py (path:/tmp/pip-fzHv6K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:09:33 INFO - Running setup.py (path:/tmp/pip-TABbg6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:09:33 INFO - Running setup.py (path:/tmp/pip-KWkO4m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:09:33 INFO - Running setup.py (path:/tmp/pip-VrWlBQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:09:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:09:33 INFO - Running setup.py (path:/tmp/pip-sMTS6v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:09:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:09:34 INFO - Running setup.py (path:/tmp/pip-Loprj5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:09:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:09:34 INFO - Running setup.py (path:/tmp/pip-VPORA8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:09:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:09:34 INFO - Running setup.py (path:/tmp/pip-at9gcR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:09:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:09:34 INFO - Running setup.py (path:/tmp/pip-DIvBi0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:09:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:09:34 INFO - Running setup.py (path:/tmp/pip-raXB2q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:09:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:09:34 INFO - Running setup.py (path:/tmp/pip-LTYyzZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:09:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:09:34 INFO - Running setup.py (path:/tmp/pip-Nsr9Wc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:09:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:09:34 INFO - Running setup.py (path:/tmp/pip-RR_EDY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:09:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:09:34 INFO - Running setup.py (path:/tmp/pip-LTNTuh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:09:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:09:34 INFO - Running setup.py install for manifestparser 20:09:34 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:09:34 INFO - Running setup.py install for mozcrash 20:09:34 INFO - Running setup.py install for mozdebug 20:09:34 INFO - Running setup.py install for mozdevice 20:09:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:09:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:09:35 INFO - Running setup.py install for mozfile 20:09:35 INFO - Running setup.py install for mozhttpd 20:09:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:09:35 INFO - Running setup.py install for mozinfo 20:09:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:09:35 INFO - Running setup.py install for mozInstall 20:09:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:09:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:09:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:09:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:09:35 INFO - Running setup.py install for mozleak 20:09:35 INFO - Running setup.py install for mozlog 20:09:35 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:09:35 INFO - Running setup.py install for moznetwork 20:09:35 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:09:35 INFO - Running setup.py install for mozprocess 20:09:35 INFO - Running setup.py install for mozprofile 20:09:36 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:09:36 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:09:36 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:09:36 INFO - Running setup.py install for mozrunner 20:09:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:09:36 INFO - Running setup.py install for mozscreenshot 20:09:36 INFO - Running setup.py install for moztest 20:09:36 INFO - Running setup.py install for mozversion 20:09:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:09:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:09:36 INFO - Cleaning up... 20:09:36 INFO - Return code: 0 20:09:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:09: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')]} 20:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:36 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 0x7fa98be71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c881d0>, '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 0x2c8b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbe0>, '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': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', '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 20:09:36 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 20:09:36 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 20:09:36 INFO - Using env: {'DISPLAY': ':0', 20:09:36 INFO - 'HOME': '/home/cltbld', 20:09:36 INFO - 'LANG': 'en_US.UTF-8', 20:09:36 INFO - 'LANGUAGE': 'en_US:en', 20:09:36 INFO - 'LOGNAME': 'cltbld', 20:09:36 INFO - 'MAIL': '/var/mail/cltbld', 20:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:36 INFO - 'MOZ_NO_REMOTE': '1', 20:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:36 INFO - 'NO_EM_RESTART': '1', 20:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:09:36 INFO - 'PWD': '/builds/slave/test-pgo', 20:09:36 INFO - 'SHELL': '/bin/bash', 20:09:36 INFO - 'SHLVL': '1', 20:09:36 INFO - 'TERM': 'linux', 20:09:36 INFO - 'TMOUT': '86400', 20:09:36 INFO - 'USER': 'cltbld', 20:09:36 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', 20:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:36 INFO - '_': '/tools/buildbot/bin/python'} 20:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:09:36 INFO - Running setup.py (path:/tmp/pip-oISLjP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:09:36 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)) 20:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:09:36 INFO - Running setup.py (path:/tmp/pip-1Awmp6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:09:36 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)) 20:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:09:36 INFO - Running setup.py (path:/tmp/pip-c6tjii-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:09:36 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)) 20:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:09:36 INFO - Running setup.py (path:/tmp/pip-TBZPn4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:09:36 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)) 20:09:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:09:37 INFO - Running setup.py (path:/tmp/pip-FiWBW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:09:37 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)) 20:09:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:09:37 INFO - Running setup.py (path:/tmp/pip-bO8Fbd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:09:37 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)) 20:09:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:09:37 INFO - Running setup.py (path:/tmp/pip-fD7NME-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:09:37 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)) 20:09:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:09:37 INFO - Running setup.py (path:/tmp/pip-h6AUt5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:09:37 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)) 20:09:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:09:37 INFO - Running setup.py (path:/tmp/pip-zDsodx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:09:37 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)) 20:09:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:09:37 INFO - Running setup.py (path:/tmp/pip-7dSDFn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:09:37 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)) 20:09:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:09:37 INFO - Running setup.py (path:/tmp/pip-5bVvo2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:09:37 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)) 20:09:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:09:37 INFO - Running setup.py (path:/tmp/pip-NEV666-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:09:37 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)) 20:09:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:09:37 INFO - Running setup.py (path:/tmp/pip-0lvgCq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:09:37 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)) 20:09:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:09:37 INFO - Running setup.py (path:/tmp/pip-X7482a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:09:37 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)) 20:09:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:09:37 INFO - Running setup.py (path:/tmp/pip-xSs9iu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:09:37 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)) 20:09:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:09:37 INFO - Running setup.py (path:/tmp/pip-clFnUR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:09:37 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)) 20:09:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:09:37 INFO - Running setup.py (path:/tmp/pip-boszx3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:09:37 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)) 20:09:37 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)) 20:09:37 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)) 20:09:37 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)) 20:09:37 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)) 20:09:37 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)) 20:09:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:09:37 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 20:09:37 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 20:09:37 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 20:09:37 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 20:09:37 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 20:09:37 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 20:09:39 INFO - Downloading blessings-1.6.tar.gz 20:09:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:09:40 INFO - Installing collected packages: blessings 20:09:40 INFO - Running setup.py install for blessings 20:09:40 INFO - Successfully installed blessings 20:09:40 INFO - Cleaning up... 20:09:40 INFO - Return code: 0 20:09:40 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:09:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:09:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:09:40 INFO - Reading from file tmpfile_stdout 20:09:40 INFO - Current package versions: 20:09:40 INFO - argparse == 1.2.1 20:09:40 INFO - blessings == 1.6 20:09:40 INFO - blobuploader == 1.2.4 20:09:40 INFO - docopt == 0.6.1 20:09:40 INFO - manifestparser == 1.1 20:09:40 INFO - mozInstall == 1.12 20:09:40 INFO - mozcrash == 0.17 20:09:40 INFO - mozdebug == 0.1 20:09:40 INFO - mozdevice == 0.48 20:09:40 INFO - mozfile == 1.2 20:09:40 INFO - mozhttpd == 0.7 20:09:40 INFO - mozinfo == 0.9 20:09:40 INFO - mozleak == 0.1 20:09:40 INFO - mozlog == 3.1 20:09:40 INFO - moznetwork == 0.27 20:09:40 INFO - mozprocess == 0.22 20:09:40 INFO - mozprofile == 0.28 20:09:40 INFO - mozrunner == 6.11 20:09:40 INFO - mozscreenshot == 0.1 20:09:40 INFO - mozsystemmonitor == 0.0 20:09:40 INFO - moztest == 0.7 20:09:40 INFO - mozversion == 1.4 20:09:40 INFO - psutil == 3.1.1 20:09:40 INFO - requests == 1.2.3 20:09:40 INFO - wsgiref == 0.1.2 20:09:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fa98be71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c881d0>, '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 0x2c8b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbe0>, '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': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', '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 20:09:40 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 20:09:40 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 20:09:40 INFO - Using env: {'DISPLAY': ':0', 20:09:40 INFO - 'HOME': '/home/cltbld', 20:09:40 INFO - 'LANG': 'en_US.UTF-8', 20:09:40 INFO - 'LANGUAGE': 'en_US:en', 20:09:40 INFO - 'LOGNAME': 'cltbld', 20:09:40 INFO - 'MAIL': '/var/mail/cltbld', 20:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:40 INFO - 'MOZ_NO_REMOTE': '1', 20:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:40 INFO - 'NO_EM_RESTART': '1', 20:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:09:40 INFO - 'PWD': '/builds/slave/test-pgo', 20:09:40 INFO - 'SHELL': '/bin/bash', 20:09:40 INFO - 'SHLVL': '1', 20:09:40 INFO - 'TERM': 'linux', 20:09:40 INFO - 'TMOUT': '86400', 20:09:40 INFO - 'USER': 'cltbld', 20:09:40 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', 20:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:40 INFO - '_': '/tools/buildbot/bin/python'} 20:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:40 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)) 20:09:40 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)) 20:09:40 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)) 20:09:40 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)) 20:09:40 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)) 20:09:40 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)) 20:09:40 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)) 20:09:40 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)) 20:09:40 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)) 20:09:40 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)) 20:09:40 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)) 20:09:40 INFO - Cleaning up... 20:09:40 INFO - Return code: 0 20:09:40 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98be71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c881d0>, '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 0x2c8b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbe0>, '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': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', '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 20:09:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 20:09:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:09:40 INFO - Using env: {'DISPLAY': ':0', 20:09:40 INFO - 'HOME': '/home/cltbld', 20:09:40 INFO - 'LANG': 'en_US.UTF-8', 20:09:40 INFO - 'LANGUAGE': 'en_US:en', 20:09:40 INFO - 'LOGNAME': 'cltbld', 20:09:40 INFO - 'MAIL': '/var/mail/cltbld', 20:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:40 INFO - 'MOZ_NO_REMOTE': '1', 20:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:40 INFO - 'NO_EM_RESTART': '1', 20:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:09:40 INFO - 'PWD': '/builds/slave/test-pgo', 20:09:40 INFO - 'SHELL': '/bin/bash', 20:09:40 INFO - 'SHLVL': '1', 20:09:40 INFO - 'TERM': 'linux', 20:09:40 INFO - 'TMOUT': '86400', 20:09:40 INFO - 'USER': 'cltbld', 20:09:40 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', 20:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:40 INFO - '_': '/tools/buildbot/bin/python'} 20:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:40 INFO - Downloading/unpacking jsonschema 20:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:09:42 INFO - Downloading/unpacking functools32 (from jsonschema) 20:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:42 INFO - Downloading functools32-3.2.3-2.tar.gz 20:09:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:09:42 INFO - warning: no files found matching '*.txt' 20:09:42 INFO - no previously-included directories found matching 'build' 20:09:42 INFO - no previously-included directories found matching 'dist' 20:09:42 INFO - no previously-included directories found matching '.git*' 20:09:42 INFO - Installing collected packages: jsonschema, functools32 20:09:43 INFO - Running setup.py install for functools32 20:09:43 INFO - warning: no files found matching '*.txt' 20:09:43 INFO - no previously-included directories found matching 'build' 20:09:43 INFO - no previously-included directories found matching 'dist' 20:09:43 INFO - no previously-included directories found matching '.git*' 20:09:43 INFO - Successfully installed jsonschema functools32 20:09:43 INFO - Cleaning up... 20:09:43 INFO - Return code: 0 20:09:43 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:09: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')]} 20:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98be71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c881d0>, '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 0x2c8b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbe0>, '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': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', '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 20:09: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', 'flake8'] in /builds/slave/test-pgo/build 20:09: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 flake8 20:09:43 INFO - Using env: {'DISPLAY': ':0', 20:09:43 INFO - 'HOME': '/home/cltbld', 20:09:43 INFO - 'LANG': 'en_US.UTF-8', 20:09:43 INFO - 'LANGUAGE': 'en_US:en', 20:09:43 INFO - 'LOGNAME': 'cltbld', 20:09:43 INFO - 'MAIL': '/var/mail/cltbld', 20:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:43 INFO - 'MOZ_NO_REMOTE': '1', 20:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:43 INFO - 'NO_EM_RESTART': '1', 20:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:09:43 INFO - 'PWD': '/builds/slave/test-pgo', 20:09:43 INFO - 'SHELL': '/bin/bash', 20:09:43 INFO - 'SHLVL': '1', 20:09:43 INFO - 'TERM': 'linux', 20:09:43 INFO - 'TMOUT': '86400', 20:09:43 INFO - 'USER': 'cltbld', 20:09:43 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', 20:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:43 INFO - '_': '/tools/buildbot/bin/python'} 20:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:43 INFO - Downloading/unpacking flake8 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:09:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:09:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:09:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:09:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:09:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:09:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:09:45 INFO - no previously-included directories found matching 'docs/_build' 20:09:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:09:46 INFO - Running setup.py install for pep8 20:09:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:09:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:09:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:09:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:09:46 INFO - no previously-included directories found matching 'docs/_build' 20:09:46 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:09:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:09:46 INFO - Cleaning up... 20:09:46 INFO - Return code: 0 20:09:46 INFO - Running post-action listener: _resource_record_post_action 20:09:46 INFO - Running post-action listener: _start_resource_monitoring 20:09:46 INFO - Starting resource monitoring. 20:09:46 INFO - ##### 20:09:46 INFO - ##### Running install step. 20:09:46 INFO - ##### 20:09:46 INFO - Running pre-action listener: _resource_record_pre_action 20:09:46 INFO - Running main action method: install 20:09:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:09:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:09:46 INFO - Reading from file tmpfile_stdout 20:09:46 INFO - Detecting whether we're running mozinstall >=1.0... 20:09:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:09:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:09:46 INFO - Reading from file tmpfile_stdout 20:09:46 INFO - Output received: 20:09:46 INFO - Usage: mozinstall [options] installer 20:09:46 INFO - Options: 20:09:46 INFO - -h, --help show this help message and exit 20:09:46 INFO - -d DEST, --destination=DEST 20:09:46 INFO - Directory to install application into. [default: 20:09:46 INFO - "/builds/slave/test-pgo"] 20:09:46 INFO - --app=APP Application being installed. [default: firefox] 20:09:46 INFO - mkdir: /builds/slave/test-pgo/build/application 20:09:46 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'] 20:09:46 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 20:10:02 INFO - Reading from file tmpfile_stdout 20:10:02 INFO - Output received: 20:10:02 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:10:02 INFO - Running post-action listener: _resource_record_post_action 20:10:02 INFO - ##### 20:10:02 INFO - ##### Running run-tests step. 20:10:02 INFO - ##### 20:10:02 INFO - Running pre-action listener: _resource_record_pre_action 20:10:02 INFO - Running main action method: run_tests 20:10:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:10:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:10:02 INFO - Python 2.7.3 20:10:02 INFO - Return code: 0 20:10:02 INFO - grabbing minidump binary from tooltool 20:10:02 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')]} 20:10:02 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 0x2c881d0>, '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 0x2c8b750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8bbe0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:10:02 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 20:10:02 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 20:10:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:10:03 INFO - Return code: 0 20:10:03 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:10:03 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:10:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:10:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:10:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:10:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:10:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:10:04 INFO - Return code: 0 20:10:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 20:10:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 20:10:04 INFO - Using env: {'DISPLAY': ':0', 20:10:04 INFO - 'HOME': '/home/cltbld', 20:10:04 INFO - 'LANG': 'en_US.UTF-8', 20:10:04 INFO - 'LANGUAGE': 'en_US:en', 20:10:04 INFO - 'LOGNAME': 'cltbld', 20:10:04 INFO - 'MAIL': '/var/mail/cltbld', 20:10:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:10:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:04 INFO - 'MOZ_NO_REMOTE': '1', 20:10:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:04 INFO - 'NO_EM_RESTART': '1', 20:10:04 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:10:04 INFO - 'PWD': '/builds/slave/test-pgo', 20:10:04 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:10:04 INFO - 'SHELL': '/bin/bash', 20:10:04 INFO - 'SHLVL': '1', 20:10:04 INFO - 'TERM': 'linux', 20:10:04 INFO - 'TMOUT': '86400', 20:10:04 INFO - 'USER': 'cltbld', 20:10:04 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404', 20:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:04 INFO - '_': '/tools/buildbot/bin/python'} 20:10:04 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 20:10:04 INFO - mozversion application_buildid: 20160321173022 20:10:04 INFO - mozversion application_changeset: 98189434eea16c181df0c7e8d60af76feceaf492 20:10:04 INFO - mozversion application_display_name: Nightly 20:10:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:10:04 INFO - mozversion application_name: Firefox 20:10:04 INFO - mozversion application_remotingname: firefox 20:10:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:10:04 INFO - mozversion application_vendor: Mozilla 20:10:04 INFO - mozversion application_version: 48.0a1 20:10:04 INFO - mozversion platform_buildid: 20160321173022 20:10:04 INFO - mozversion platform_changeset: 98189434eea16c181df0c7e8d60af76feceaf492 20:10:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:10:04 INFO - mozversion platform_version: 48.0a1 20:10:04 INFO - using testdate: 1458616204 20:10:04 INFO - actual date: 1458616204 20:10:04 INFO - starting webserver on 'localhost:41304' 20:10:04 INFO - SUITE-START | Running 2 tests 20:10:04 INFO - TEST-START | dromaeo_css 20:10:04 INFO - operating with platform_type : linux_ 20:10:04 INFO - Initialising browser for dromaeo_css test... 20:10:04 INFO - TEST-INFO | started process 3275 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp04hVXA/profile http://localhost:41304/getInfo.html) 20:10:10 INFO - PROCESS | 3275 | __metrics Screen width/height:1600/1200 20:10:10 INFO - PROCESS | 3275 | colorDepth:24 20:10:10 INFO - PROCESS | 3275 | Browser inner width/height: 1024/697 20:10:10 INFO - PROCESS | 3275 | __metrics 20:10:11 ERROR - PROCESS | 3275 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:10:12 INFO - TEST-INFO | 3275: exit 0 20:10:12 INFO - Browser initialized. 20:10:12 INFO - Running cycle 1/1 for dromaeo_css test... 20:10:12 INFO - TEST-INFO | started process 3372 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp04hVXA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:23 INFO - PROCESS | 3372 | RSS: Main: 155660288 20:10:23 INFO - PROCESS | 3372 | 20:11:14 INFO - PROCESS | 3372 | 1458616274749 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] 20:13:22 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:41304/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41304/tests/dromaeo/cssquery-ext.html) 20:13:23 INFO - PROCESS | 3372 | RSS: Main: 252461056 20:13:23 INFO - PROCESS | 3372 | 20:16:25 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:41304/tests/dromaeo/cssquery-ext.html (next: http://localhost:41304/tests/dromaeo/cssquery-jquery.html) 20:16:26 INFO - PROCESS | 3372 | RSS: Main: 233197568 20:16:26 INFO - PROCESS | 3372 | 20:19:28 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:41304/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41304/tests/dromaeo/cssquery-mootools.html) 20:19:28 INFO - PROCESS | 3372 | RSS: Main: 228327424 20:19:28 INFO - PROCESS | 3372 | 20:22:30 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:41304/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41304/tests/dromaeo/cssquery-prototype.html) 20:22:31 INFO - PROCESS | 3372 | RSS: Main: 221958144 20:22:31 INFO - PROCESS | 3372 | 20:25:33 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:41304/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41304/tests/dromaeo/cssquery-yui.html) 20:25:34 INFO - PROCESS | 3372 | RSS: Main: 221786112 20:25:34 INFO - PROCESS | 3372 | 20:28:36 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:41304/tests/dromaeo/cssquery-yui.html (next: http://localhost:41304/tests/dromaeo/cssquery-dojo.html) 20:28:37 INFO - PROCESS | 3372 | RSS: Main: 258707456 20:28:37 INFO - PROCESS | 3372 | 20:28:37 INFO - PROCESS | 3372 | __start_tp_report 20:28:37 INFO - PROCESS | 3372 | _x_x_mozilla_page_load 20:28:37 INFO - PROCESS | 3372 | _x_x_mozilla_page_load_details 20:28:37 INFO - PROCESS | 3372 | |i|pagename|runs| 20:28:37 INFO - PROCESS | 3372 | |0;dojo.html;3058.2965917838897;3098.5662007318965;3110.5023196288585;3136.796108252963;3158.936821263575;5266.183741520061;5345.251664766935;5376.51611354978;5377.758000889964;5422.1595652673805;5369.140937450009;5398.568114550836;5443.292371991645;5445.1832225166245;5473.562115030798;4817.831375901844;4832.903341933168;4837.080954618611;4849.0301939612045;4952.380952380952;4919.926201106986;4937.827176048839;4978.87552811179;4985.102681517325;4997.225430058346;4786.329913812069;4839.37088178538;4911.926321105187;4921.704697718148;4942.308076869242;4847.442544107403;4850.75746212688;4850.95149048512;4856.562909338177;4891.4863939286215;4808.855734327975;4827.879303017417;4842.58837998767;4846.9515304846855;4892.877678058041;5317.574594032507;5359.732013399314;5364.624476286662;5375.11310633745;5391.406945236021;5662.462066103713;5662.6036177467595;5668.97165514174;5673.6879471629045;5674.602777805555;5649.774009039634;5705.315362156526;5707.029804933171;5712.22884910536;5748.942510574882;5394.109971854639;5396.514313711785;5416.8104116356135;5421.5391691706645;5432.6740395576;5875.706214689334;5876.853078673067;5877.647341159544;5880.323762767336;5885;5504.146857237135;5634.3802181759975;5635.492805647429;5662.915056274159;5726.398728133486;5768.855778605568;5800.158976948319;5804.6807425592;5806.21616081832;5832.708364581838;5724.16999535065;5739.225204597409;5767.394423585547;5767.452092051249;5775.162601422854;5493.368262649767;5681.289838770153;5727.3699893011735;5738.856528586819;5791.247137872049;4361.498427680794;4369.584889435562;4380.649548036149;4383;4407.27279998803;3854.1520865409566;3905.1213476968023;3914.5106861642294;3919.470871432377;3938.448617193595;5293.994141113176;5457.045017121988;5485.890282194334;5524.972375138099;5537.750801213955;5785.4214578541805;5787.623804452697;5788.27646544182;5790.681512516852;5814.9709251454315;5249.921251181236;5429.995450841607;5459.454054594509;5466.945330546644;5470.480304371078;4919.163742163841;4953.578945789648;4957.7769000395065;4984.925226121611;4986.276989836453;5893.086571581412;5920.5559583031445;5921.644701317935;5954.285485741652;5968.074948383008;5673.8297851064535;5698.116791897262;5734.598578099576;5740.6268592541355;5754.165645981393;5998.130271110752;6064.7877324295205;6089.025755879038;6113.84715382119;6118.694065296629;5716.771329146787;5745.856353591026;5750.25246717924;5752.28096487939;5766.711664416846;5572.777088916398;5793.217915581511;5836.533077353886;5845.18167456548;5852.356240813422;5655.066913959151;5691.914621280601;5710.2862142232225;5744.0522313817755;5754.56840736938;5597.524210442158;5597.636153650163;5621.072523033654;5623.522000629992;5633.0987042073075;5409.756560954846;5481.424450432806;5486.341639003345;5488.588355873246;5489.58828087903;5667.773289068391;5674.74463649145;5682.857928551819;5696.658200507983;5781.537477001746;5521.751521181637;5570.972145139248;5571.832845014656;5579.302587176603;5591.329040515164 20:28:37 INFO - PROCESS | 3372 | |1;ext.html;553.0323519262872;558.8882223555285;571.5998800839412;577.2293987526651;586.6685322792622;29379.853100734494;38136;38563.80718096409;38980.41529377062;39023.60976390235;41899.581004189946;42361.152776944444;42371.152576948516;42411.15177696444;42467;7387.4090072794315;8679.913200868004;8797.780055498632;8835.337349698766;8867.113288671146;10556.894431055667;10766.892331076706;10772.892271077268;10782.946085269563;10784.029437350637;10450.16398688103;10550.736231594195;10552.78894422111;10556.894431055707;10566.260361774679;10360.533775980099;10425.947870260676;10441.42572158531;10441.84337234942;10455.68632941013;10193.847092293621;10252.794944101077;10266.12737917278;10300.22748293881;10313.226508011854;41714;41996.58003419957;42040.57959420397;42518.57481425177;42540.787296063325;3364.7812892162174;3370.1069216657606;3462.3248466549035;3643.3259846928404;3755.643213894703;30306.242343941358;31027.689723102707;31386.37227255442;32997.50503742446;33628.327433451435;4314.460692413449;4320.373545835836;4359.258925982591;4438.3564383164585;4448.488423831269;238416;240919;241233.99999999825;241853;243701;49786.75106624516;50508.24237636438;50591.49408505868;61453.69273153606;62079;51050.489495105314;51081.233781493305;51120.48879511232;51129.74435127801;51203.487965120614;14361.066530675682;14423.85576144246;14436.855631443761;14440.133591984515;14450.205238711762;12646.177998430072;12773.744525109445;12782.872171278354;12784.552540661032;12795.61613151607;16698.666026679643;16763.580910477336;16890.239939202766;16894.15529223534;16894.74657880133;6584.539082264291;6633.2371777246235;6741.393274605309;6845.657717114224;6889.414399776075;1087.1737479515625;1092.748667806409;1114.0920150077661;1154.4747140051256;1178.5992762460805;31591.684083159333;31605.525917111263;32078.358432831214;32112.678873211436;32424.35151296961;1152.9192956492966;1165.1028707894873;1170.169179882293;1209.6975756060986;1231.5812623707982;16252.456016678396;16625.6674866502;16652.75020874688;16673.333066677198;16867;385721;386059;390263;390558;391206;55829.72085139548;55888.441115589136;56122.15816762752;56203.43796562064;56248.71875640677;1256.7926292161692;1360.6530334764573;1372.0875617714307;1404.1013751199037;1406.9929650351683;28008.859955700093;28965.710342897146;29051.85474072616;29586.704132958395;30089.849550752107;41317.58682413257;41576.58423415727;41654;41658.37512437255;41677;213506;215408;216441;216935;217050;31426.21434464157;34976.65023349734;36021;36416.63583364239;36944.63055369412;41234.1753164929;41650.791746041075;42037.36943945782;42298.71266091739;42340.36489452599;37359.626403735616;37530.437043443824;37702.05744856291;37771.244575108896;37986.43020354752;37161.25677486381;37550.81224593969;38313;39070.4139437903;39150.60849391584;38829.805850970566;39441.802790985865;39478.802605986784;40133.598664012985;40391.39412908867;33580;34605.826970865994;34686;35059.298814024085;35144.824275878455;26946.865265673547;27002.459950801265;27141.321466963484;27197.72802271952;27820.30449238785 20:28:37 INFO - PROCESS | 3372 | |2;jquery.html;369.65621971566435;372.56782132726033;372.86017743346264;375.56059410489723;376.9990674758515;18089.1859866306;18577.814221857796;18790.62418751624;18976.715349269736;19009.619807603838;17933.372331968385;18212.180451879663;19032.14355354009;19049.809271933733;19074.523136921584;5439.864003399917;5574.386817450078;5596.692181929992;5610.943890561103;5611.691356975365;3985.382265748799;5474.972625136868;5910.763569457238;6176.81469555914;6200.317965023866;6130.969345153268;6131.540134489909;6146.200993870812;6154.476869466101;6161.476274516649;5897.144913987469;6058.575899687024;6063.211782468273;6066.878662426749;6075.27096748393;3589.1565482111682;5083.974580127076;5299;5380.757865896044;5387.622866399353;21409.357719268446;21614.35156945294;21751.238706645192;22715.659265111037;22773.08907643692;2343.238447504551;2398.280515845257;2402.6516155157406;2416.4804567018177;3128.9530657040164;13887.4445022199;13892.305384730824;13932.303384830819;14346.64133396663;14691.926540367336;1970.753655793026;1988.9801101989085;2019.2629690163133;2050.2721533855415;2097.549026959211;65871.67064164697;70889;71288;71971;72003.63998179976;10540.420276884844;10683.14534837211;10943.507542160622;11001.22991390611;11152.271397933171;13887.652808679864;14097.154170749787;14099.462096822464;14120.71758564823;14122.576322710334;8322.791930201793;8595.44129631572;8709.303255739525;8751.518666473405;8752.69365572202;7546.735864244725;7662.1571627120975;7791.727289544839;8347.582620868932;8506.617202225914;6523.575967562093;6676.76479851229;6723.529352945345;6751.459883209332;6827.112475378169;1722.776039114932;1798.4514723009609;1817.6637322095455;1832.3553815502291;1865.1606776950428;971.5579411367811;971.8396464583265;1009.6668099527285;1030.4538594544904;1103.906167975715;17804;17950.640987180184;18072.277108915758;18316;18419;1000.4597517340554;1000.6447711062614;1036.6423583863555;1039.667306461925;1042.7080417483116;9034.096590340914;10242.692719218436;10307.433091179908;10357.223208259411;10497.842532362021;451779;462700;464523;468378.2135250568;474468;75052.24947750561;77432.2256777425;79666.6016669913;81125.59437202776;81962;985.9211263098935;997.9051990060933;1061.5912873543587;1072.9034386905216;1075.6127793994156;15654.608634784221;15823.454276932516;15885.967412118176;16215.270312835715;16343.754843677116;34669.30661386708;35310.646893530735;36430.63569364379;37834.43248351332;38472.6152738469;43559;43980.560194398924;44305;44593.33110003417;45075;8159.592020399075;8311.335093192409;8312.6674933002;8501.19238672325;8515.446495977989;12153.878461215629;12208.75582488363;12250.203736757083;12664.240145591293;12861;8146;10338.276320657482;10875.945620272165;11025.889741102486;11193.216474846682;10700;10911.672649820519;11071.280366776135;11144;11363.090952723596;10754.946225268823;10986.395748233925;11095.556177753122;11470.885291146982;11501.891166727604;7842;8012.879806803019;8079.676812927417;8089.595520223847;8342.708005219789;10745.345936329179;10825.186387836246;10868.836967445337;11609.825852612048;11947.940260298643 20:28:37 INFO - PROCESS | 3372 | |3;mootools.html;1350.4395675794547;1484.539792664274;1507.1559926441191;1674;1810.5383127302543;7839.686412543499;8023;8028.558429286387;8029.47808392454;8033.638486268117;7846.2153784621505;7950.36397088233;7978.481398709095;8012.519248845073;8016.398770092237;2051.579426217622;2094.465911192644;2336.8247381446376;2353.6116540770754;2382.344855164835;2383.6543701163323;2391.1869964212165;2400.639904014403;2403.5553422616786;2403.867787271708;2296.9540609187807;2313;2366.219147681261;2366.810655147584;2367.1478267823654;2293.9655905161353;2296.0700916129076;2304.2511183865313;2375.928722138339;2384.201292566992;2323.59337116004;2327.6392159215347;2351.0595761695286;2351.2828587280874;2410.8915098820594;8292.212239837207;8363.28912042471;8376.371772117116;8385.035720892054;8391.790205244857;5178.533931946143;5246.632735708502;5286.762095705664;5295.523402893758;5303.018941495836;3496.0735405117666;3558.430651095812;3597.5143355646915;3648.343298206322;3674.026383008505;1149.6953307373553;1165.877582853805;1185.3125187391292;1193.582246213827;1216.7748966441236;11824.172307938361;11838.052955763518;11887.286762794174;11888.762224755457;11901.166918315721;4756.208478329691;4797.280407938767;4801.255805350176;4821.879453013703;4857;9982.201423886072;9989.200863930868;10002.849957250646;10004.399736015863;10028.899711002796;5276.498732620395;5281.709505977208;5286.259923610698;5328.094223981932;5329.467053294639;4149.792510374469;4692.929606055912;4780.521947805191;4782;4839.201531747292;3950.466686997276;4027.154297597537;4044.1911617676583;4065.1869626074904;4086.0602061526015;1277.8019406991932;1290.864459231786;1298.8636193199768;1299.5191779041816;1303.2506308872437;1129.6102844518628;1162.68607475981;1351.4661708625038;1373.1074801379184;1384.7507448659137;7854.410919181084;7946.682132714743;7970.9202907970175;7982;7982.800429989181;506.38980029065624;507.621821742804;509.35566508366946;1257.4844313831286;1286.8906142977764;6167.444929956326;6274.968625156845;6309.085182648582;6327.651979141191;6340.841478963062;9534.713958581253;9759.756006099762;9855.90144098564;9888.110070093582;9916.405015698936;9705.223582113415;9764.462954537568;9784.657536986171;10130.277852765048;10184.338018028804;7904.604769761604;8001.959990200012;8033.317168040782;8038.276555110068;8097.190280971973;7553.924460755322;7616.885746713693;7658.157602663814;7659.693612255447;7683.0780306363595;9034.819303614022;9195;9255.861162082709;9308.860367094634;9312.674056407994;9290.210332121846;9372.67195648149;9699.806003880023;9742.610295588098;9751.951240243754;6130.2030736004035;6755.763548275787;6949.339812717783;7141.107361579802;7239.782806515813;7837;7838.882416763639;7855.7250496232355;7857.646405911862;7877.094134174643;6769.1876974763345;6867.690953907186;6872.862542749217;7023.578585284899;7041.894371584533;6992.056072430157;7043.7182512700965;7046.401055910305;7129.964350178423;7135.357817796424;7223.1693355264815;7242.891356629761;7365.558066516026;7426.925730742623;7437.219091995263;6985.685644146127;6996.720131194696;7023.157221133497;7028.121484814398;7055.611941343275;6758;6759.797206083826;6816.216135144522;6944.51388402807;6944.965275173592 20:28:37 INFO - PROCESS | 3372 | |4;prototype.html;342.912557297889;345.85819813876316;346.41801773021314;351.1975136812383;353.25815786847625;6020.157177995079;6036.909446358308;6068.575199736015;6080.665563394023;6110.786122485714;5991.071383935486;6001.03983362661;6008.098785182225;6009.369016253296;6011.729472173752;4379.58393952574;4500.347449619803;4527.456705195381;4617.538246175381;4631;4585;4589.931151032721;4647.837325693601;4653.604443622279;4657.32468792025;4559.065391594731;4569.543045695421;4583.564561366665;4587.472440669332;4594.563516465931;4335.6965012449145;4451.354553589727;4557.156925968673;4582.335561343587;4583.564561366698;4010.8195131219163;4014.759114453113;4019.718619696622;4023.436718859362;4024.3963405489117;5761.798337058225;5769.971150144264;5771.855703607402;5774.364819869811;5777.335606405275;5317.973410132963;5327.760250788724;5329.440408757102;5331.306930099101;5331.813386531453;6259.624422534617;6270.683156537133;6275.497960163221;6276.3409841966395;6276.780312689079;4375.299952007664;4472.396226509412;4486.932696009562;4487.910241795178;4489.595936365743;6495.285518592951;6511.967440162816;6538.215414150332;6553.737850485975;6557.737690492375;4582.152301824107;4583.610393116623;4588.839390621312;4591.219492686251;4593.242115050979;4642.79107440166;4648.349231107648;4651.465081515601;4651.744154071558;4655.208614535537;5318.44156363584;5332.9466705333225;5334.1732031535175;5336.91994620081;5340.332458442695;6177.4749146322165;6336.936630633634;6343.175387199634;6353.618782873043;6415.647139407284;1582.8654564361927;1593.4661888267328;1598.8720902327786;1602.6233835048754;1608.7586861970565;997.2719914462483;1042.9895701043044;1053.989460105389;1072.3137192197;1079.2067830144838;6036.577439579188;6039.033754599243;6039.365866584033;6043.244594425697;6049;6464;6555;6580.605163690194;6586.50601204902;6587.53887227899;6057.091436284592;6090.512758979271;6091.48222401092;6096.237970253718;6098.26820781509;3472.236108056274;3501.8774342897877;3502.141975216088;3506.561679790026;3509.175343794206;6660.533762636665;6728.697208625624;6862.9313706862295;6864.897026544606;6869.347411995853;6688.498362622823;6704.497162712719;6713.295104014106;6717.361850624281;6718.05947167397;6765.323467653196;6775.1192344995825;6778.356056174655;6779.796606101825;6785.8642827143185;6578.901316480161;6583.111279977142;6587.571807832475;6594.604323740591;6613.867722645424;6308.621482711052;6525.119108920425;6526.347365263436;6537.7058032389605;6556.868862622626;6830.7609233676585;6838.213605435439;6840.144981877265;6870.3473170048765;6884.690188941409;4487.192305385062;4516.209663308842;4517.051419202005;4517.661175411923;4525.502194758508;6533.901991470037;6559.114519539801;6571.474282057328;6578.736850525926;6582.670866456562;6243.063540468966;6417.743290268524;6432.646204458612;6438.7746428876635;6439.484841212786;6347.111404403295;6380.298167201697;6384.680765961591;6386;6391.360863913757;6180.907286390618;6206.224221972254;6212.968935155295;6215.689215539295;6217.129601855834;6411.455026322628;6412.871742565216;6415.230172379344;6416.647084410216;6420.743170273324;6003.939960600338;6081.179040829608;6191.659458729813;6263.718132683949;6265.96867015662 20:28:37 INFO - PROCESS | 3372 | |5;yui.html;740.7185269597553;758.6586036283674;810.752720420272;844.5144042175747;852.071242345843;14551.345189466472;14585.270736463173;14878.032927859682;14917.776233356508;14938.850611493868;13935.790963135536;13998.230097344642;14030.929845350784;14038.859611403883;14047.508337208199;658.298911659084;838.4424357802054;856.7258477287271;860.1785295043219;860.535310932096;849.362977766675;851.7572491839827;852.3522123186392;854.4147259127486;855.6962278391175;694.6561452081202;889.1997202517721;897;898.3442087276293;899.0200681257428;874.4272501511489;886.246690313235;887.3699673232013;887.5784002598714;888.3825741109931;640.7533099756581;646.0277282689523;646.8770933522616;647.123148134276;647.1716203259834;14885.70228595422;14970.775438368433;14984.250787460584;14989.175595342253;14997.250137493082;14258.500952466615;14524.419023239057;14561.271936403244;14576.854231457655;14579.125252484884;11446.255993360488;11518.94240528792;11602.4198790061;11717.70705732355;11878.881211187863;3833.769973801581;3880.185161116169;3901.7854018028997;3921.4117882317596;3994.4407782910416;54852;55066.17400738992;55510.99999999959;56117.43882561163;56352.71823640897;11367.943160284145;11481.425928703531;11577;11610.94194529022;11677.299362038304;20459.181632734522;20466.59066818685;20472.283470078477;20476.897615511825;20490;8298.8340233195;8640.222379985831;8695.695650652324;8739.475631462132;8770.561471926378;4660.13787449323;4697.882552936204;4727.333954004302;4792.640551958617;4864.100141473838;3369.5451114099774;3425.8523394663066;3431;3437.6218615952225;3439.8280085995602;583.1340459417761;594.8691287916652;597.2593983460478;605.8121982185537;610.6031079798166;719.9928000720031;739.2496615934831;750.8873668949592;759.506320891425;774.3882332957013;8664.610092545725;8665.740027799176;8741;8763.780905477286;8851.159139881702;690.8617827822881;691.5574032619128;716.1227496317074;721.7257442171941;736.5102207032263;3947.6249756273683;3970.5433875104154;4010.9197816044098;4050.5544390117066;4056.513218413809;65050.349496505376;66451.33548664452;66959.66520167465;67220.32779672238;68431;54319.72840135774;59023.704881475314;59080;59837;59868.401315987154;52062.73968630133;52378.21432678513;52629;52988.73505632524;54150.45849541454;8063.516189028677;8074.192580741878;8141.59292035384;8147.266745992889;8209.83580328402;36515.452268215464;39209;40417.39373909453;40879.59120408877;41424.58575414207;45992.16031358708;50265.74867125641;50724.49275507198;51154;51618.483815161366;11426.314421134759;11509.482073306554;11874.99999999993;11882.940585297018;11917.582884598998;13027.47890084386;13051.28217948022;13600.183988960694;13923.860761392662;14314.141151530941;12984.805227921399;13143.211407315592;13482.19106853592;13518.459261629425;13756.380962856496;12926.547570834975;13063;13081.934590326988;13268.203907765565;13705.862941370458;12527.93736031314;13003.47986080584;13252.403641836334;13253.204807711569;13623.931880340931;10982.395968221825;11158.55365785392;11410.372429516456;11491.712707182387;11830.940845295718;10458.68623941283;10527.4736263185;10600.522976465923;10744.974221653849;10819.729506762395 20:28:37 INFO - PROCESS | 3372 | __end_tp_report 20:28:37 INFO - PROCESS | 3372 | __start_cc_report 20:28:37 INFO - PROCESS | 3372 | _x_x_mozilla_cycle_collect,775 20:28:37 INFO - PROCESS | 3372 | __end_cc_report 20:28:37 INFO - PROCESS | 3372 | __startTimestamp1458617317086__endTimestamp 20:28:37 INFO - PROCESS | 3372 | 20:28:37 INFO - PROCESS | 3372 | ------- Summary: start ------- 20:28:37 INFO - PROCESS | 3372 | Number of tests: 6 20:28:37 INFO - PROCESS | 3372 | 20:28:37 INFO - PROCESS | 3372 | [#0] dojo.html Cycles:165 Average:5346.65 Median:5537.75 stddev:614.37 (11.1%) stddev-sans-first:589.45 20:28:37 INFO - PROCESS | 3372 | Values: 3058.3 3098.6 3110.5 3136.8 3158.9 5266.2 5345.3 5376.5 5377.8 5422.2 5369.1 5398.6 5443.3 5445.2 5473.6 4817.8 4832.9 4837.1 4849.0 4952.4 4919.9 4937.8 4978.9 4985.1 4997.2 4786.3 4839.4 4911.9 4921.7 4942.3 4847.4 4850.8 4851.0 4856.6 4891.5 4808.9 4827.9 4842.6 4847.0 4892.9 5317.6 5359.7 5364.6 5375.1 5391.4 5662.5 5662.6 5669.0 5673.7 5674.6 5649.8 5705.3 5707.0 5712.2 5748.9 5394.1 5396.5 5416.8 5421.5 5432.7 5875.7 5876.9 5877.6 5880.3 5885.0 5504.1 5634.4 5635.5 5662.9 5726.4 5768.9 5800.2 5804.7 5806.2 5832.7 5724.2 5739.2 5767.4 5767.5 5775.2 5493.4 5681.3 5727.4 5738.9 5791.2 4361.5 4369.6 4380.6 4383.0 4407.3 3854.2 3905.1 3914.5 3919.5 3938.4 5294.0 5457.0 5485.9 5525.0 5537.8 5785.4 5787.6 5788.3 5790.7 5815.0 5249.9 5430.0 5459.5 5466.9 5470.5 4919.2 4953.6 4957.8 4984.9 4986.3 5893.1 5920.6 5921.6 5954.3 5968.1 5673.8 5698.1 5734.6 5740.6 5754.2 5998.1 6064.8 6089.0 6113.8 6118.7 5716.8 5745.9 5750.3 5752.3 5766.7 5572.8 5793.2 5836.5 5845.2 5852.4 5655.1 5691.9 5710.3 5744.1 5754.6 5597.5 5597.6 5621.1 5623.5 5633.1 5409.8 5481.4 5486.3 5488.6 5489.6 5667.8 5674.7 5682.9 5696.7 5781.5 5521.8 5571.0 5571.8 5579.3 5591.3 20:28:37 INFO - PROCESS | 3372 | 20:28:37 INFO - PROCESS | 3372 | [#1] ext.html Cycles:180 Average:45783.12 Median:19034.08 stddev:76542.74 (402.1%) stddev-sans-first:76682.12 20:28:37 INFO - PROCESS | 3372 | Values: 553.0 558.9 571.6 577.2 586.7 29379.9 38136.0 38563.8 38980.4 39023.6 41899.6 42361.2 42371.2 42411.2 42467.0 7387.4 8679.9 8797.8 8835.3 8867.1 10556.9 10766.9 10772.9 10782.9 10784.0 10450.2 10550.7 10552.8 10556.9 10566.3 10360.5 10425.9 10441.4 10441.8 10455.7 10193.8 10252.8 10266.1 10300.2 10313.2 41714.0 41996.6 42040.6 42518.6 42540.8 3364.8 3370.1 3462.3 3643.3 3755.6 30306.2 31027.7 31386.4 32997.5 33628.3 4314.5 4320.4 4359.3 4438.4 4448.5 238416.0 240919.0 241234.0 241853.0 243701.0 49786.8 50508.2 50591.5 61453.7 62079.0 51050.5 51081.2 51120.5 51129.7 51203.5 14361.1 14423.9 14436.9 14440.1 14450.2 12646.2 12773.7 12782.9 12784.6 12795.6 16698.7 16763.6 16890.2 16894.2 16894.7 6584.5 6633.2 6741.4 6845.7 6889.4 1087.2 1092.7 1114.1 1154.5 1178.6 31591.7 31605.5 32078.4 32112.7 32424.4 1152.9 1165.1 1170.2 1209.7 1231.6 16252.5 16625.7 16652.8 16673.3 16867.0 385721.0 386059.0 390263.0 390558.0 391206.0 55829.7 55888.4 56122.2 56203.4 56248.7 1256.8 1360.7 1372.1 1404.1 1407.0 28008.9 28965.7 29051.9 29586.7 30089.8 41317.6 41576.6 41654.0 41658.4 41677.0 213506.0 215408.0 216441.0 216935.0 217050.0 31426.2 34976.7 36021.0 36416.6 36944.6 41234.2 41650.8 42037.4 42298.7 42340.4 37359.6 37530.4 37702.1 37771.2 37986.4 37161.3 37550.8 38313.0 39070.4 39150.6 38829.8 39441.8 39478.8 40133.6 40391.4 33580.0 34605.8 34686.0 35059.3 35144.8 26946.9 27002.5 27141.3 27197.7 27820.3 20:28:37 INFO - PROCESS | 3372 | 20:28:37 INFO - PROCESS | 3372 | [#2] jquery.html Cycles:180 Average:26979.85 Median:2400.47 stddev:76136.74 (3171.7%) stddev-sans-first:76324.11 20:28:37 INFO - PROCESS | 3372 | Values: 369.7 372.6 372.9 375.6 377.0 18089.2 18577.8 18790.6 18976.7 19009.6 17933.4 18212.2 19032.1 19049.8 19074.5 5439.9 5574.4 5596.7 5610.9 5611.7 3985.4 5475.0 5910.8 6176.8 6200.3 6131.0 6131.5 6146.2 6154.5 6161.5 5897.1 6058.6 6063.2 6066.9 6075.3 3589.2 5084.0 5299.0 5380.8 5387.6 21409.4 21614.4 21751.2 22715.7 22773.1 2343.2 2398.3 2402.7 2416.5 3129.0 13887.4 13892.3 13932.3 14346.6 14691.9 1970.8 1989.0 2019.3 2050.3 2097.5 65871.7 70889.0 71288.0 71971.0 72003.6 10540.4 10683.1 10943.5 11001.2 11152.3 13887.7 14097.2 14099.5 14120.7 14122.6 8322.8 8595.4 8709.3 8751.5 8752.7 7546.7 7662.2 7791.7 8347.6 8506.6 6523.6 6676.8 6723.5 6751.5 6827.1 1722.8 1798.5 1817.7 1832.4 1865.2 971.6 971.8 1009.7 1030.5 1103.9 17804.0 17950.6 18072.3 18316.0 18419.0 1000.5 1000.6 1036.6 1039.7 1042.7 9034.1 10242.7 10307.4 10357.2 10497.8 451779.0 462700.0 464523.0 468378.2 474468.0 75052.2 77432.2 79666.6 81125.6 81962.0 985.9 997.9 1061.6 1072.9 1075.6 15654.6 15823.5 15886.0 16215.3 16343.8 34669.3 35310.6 36430.6 37834.4 38472.6 43559.0 43980.6 44305.0 44593.3 45075.0 8159.6 8311.3 8312.7 8501.2 8515.4 12153.9 12208.8 12250.2 12664.2 12861.0 8146.0 10338.3 10875.9 11025.9 11193.2 10700.0 10911.7 11071.3 11144.0 11363.1 10754.9 10986.4 11095.6 11470.9 11501.9 7842.0 8012.9 8079.7 8089.6 8342.7 10745.3 10825.2 10868.8 11609.8 11947.9 20:28:37 INFO - PROCESS | 3372 | 20:28:37 INFO - PROCESS | 3372 | [#3] mootools.html Cycles:180 Average:5830.37 Median:6148.82 stddev:3044.61 (49.5%) stddev-sans-first:3034.52 20:28:37 INFO - PROCESS | 3372 | Values: 1350.4 1484.5 1507.2 1674.0 1810.5 7839.7 8023.0 8028.6 8029.5 8033.6 7846.2 7950.4 7978.5 8012.5 8016.4 2051.6 2094.5 2336.8 2353.6 2382.3 2383.7 2391.2 2400.6 2403.6 2403.9 2297.0 2313.0 2366.2 2366.8 2367.1 2294.0 2296.1 2304.3 2375.9 2384.2 2323.6 2327.6 2351.1 2351.3 2410.9 8292.2 8363.3 8376.4 8385.0 8391.8 5178.5 5246.6 5286.8 5295.5 5303.0 3496.1 3558.4 3597.5 3648.3 3674.0 1149.7 1165.9 1185.3 1193.6 1216.8 11824.2 11838.1 11887.3 11888.8 11901.2 4756.2 4797.3 4801.3 4821.9 4857.0 9982.2 9989.2 10002.8 10004.4 10028.9 5276.5 5281.7 5286.3 5328.1 5329.5 4149.8 4692.9 4780.5 4782.0 4839.2 3950.5 4027.2 4044.2 4065.2 4086.1 1277.8 1290.9 1298.9 1299.5 1303.3 1129.6 1162.7 1351.5 1373.1 1384.8 7854.4 7946.7 7970.9 7982.0 7982.8 506.4 507.6 509.4 1257.5 1286.9 6167.4 6275.0 6309.1 6327.7 6340.8 9534.7 9759.8 9855.9 9888.1 9916.4 9705.2 9764.5 9784.7 10130.3 10184.3 7904.6 8002.0 8033.3 8038.3 8097.2 7553.9 7616.9 7658.2 7659.7 7683.1 9034.8 9195.0 9255.9 9308.9 9312.7 9290.2 9372.7 9699.8 9742.6 9752.0 6130.2 6755.8 6949.3 7141.1 7239.8 7837.0 7838.9 7855.7 7857.6 7877.1 6769.2 6867.7 6872.9 7023.6 7041.9 6992.1 7043.7 7046.4 7130.0 7135.4 7223.2 7242.9 7365.6 7426.9 7437.2 6985.7 6996.7 7023.2 7028.1 7055.6 6758.0 6759.8 6816.2 6944.5 6945.0 20:28:37 INFO - PROCESS | 3372 | 20:28:37 INFO - PROCESS | 3372 | [#4] prototype.html Cycles:180 Average:5322.56 Median:6046.12 stddev:1602.38 (26.5%) stddev-sans-first:1562.68 20:28:37 INFO - PROCESS | 3372 | Values: 342.9 345.9 346.4 351.2 353.3 6020.2 6036.9 6068.6 6080.7 6110.8 5991.1 6001.0 6008.1 6009.4 6011.7 4379.6 4500.3 4527.5 4617.5 4631.0 4585.0 4589.9 4647.8 4653.6 4657.3 4559.1 4569.5 4583.6 4587.5 4594.6 4335.7 4451.4 4557.2 4582.3 4583.6 4010.8 4014.8 4019.7 4023.4 4024.4 5761.8 5770.0 5771.9 5774.4 5777.3 5318.0 5327.8 5329.4 5331.3 5331.8 6259.6 6270.7 6275.5 6276.3 6276.8 4375.3 4472.4 4486.9 4487.9 4489.6 6495.3 6512.0 6538.2 6553.7 6557.7 4582.2 4583.6 4588.8 4591.2 4593.2 4642.8 4648.3 4651.5 4651.7 4655.2 5318.4 5332.9 5334.2 5336.9 5340.3 6177.5 6336.9 6343.2 6353.6 6415.6 1582.9 1593.5 1598.9 1602.6 1608.8 997.3 1043.0 1054.0 1072.3 1079.2 6036.6 6039.0 6039.4 6043.2 6049.0 6464.0 6555.0 6580.6 6586.5 6587.5 6057.1 6090.5 6091.5 6096.2 6098.3 3472.2 3501.9 3502.1 3506.6 3509.2 6660.5 6728.7 6862.9 6864.9 6869.3 6688.5 6704.5 6713.3 6717.4 6718.1 6765.3 6775.1 6778.4 6779.8 6785.9 6578.9 6583.1 6587.6 6594.6 6613.9 6308.6 6525.1 6526.3 6537.7 6556.9 6830.8 6838.2 6840.1 6870.3 6884.7 4487.2 4516.2 4517.1 4517.7 4525.5 6533.9 6559.1 6571.5 6578.7 6582.7 6243.1 6417.7 6432.6 6438.8 6439.5 6347.1 6380.3 6384.7 6386.0 6391.4 6180.9 6206.2 6213.0 6215.7 6217.1 6411.5 6412.9 6415.2 6416.6 6420.7 6003.9 6081.2 6191.7 6263.7 6266.0 20:28:37 INFO - PROCESS | 3372 | 20:28:37 INFO - PROCESS | 3372 | [#5] yui.html Cycles:180 Average:15575.77 Median:25326.15 stddev:18327.91 (72.4%) stddev-sans-first:18345.46 20:28:37 INFO - PROCESS | 3372 | Values: 740.7 758.7 810.8 844.5 852.1 14551.3 14585.3 14878.0 14917.8 14938.9 13935.8 13998.2 14030.9 14038.9 14047.5 658.3 838.4 856.7 860.2 860.5 849.4 851.8 852.4 854.4 855.7 694.7 889.2 897.0 898.3 899.0 874.4 886.2 887.4 887.6 888.4 640.8 646.0 646.9 647.1 647.2 14885.7 14970.8 14984.3 14989.2 14997.3 14258.5 14524.4 14561.3 14576.9 14579.1 11446.3 11518.9 11602.4 11717.7 11878.9 3833.8 3880.2 3901.8 3921.4 3994.4 54852.0 55066.2 55511.0 56117.4 56352.7 11367.9 11481.4 11577.0 11610.9 11677.3 20459.2 20466.6 20472.3 20476.9 20490.0 8298.8 8640.2 8695.7 8739.5 8770.6 4660.1 4697.9 4727.3 4792.6 4864.1 3369.5 3425.9 3431.0 3437.6 3439.8 583.1 594.9 597.3 605.8 610.6 720.0 739.2 750.9 759.5 774.4 8664.6 8665.7 8741.0 8763.8 8851.2 690.9 691.6 716.1 721.7 736.5 3947.6 3970.5 4010.9 4050.6 4056.5 65050.3 66451.3 66959.7 67220.3 68431.0 54319.7 59023.7 59080.0 59837.0 59868.4 52062.7 52378.2 52629.0 52988.7 54150.5 8063.5 8074.2 8141.6 8147.3 8209.8 36515.5 39209.0 40417.4 40879.6 41424.6 45992.2 50265.7 50724.5 51154.0 51618.5 11426.3 11509.5 11875.0 11882.9 11917.6 13027.5 13051.3 13600.2 13923.9 14314.1 12984.8 13143.2 13482.2 13518.5 13756.4 12926.5 13063.0 13081.9 13268.2 13705.9 12527.9 13003.5 13252.4 13253.2 13623.9 10982.4 11158.6 11410.4 11491.7 11830.9 10458.7 10527.5 10600.5 10745.0 10819.7 20:28:37 INFO - PROCESS | 3372 | -------- Summary: end -------- 20:28:37 INFO - PROCESS | 3372 | 20:28:37 INFO - TEST-INFO | 3372: exit 0 20:28:37 INFO - TEST-OK | dromaeo_css | took 1113180ms 20:28:37 INFO - TEST-START | kraken 20:28:37 INFO - operating with platform_type : linux_ 20:28:37 INFO - Initialising browser for kraken test... 20:28:37 INFO - TEST-INFO | started process 3558 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGYyh3i/profile http://localhost:41304/getInfo.html) 20:28:41 INFO - PROCESS | 3558 | __metrics Screen width/height:1600/1200 20:28:41 INFO - PROCESS | 3558 | colorDepth:24 20:28:41 INFO - PROCESS | 3558 | Browser inner width/height: 1024/697 20:28:41 INFO - PROCESS | 3558 | __metrics 20:28:42 ERROR - PROCESS | 3558 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:28:42 INFO - PROCESS | 3558 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:28:43 INFO - TEST-INFO | 3558: exit 0 20:28:43 INFO - Browser initialized. 20:28:43 INFO - Running cycle 1/1 for kraken test... 20:28:43 INFO - TEST-INFO | started process 3639 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGYyh3i/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:55 INFO - PROCESS | 3639 | RSS: Main: 155549696 20:28:55 INFO - PROCESS | 3639 | 20:28:57 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41304/tests/kraken/driver.html?testName=audio-beat-detection) 20:28:58 INFO - PROCESS | 3639 | RSS: Main: 198041600 20:28:58 INFO - PROCESS | 3639 | 20:29:01 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41304/tests/kraken/driver.html?testName=audio-dft) 20:29:01 INFO - PROCESS | 3639 | RSS: Main: 187834368 20:29:01 INFO - PROCESS | 3639 | 20:29:04 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41304/tests/kraken/driver.html?testName=audio-fft) 20:29:05 INFO - PROCESS | 3639 | RSS: Main: 171991040 20:29:05 INFO - PROCESS | 3639 | 20:29:07 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41304/tests/kraken/driver.html?testName=audio-oscillator) 20:29:07 INFO - PROCESS | 3639 | RSS: Main: 173383680 20:29:07 INFO - PROCESS | 3639 | 20:29:10 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41304/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:29:10 INFO - PROCESS | 3639 | RSS: Main: 176340992 20:29:10 INFO - PROCESS | 3639 | 20:29:13 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41304/tests/kraken/driver.html?testName=imaging-darkroom) 20:29:14 INFO - PROCESS | 3639 | RSS: Main: 176709632 20:29:14 INFO - PROCESS | 3639 | 20:29:17 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41304/tests/kraken/driver.html?testName=imaging-desaturate) 20:29:18 INFO - PROCESS | 3639 | RSS: Main: 178159616 20:29:18 INFO - PROCESS | 3639 | 20:29:20 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41304/tests/kraken/driver.html?testName=json-parse-financial) 20:29:21 INFO - PROCESS | 3639 | RSS: Main: 176984064 20:29:21 INFO - PROCESS | 3639 | 20:29:23 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41304/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:29:23 INFO - PROCESS | 3639 | RSS: Main: 187781120 20:29:23 INFO - PROCESS | 3639 | 20:29:25 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41304/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:29:25 INFO - PROCESS | 3639 | RSS: Main: 183640064 20:29:25 INFO - PROCESS | 3639 | 20:29:27 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41304/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:29:28 INFO - PROCESS | 3639 | RSS: Main: 195080192 20:29:28 INFO - PROCESS | 3639 | 20:29:30 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:29:31 INFO - PROCESS | 3639 | RSS: Main: 199168000 20:29:31 INFO - PROCESS | 3639 | 20:29:33 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:34 INFO - PROCESS | 3639 | RSS: Main: 199643136 20:29:34 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:41304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41304/tests/kraken/driver.html?testName=ai-astar) 20:29:36 INFO - PROCESS | 3639 | RSS: Main: 259047424 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | __start_tp_report 20:29:36 INFO - PROCESS | 3639 | _x_x_mozilla_page_load 20:29:36 INFO - PROCESS | 3639 | _x_x_mozilla_page_load_details 20:29:36 INFO - PROCESS | 3639 | |i|pagename|runs| 20:29:36 INFO - PROCESS | 3639 | |0;ai-astar;109;110;104;111;110;111;99;110;109;109 20:29:36 INFO - PROCESS | 3639 | |1;audio-beat-detection;152;124;148;161;125;154;164;133;176;125 20:29:36 INFO - PROCESS | 3639 | |2;audio-dft;161;161;162;162;162;160;158;162;161;161 20:29:36 INFO - PROCESS | 3639 | |3;audio-fft;75;72;96;95;75;74;73;131;102;72 20:29:36 INFO - PROCESS | 3639 | |4;audio-oscillator;92;93;149;93;94;92;143;93;92;133 20:29:36 INFO - PROCESS | 3639 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 20:29:36 INFO - PROCESS | 3639 | |6;imaging-darkroom;146;146;145;145;147;146;145;145;146;145 20:29:36 INFO - PROCESS | 3639 | |7;imaging-desaturate;96;95;96;95;95;95;95;95;95;96 20:29:36 INFO - PROCESS | 3639 | |8;json-parse-financial;55;55;56;53;55;55;54;63;54;53 20:29:36 INFO - PROCESS | 3639 | |9;json-stringify-tinderbox;60;60;60;61;60;60;60;60;59;60 20:29:36 INFO - PROCESS | 3639 | |10;stanford-crypto-aes;78;85;81;78;80;81;87;77;78;77 20:29:36 INFO - PROCESS | 3639 | |11;stanford-crypto-ccm;108;109;112;114;107;110;114;109;110;111 20:29:36 INFO - PROCESS | 3639 | |12;stanford-crypto-pbkdf2;141;142;141;142;142;130;143;140;139;143 20:29:36 INFO - PROCESS | 3639 | |13;stanford-crypto-sha256-iterative;64;64;64;64;63;62;62;63;63;64 20:29:36 INFO - PROCESS | 3639 | __end_tp_report 20:29:36 INFO - PROCESS | 3639 | __start_cc_report 20:29:36 INFO - PROCESS | 3639 | _x_x_mozilla_cycle_collect,1073 20:29:36 INFO - PROCESS | 3639 | __end_cc_report 20:29:36 INFO - PROCESS | 3639 | __startTimestamp1458617376400__endTimestamp 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | ------- Summary: start ------- 20:29:36 INFO - PROCESS | 3639 | Number of tests: 14 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.79 (3.4%) stddev-sans-first:4.01 20:29:36 INFO - PROCESS | 3639 | Values: 109.0 110.0 104.0 111.0 110.0 111.0 99.0 110.0 109.0 109.0 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:153.00 stddev:18.52 (12.1%) stddev-sans-first:19.53 20:29:36 INFO - PROCESS | 3639 | Values: 152.0 124.0 148.0 161.0 125.0 154.0 164.0 133.0 176.0 125.0 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 20:29:36 INFO - PROCESS | 3639 | Values: 161.0 161.0 162.0 162.0 162.0 160.0 158.0 162.0 161.0 161.0 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#3] audio-fft Cycles:10 Average:86.50 Median:74.50 stddev:19.46 (26.1%) stddev-sans-first:20.19 20:29:36 INFO - PROCESS | 3639 | Values: 75.0 72.0 96.0 95.0 75.0 74.0 73.0 131.0 102.0 72.0 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:92.50 stddev:23.96 (25.9%) stddev-sans-first:24.76 20:29:36 INFO - PROCESS | 3639 | Values: 92.0 93.0 149.0 93.0 94.0 92.0 143.0 93.0 92.0 133.0 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 20:29:36 INFO - PROCESS | 3639 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 20:29:36 INFO - PROCESS | 3639 | Values: 146.0 146.0 145.0 145.0 147.0 146.0 145.0 145.0 146.0 145.0 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 20:29:36 INFO - PROCESS | 3639 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:2.87 (5.2%) stddev-sans-first:3.04 20:29:36 INFO - PROCESS | 3639 | Values: 55.0 55.0 56.0 53.0 55.0 55.0 54.0 63.0 54.0 53.0 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 20:29:36 INFO - PROCESS | 3639 | Values: 60.0 60.0 60.0 61.0 60.0 60.0 60.0 60.0 59.0 60.0 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.50 stddev:3.43 (4.3%) stddev-sans-first:3.54 20:29:36 INFO - PROCESS | 3639 | Values: 78.0 85.0 81.0 78.0 80.0 81.0 87.0 77.0 78.0 77.0 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#11] stanford-crypto-ccm Cycles:10 Average:110.40 Median:110.50 stddev:2.37 (2.1%) stddev-sans-first:2.35 20:29:36 INFO - PROCESS | 3639 | Values: 108.0 109.0 112.0 114.0 107.0 110.0 114.0 109.0 110.0 111.0 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.30 Median:142.00 stddev:3.83 (2.7%) stddev-sans-first:4.06 20:29:36 INFO - PROCESS | 3639 | Values: 141.0 142.0 141.0 142.0 142.0 130.0 143.0 140.0 139.0 143.0 20:29:36 INFO - PROCESS | 3639 | 20:29:36 INFO - PROCESS | 3639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 20:29:36 INFO - PROCESS | 3639 | Values: 64.0 64.0 64.0 64.0 63.0 62.0 62.0 63.0 63.0 64.0 20:29:36 INFO - PROCESS | 3639 | -------- Summary: end -------- 20:29:36 INFO - PROCESS | 3639 | 20:29:37 INFO - TEST-INFO | 3639: exit 0 20:29:37 INFO - TEST-OK | kraken | took 59571ms 20:29:37 INFO - SUITE-END | took 1172s 20:29:37 INFO - Completed test suite (00:19:32) 20:29:37 INFO - javascript benchmark 20:29:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3058.2965917838897, 3098.5662007318965, 3110.5023196288585, 3136.796108252963, 3158.936821263575, 5266.183741520061, 5345.251664766935, 5376.51611354978, 5377.758000889964, 5422.1595652673805, 5369.140937450009, 5398.568114550836, 5443.292371991645, 5445.1832225166245, 5473.562115030798, 4817.831375901844, 4832.903341933168, 4837.080954618611, 4849.0301939612045, 4952.380952380952, 4919.926201106986, 4937.827176048839, 4978.87552811179, 4985.102681517325, 4997.225430058346, 4786.329913812069, 4839.37088178538, 4911.926321105187, 4921.704697718148, 4942.308076869242, 4847.442544107403, 4850.75746212688, 4850.95149048512, 4856.562909338177, 4891.4863939286215, 4808.855734327975, 4827.879303017417, 4842.58837998767, 4846.9515304846855, 4892.877678058041, 5317.574594032507, 5359.732013399314, 5364.624476286662, 5375.11310633745, 5391.406945236021, 5662.462066103713, 5662.6036177467595, 5668.97165514174, 5673.6879471629045, 5674.602777805555, 5649.774009039634, 5705.315362156526, 5707.029804933171, 5712.22884910536, 5748.942510574882, 5394.109971854639, 5396.514313711785, 5416.8104116356135, 5421.5391691706645, 5432.6740395576, 5875.706214689334, 5876.853078673067, 5877.647341159544, 5880.323762767336, 5885.0, 5504.146857237135, 5634.3802181759975, 5635.492805647429, 5662.915056274159, 5726.398728133486, 5768.855778605568, 5800.158976948319, 5804.6807425592, 5806.21616081832, 5832.708364581838, 5724.16999535065, 5739.225204597409, 5767.394423585547, 5767.452092051249, 5775.162601422854, 5493.368262649767, 5681.289838770153, 5727.3699893011735, 5738.856528586819, 5791.247137872049, 4361.498427680794, 4369.584889435562, 4380.649548036149, 4383.0, 4407.27279998803, 3854.1520865409566, 3905.1213476968023, 3914.5106861642294, 3919.470871432377, 3938.448617193595, 5293.994141113176, 5457.045017121988, 5485.890282194334, 5524.972375138099, 5537.750801213955, 5785.4214578541805, 5787.623804452697, 5788.27646544182, 5790.681512516852, 5814.9709251454315, 5249.921251181236, 5429.995450841607, 5459.454054594509, 5466.945330546644, 5470.480304371078, 4919.163742163841, 4953.578945789648, 4957.7769000395065, 4984.925226121611, 4986.276989836453, 5893.086571581412, 5920.5559583031445, 5921.644701317935, 5954.285485741652, 5968.074948383008, 5673.8297851064535, 5698.116791897262, 5734.598578099576, 5740.6268592541355, 5754.165645981393, 5998.130271110752, 6064.7877324295205, 6089.025755879038, 6113.84715382119, 6118.694065296629, 5716.771329146787, 5745.856353591026, 5750.25246717924, 5752.28096487939, 5766.711664416846, 5572.777088916398, 5793.217915581511, 5836.533077353886, 5845.18167456548, 5852.356240813422, 5655.066913959151, 5691.914621280601, 5710.2862142232225, 5744.0522313817755, 5754.56840736938, 5597.524210442158, 5597.636153650163, 5621.072523033654, 5623.522000629992, 5633.0987042073075, 5409.756560954846, 5481.424450432806, 5486.341639003345, 5488.588355873246, 5489.58828087903, 5667.773289068391, 5674.74463649145, 5682.857928551819, 5696.658200507983, 5781.537477001746, 5521.751521181637, 5570.972145139248, 5571.832845014656, 5579.302587176603, 5591.329040515164], "unit": "score", "name": "dojo.html", "value": 5304.6847909348035}, {"lowerIsBetter": false, "replicates": [553.0323519262872, 558.8882223555285, 571.5998800839412, 577.2293987526651, 586.6685322792622, 29379.853100734494, 38136.0, 38563.80718096409, 38980.41529377062, 39023.60976390235, 41899.581004189946, 42361.152776944444, 42371.152576948516, 42411.15177696444, 42467.0, 7387.4090072794315, 8679.913200868004, 8797.780055498632, 8835.337349698766, 8867.113288671146, 10556.894431055667, 10766.892331076706, 10772.892271077268, 10782.946085269563, 10784.029437350637, 10450.16398688103, 10550.736231594195, 10552.78894422111, 10556.894431055707, 10566.260361774679, 10360.533775980099, 10425.947870260676, 10441.42572158531, 10441.84337234942, 10455.68632941013, 10193.847092293621, 10252.794944101077, 10266.12737917278, 10300.22748293881, 10313.226508011854, 41714.0, 41996.58003419957, 42040.57959420397, 42518.57481425177, 42540.787296063325, 3364.7812892162174, 3370.1069216657606, 3462.3248466549035, 3643.3259846928404, 3755.643213894703, 30306.242343941358, 31027.689723102707, 31386.37227255442, 32997.50503742446, 33628.327433451435, 4314.460692413449, 4320.373545835836, 4359.258925982591, 4438.3564383164585, 4448.488423831269, 238416.0, 240919.0, 241233.99999999825, 241853.0, 243701.0, 49786.75106624516, 50508.24237636438, 50591.49408505868, 61453.69273153606, 62079.0, 51050.489495105314, 51081.233781493305, 51120.48879511232, 51129.74435127801, 51203.487965120614, 14361.066530675682, 14423.85576144246, 14436.855631443761, 14440.133591984515, 14450.205238711762, 12646.177998430072, 12773.744525109445, 12782.872171278354, 12784.552540661032, 12795.61613151607, 16698.666026679643, 16763.580910477336, 16890.239939202766, 16894.15529223534, 16894.74657880133, 6584.539082264291, 6633.2371777246235, 6741.393274605309, 6845.657717114224, 6889.414399776075, 1087.1737479515625, 1092.748667806409, 1114.0920150077661, 1154.4747140051256, 1178.5992762460805, 31591.684083159333, 31605.525917111263, 32078.358432831214, 32112.678873211436, 32424.35151296961, 1152.9192956492966, 1165.1028707894873, 1170.169179882293, 1209.6975756060986, 1231.5812623707982, 16252.456016678396, 16625.6674866502, 16652.75020874688, 16673.333066677198, 16867.0, 385721.0, 386059.0, 390263.0, 390558.0, 391206.0, 55829.72085139548, 55888.441115589136, 56122.15816762752, 56203.43796562064, 56248.71875640677, 1256.7926292161692, 1360.6530334764573, 1372.0875617714307, 1404.1013751199037, 1406.9929650351683, 28008.859955700093, 28965.710342897146, 29051.85474072616, 29586.704132958395, 30089.849550752107, 41317.58682413257, 41576.58423415727, 41654.0, 41658.37512437255, 41677.0, 213506.0, 215408.0, 216441.0, 216935.0, 217050.0, 31426.21434464157, 34976.65023349734, 36021.0, 36416.63583364239, 36944.63055369412, 41234.1753164929, 41650.791746041075, 42037.36943945782, 42298.71266091739, 42340.36489452599, 37359.626403735616, 37530.437043443824, 37702.05744856291, 37771.244575108896, 37986.43020354752, 37161.25677486381, 37550.81224593969, 38313.0, 39070.4139437903, 39150.60849391584, 38829.805850970566, 39441.802790985865, 39478.802605986784, 40133.598664012985, 40391.39412908867, 33580.0, 34605.826970865994, 34686.0, 35059.298814024085, 35144.824275878455, 26946.865265673547, 27002.459950801265, 27141.321466963484, 27197.72802271952, 27820.30449238785], "unit": "score", "name": "ext.html", "value": 19039.596401506213}, {"lowerIsBetter": false, "replicates": [369.65621971566435, 372.56782132726033, 372.86017743346264, 375.56059410489723, 376.9990674758515, 18089.1859866306, 18577.814221857796, 18790.62418751624, 18976.715349269736, 19009.619807603838, 17933.372331968385, 18212.180451879663, 19032.14355354009, 19049.809271933733, 19074.523136921584, 5439.864003399917, 5574.386817450078, 5596.692181929992, 5610.943890561103, 5611.691356975365, 3985.382265748799, 5474.972625136868, 5910.763569457238, 6176.81469555914, 6200.317965023866, 6130.969345153268, 6131.540134489909, 6146.200993870812, 6154.476869466101, 6161.476274516649, 5897.144913987469, 6058.575899687024, 6063.211782468273, 6066.878662426749, 6075.27096748393, 3589.1565482111682, 5083.974580127076, 5299.0, 5380.757865896044, 5387.622866399353, 21409.357719268446, 21614.35156945294, 21751.238706645192, 22715.659265111037, 22773.08907643692, 2343.238447504551, 2398.280515845257, 2402.6516155157406, 2416.4804567018177, 3128.9530657040164, 13887.4445022199, 13892.305384730824, 13932.303384830819, 14346.64133396663, 14691.926540367336, 1970.753655793026, 1988.9801101989085, 2019.2629690163133, 2050.2721533855415, 2097.549026959211, 65871.67064164697, 70889.0, 71288.0, 71971.0, 72003.63998179976, 10540.420276884844, 10683.14534837211, 10943.507542160622, 11001.22991390611, 11152.271397933171, 13887.652808679864, 14097.154170749787, 14099.462096822464, 14120.71758564823, 14122.576322710334, 8322.791930201793, 8595.44129631572, 8709.303255739525, 8751.518666473405, 8752.69365572202, 7546.735864244725, 7662.1571627120975, 7791.727289544839, 8347.582620868932, 8506.617202225914, 6523.575967562093, 6676.76479851229, 6723.529352945345, 6751.459883209332, 6827.112475378169, 1722.776039114932, 1798.4514723009609, 1817.6637322095455, 1832.3553815502291, 1865.1606776950428, 971.5579411367811, 971.8396464583265, 1009.6668099527285, 1030.4538594544904, 1103.906167975715, 17804.0, 17950.640987180184, 18072.277108915758, 18316.0, 18419.0, 1000.4597517340554, 1000.6447711062614, 1036.6423583863555, 1039.667306461925, 1042.7080417483116, 9034.096590340914, 10242.692719218436, 10307.433091179908, 10357.223208259411, 10497.842532362021, 451779.0, 462700.0, 464523.0, 468378.2135250568, 474468.0, 75052.24947750561, 77432.2256777425, 79666.6016669913, 81125.59437202776, 81962.0, 985.9211263098935, 997.9051990060933, 1061.5912873543587, 1072.9034386905216, 1075.6127793994156, 15654.608634784221, 15823.454276932516, 15885.967412118176, 16215.270312835715, 16343.754843677116, 34669.30661386708, 35310.646893530735, 36430.63569364379, 37834.43248351332, 38472.6152738469, 43559.0, 43980.560194398924, 44305.0, 44593.33110003417, 45075.0, 8159.592020399075, 8311.335093192409, 8312.6674933002, 8501.19238672325, 8515.446495977989, 12153.878461215629, 12208.75582488363, 12250.203736757083, 12664.240145591293, 12861.0, 8146.0, 10338.276320657482, 10875.945620272165, 11025.889741102486, 11193.216474846682, 10700.0, 10911.672649820519, 11071.280366776135, 11144.0, 11363.090952723596, 10754.946225268823, 10986.395748233925, 11095.556177753122, 11470.885291146982, 11501.891166727604, 7842.0, 8012.879806803019, 8079.676812927417, 8089.595520223847, 8342.708005219789, 10745.345936329179, 10825.186387836246, 10868.836967445337, 11609.825852612048, 11947.940260298643], "unit": "score", "name": "jquery.html", "value": 9015.042325958952}, {"lowerIsBetter": false, "replicates": [1350.4395675794547, 1484.539792664274, 1507.1559926441191, 1674.0, 1810.5383127302543, 7839.686412543499, 8023.0, 8028.558429286387, 8029.47808392454, 8033.638486268117, 7846.2153784621505, 7950.36397088233, 7978.481398709095, 8012.519248845073, 8016.398770092237, 2051.579426217622, 2094.465911192644, 2336.8247381446376, 2353.6116540770754, 2382.344855164835, 2383.6543701163323, 2391.1869964212165, 2400.639904014403, 2403.5553422616786, 2403.867787271708, 2296.9540609187807, 2313.0, 2366.219147681261, 2366.810655147584, 2367.1478267823654, 2293.9655905161353, 2296.0700916129076, 2304.2511183865313, 2375.928722138339, 2384.201292566992, 2323.59337116004, 2327.6392159215347, 2351.0595761695286, 2351.2828587280874, 2410.8915098820594, 8292.212239837207, 8363.28912042471, 8376.371772117116, 8385.035720892054, 8391.790205244857, 5178.533931946143, 5246.632735708502, 5286.762095705664, 5295.523402893758, 5303.018941495836, 3496.0735405117666, 3558.430651095812, 3597.5143355646915, 3648.343298206322, 3674.026383008505, 1149.6953307373553, 1165.877582853805, 1185.3125187391292, 1193.582246213827, 1216.7748966441236, 11824.172307938361, 11838.052955763518, 11887.286762794174, 11888.762224755457, 11901.166918315721, 4756.208478329691, 4797.280407938767, 4801.255805350176, 4821.879453013703, 4857.0, 9982.201423886072, 9989.200863930868, 10002.849957250646, 10004.399736015863, 10028.899711002796, 5276.498732620395, 5281.709505977208, 5286.259923610698, 5328.094223981932, 5329.467053294639, 4149.792510374469, 4692.929606055912, 4780.521947805191, 4782.0, 4839.201531747292, 3950.466686997276, 4027.154297597537, 4044.1911617676583, 4065.1869626074904, 4086.0602061526015, 1277.8019406991932, 1290.864459231786, 1298.8636193199768, 1299.5191779041816, 1303.2506308872437, 1129.6102844518628, 1162.68607475981, 1351.4661708625038, 1373.1074801379184, 1384.7507448659137, 7854.410919181084, 7946.682132714743, 7970.9202907970175, 7982.0, 7982.800429989181, 506.38980029065624, 507.621821742804, 509.35566508366946, 1257.4844313831286, 1286.8906142977764, 6167.444929956326, 6274.968625156845, 6309.085182648582, 6327.651979141191, 6340.841478963062, 9534.713958581253, 9759.756006099762, 9855.90144098564, 9888.110070093582, 9916.405015698936, 9705.223582113415, 9764.462954537568, 9784.657536986171, 10130.277852765048, 10184.338018028804, 7904.604769761604, 8001.959990200012, 8033.317168040782, 8038.276555110068, 8097.190280971973, 7553.924460755322, 7616.885746713693, 7658.157602663814, 7659.693612255447, 7683.0780306363595, 9034.819303614022, 9195.0, 9255.861162082709, 9308.860367094634, 9312.674056407994, 9290.210332121846, 9372.67195648149, 9699.806003880023, 9742.610295588098, 9751.951240243754, 6130.2030736004035, 6755.763548275787, 6949.339812717783, 7141.107361579802, 7239.782806515813, 7837.0, 7838.882416763639, 7855.7250496232355, 7857.646405911862, 7877.094134174643, 6769.1876974763345, 6867.690953907186, 6872.862542749217, 7023.578585284899, 7041.894371584533, 6992.056072430157, 7043.7182512700965, 7046.401055910305, 7129.964350178423, 7135.357817796424, 7223.1693355264815, 7242.891356629761, 7365.558066516026, 7426.925730742623, 7437.219091995263, 6985.685644146127, 6996.720131194696, 7023.157221133497, 7028.121484814398, 7055.611941343275, 6758.0, 6759.797206083826, 6816.216135144522, 6944.51388402807, 6944.965275173592], "unit": "score", "name": "mootools.html", "value": 4755.3392558218875}, {"lowerIsBetter": false, "replicates": [342.912557297889, 345.85819813876316, 346.41801773021314, 351.1975136812383, 353.25815786847625, 6020.157177995079, 6036.909446358308, 6068.575199736015, 6080.665563394023, 6110.786122485714, 5991.071383935486, 6001.03983362661, 6008.098785182225, 6009.369016253296, 6011.729472173752, 4379.58393952574, 4500.347449619803, 4527.456705195381, 4617.538246175381, 4631.0, 4585.0, 4589.931151032721, 4647.837325693601, 4653.604443622279, 4657.32468792025, 4559.065391594731, 4569.543045695421, 4583.564561366665, 4587.472440669332, 4594.563516465931, 4335.6965012449145, 4451.354553589727, 4557.156925968673, 4582.335561343587, 4583.564561366698, 4010.8195131219163, 4014.759114453113, 4019.718619696622, 4023.436718859362, 4024.3963405489117, 5761.798337058225, 5769.971150144264, 5771.855703607402, 5774.364819869811, 5777.335606405275, 5317.973410132963, 5327.760250788724, 5329.440408757102, 5331.306930099101, 5331.813386531453, 6259.624422534617, 6270.683156537133, 6275.497960163221, 6276.3409841966395, 6276.780312689079, 4375.299952007664, 4472.396226509412, 4486.932696009562, 4487.910241795178, 4489.595936365743, 6495.285518592951, 6511.967440162816, 6538.215414150332, 6553.737850485975, 6557.737690492375, 4582.152301824107, 4583.610393116623, 4588.839390621312, 4591.219492686251, 4593.242115050979, 4642.79107440166, 4648.349231107648, 4651.465081515601, 4651.744154071558, 4655.208614535537, 5318.44156363584, 5332.9466705333225, 5334.1732031535175, 5336.91994620081, 5340.332458442695, 6177.4749146322165, 6336.936630633634, 6343.175387199634, 6353.618782873043, 6415.647139407284, 1582.8654564361927, 1593.4661888267328, 1598.8720902327786, 1602.6233835048754, 1608.7586861970565, 997.2719914462483, 1042.9895701043044, 1053.989460105389, 1072.3137192197, 1079.2067830144838, 6036.577439579188, 6039.033754599243, 6039.365866584033, 6043.244594425697, 6049.0, 6464.0, 6555.0, 6580.605163690194, 6586.50601204902, 6587.53887227899, 6057.091436284592, 6090.512758979271, 6091.48222401092, 6096.237970253718, 6098.26820781509, 3472.236108056274, 3501.8774342897877, 3502.141975216088, 3506.561679790026, 3509.175343794206, 6660.533762636665, 6728.697208625624, 6862.9313706862295, 6864.897026544606, 6869.347411995853, 6688.498362622823, 6704.497162712719, 6713.295104014106, 6717.361850624281, 6718.05947167397, 6765.323467653196, 6775.1192344995825, 6778.356056174655, 6779.796606101825, 6785.8642827143185, 6578.901316480161, 6583.111279977142, 6587.571807832475, 6594.604323740591, 6613.867722645424, 6308.621482711052, 6525.119108920425, 6526.347365263436, 6537.7058032389605, 6556.868862622626, 6830.7609233676585, 6838.213605435439, 6840.144981877265, 6870.3473170048765, 6884.690188941409, 4487.192305385062, 4516.209663308842, 4517.051419202005, 4517.661175411923, 4525.502194758508, 6533.901991470037, 6559.114519539801, 6571.474282057328, 6578.736850525926, 6582.670866456562, 6243.063540468966, 6417.743290268524, 6432.646204458612, 6438.7746428876635, 6439.484841212786, 6347.111404403295, 6380.298167201697, 6384.680765961591, 6386.0, 6391.360863913757, 6180.907286390618, 6206.224221972254, 6212.968935155295, 6215.689215539295, 6217.129601855834, 6411.455026322628, 6412.871742565216, 6415.230172379344, 6416.647084410216, 6420.743170273324, 6003.939960600338, 6081.179040829608, 6191.659458729813, 6263.718132683949, 6265.96867015662], "unit": "score", "name": "prototype.html", "value": 4801.548682017037}, {"lowerIsBetter": false, "replicates": [740.7185269597553, 758.6586036283674, 810.752720420272, 844.5144042175747, 852.071242345843, 14551.345189466472, 14585.270736463173, 14878.032927859682, 14917.776233356508, 14938.850611493868, 13935.790963135536, 13998.230097344642, 14030.929845350784, 14038.859611403883, 14047.508337208199, 658.298911659084, 838.4424357802054, 856.7258477287271, 860.1785295043219, 860.535310932096, 849.362977766675, 851.7572491839827, 852.3522123186392, 854.4147259127486, 855.6962278391175, 694.6561452081202, 889.1997202517721, 897.0, 898.3442087276293, 899.0200681257428, 874.4272501511489, 886.246690313235, 887.3699673232013, 887.5784002598714, 888.3825741109931, 640.7533099756581, 646.0277282689523, 646.8770933522616, 647.123148134276, 647.1716203259834, 14885.70228595422, 14970.775438368433, 14984.250787460584, 14989.175595342253, 14997.250137493082, 14258.500952466615, 14524.419023239057, 14561.271936403244, 14576.854231457655, 14579.125252484884, 11446.255993360488, 11518.94240528792, 11602.4198790061, 11717.70705732355, 11878.881211187863, 3833.769973801581, 3880.185161116169, 3901.7854018028997, 3921.4117882317596, 3994.4407782910416, 54852.0, 55066.17400738992, 55510.99999999959, 56117.43882561163, 56352.71823640897, 11367.943160284145, 11481.425928703531, 11577.0, 11610.94194529022, 11677.299362038304, 20459.181632734522, 20466.59066818685, 20472.283470078477, 20476.897615511825, 20490.0, 8298.8340233195, 8640.222379985831, 8695.695650652324, 8739.475631462132, 8770.561471926378, 4660.13787449323, 4697.882552936204, 4727.333954004302, 4792.640551958617, 4864.100141473838, 3369.5451114099774, 3425.8523394663066, 3431.0, 3437.6218615952225, 3439.8280085995602, 583.1340459417761, 594.8691287916652, 597.2593983460478, 605.8121982185537, 610.6031079798166, 719.9928000720031, 739.2496615934831, 750.8873668949592, 759.506320891425, 774.3882332957013, 8664.610092545725, 8665.740027799176, 8741.0, 8763.780905477286, 8851.159139881702, 690.8617827822881, 691.5574032619128, 716.1227496317074, 721.7257442171941, 736.5102207032263, 3947.6249756273683, 3970.5433875104154, 4010.9197816044098, 4050.5544390117066, 4056.513218413809, 65050.349496505376, 66451.33548664452, 66959.66520167465, 67220.32779672238, 68431.0, 54319.72840135774, 59023.704881475314, 59080.0, 59837.0, 59868.401315987154, 52062.73968630133, 52378.21432678513, 52629.0, 52988.73505632524, 54150.45849541454, 8063.516189028677, 8074.192580741878, 8141.59292035384, 8147.266745992889, 8209.83580328402, 36515.452268215464, 39209.0, 40417.39373909453, 40879.59120408877, 41424.58575414207, 45992.16031358708, 50265.74867125641, 50724.49275507198, 51154.0, 51618.483815161366, 11426.314421134759, 11509.482073306554, 11874.99999999993, 11882.940585297018, 11917.582884598998, 13027.47890084386, 13051.28217948022, 13600.183988960694, 13923.860761392662, 14314.141151530941, 12984.805227921399, 13143.211407315592, 13482.19106853592, 13518.459261629425, 13756.380962856496, 12926.547570834975, 13063.0, 13081.934590326988, 13268.203907765565, 13705.862941370458, 12527.93736031314, 13003.47986080584, 13252.403641836334, 13253.204807711569, 13623.931880340931, 10982.395968221825, 11158.55365785392, 11410.372429516456, 11491.712707182387, 11830.940845295718, 10458.68623941283, 10527.4736263185, 10600.522976465923, 10744.974221653849, 10819.729506762395], "unit": "score", "name": "yui.html", "value": 6915.245453769209}], "name": "dromaeo_css", "value": 7237.9485290280045}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 111.0, 110.0, 111.0, 99.0, 110.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 148.0, 161.0, 125.0, 154.0, 164.0, 133.0, 176.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 162.0, 162.0, 160.0, 158.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 96.0, 95.0, 75.0, 74.0, 73.0, 131.0, 102.0, 72.0], "unit": "score", "name": "audio-fft", "value": 86.5}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 149.0, 93.0, 94.0, 92.0, 143.0, 93.0, 92.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"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": [146.0, 146.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 56.0, 53.0, 55.0, 55.0, 54.0, 63.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.0}, {"lowerIsBetter": true, "replicates": [78.0, 85.0, 81.0, 78.0, 80.0, 81.0, 87.0, 77.0, 78.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.2}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 112.0, 114.0, 107.0, 110.0, 114.0, 109.0, 110.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 110.4}, {"lowerIsBetter": true, "replicates": [141.0, 142.0, 141.0, 142.0, 142.0, 130.0, 143.0, 140.0, 139.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.3}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 63.0, 62.0, 62.0, 63.0, 63.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.3}], "name": "kraken", "value": 1476.7}]} 20:29:37 INFO - Return code: 0 20:29:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:29:37 ERROR - # TBPL SUCCESS # 20:29:37 INFO - Running post-action listener: _resource_record_post_action 20:29:37 INFO - Running post-run listener: _resource_record_post_run 20:29:38 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 10354688; Write bytes: 424214528; Read time: 2800; Write time: 397900 20:29:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5197824; Read time: 0; Write time: 656 20:29:38 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 10350592; Write bytes: 376406016; Read time: 2724; Write time: 366784 20:29:38 INFO - Running post-run listener: _upload_blobber_files 20:29:38 INFO - Blob upload gear active. 20:29:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:29:38 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 20:29:38 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:29:38 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:29:39 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:29:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:29:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:40 INFO - (blobuploader) - INFO - Done attempting. 20:29:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:29:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:29:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:41 INFO - (blobuploader) - INFO - Done attempting. 20:29:41 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:41 INFO - Return code: 0 20:29:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:29:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8cf1b5ec8adcb182ec6009016d7a940eb04c6960221d039d077bbf770453dc390a53ae637945f578abf1d64e2da175e59e324b35754631753c5a401d5fe7ed5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8abe8465a3376a309af573281baec481175ae11ed78f3172fb621614b1b0a82ba2ea23f60f0b0775c33ed2a402a511f52a75f0d7cb6b8b364a87326c9812625d"} 20:29:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:29:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:29:41 INFO - Contents: 20:29:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8cf1b5ec8adcb182ec6009016d7a940eb04c6960221d039d077bbf770453dc390a53ae637945f578abf1d64e2da175e59e324b35754631753c5a401d5fe7ed5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8abe8465a3376a309af573281baec481175ae11ed78f3172fb621614b1b0a82ba2ea23f60f0b0775c33ed2a402a511f52a75f0d7cb6b8b364a87326c9812625d"} 20:29:41 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:41 INFO - Copying logs to upload dir... 20:29:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:29:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.644428 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-03-21 20:29:41.146102) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 20:29:41.149575) ========= 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=1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8cf1b5ec8adcb182ec6009016d7a940eb04c6960221d039d077bbf770453dc390a53ae637945f578abf1d64e2da175e59e324b35754631753c5a401d5fe7ed5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8abe8465a3376a309af573281baec481175ae11ed78f3172fb621614b1b0a82ba2ea23f60f0b0775c33ed2a402a511f52a75f0d7cb6b8b364a87326c9812625d"} build_url:https://queue.taskcluster.net/v1/task/axZeBe9CQj6SIuIEXfq-SA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011149 build_url: 'https://queue.taskcluster.net/v1/task/axZeBe9CQj6SIuIEXfq-SA/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/Fx-Team/sha512/d8cf1b5ec8adcb182ec6009016d7a940eb04c6960221d039d077bbf770453dc390a53ae637945f578abf1d64e2da175e59e324b35754631753c5a401d5fe7ed5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8abe8465a3376a309af573281baec481175ae11ed78f3172fb621614b1b0a82ba2ea23f60f0b0775c33ed2a402a511f52a75f0d7cb6b8b364a87326c9812625d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 20:29:41.187668) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 20:29:41.188039) ========= 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=1b9da9da7504fe468691862d000001b9-1458609952.800461-2132532404 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 20:29:41.287562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 20:29:41.287872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 20:29:41.288198) ========= ========= Total master_lag: 0.33 =========