builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1455165683.94 results: success (0) buildid: 20160210173008 builduid: e6b30a84d2a947c9ae0dfe6068ba70c6 revision: c507aa4e2a21bf01e7580fc431a313b0b442fc61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:23.936992) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:23.937577) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:23.937893) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006445 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:23.962518) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:23.962829) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:23.986452) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:23.986725) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.039268 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:24.035335) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:24.035621) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:24.035995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:24.036336) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-10 20:41:24-- 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% 36.9M=0s 2016-02-10 20:41:24 (36.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101422 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:24.150220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:24.150553) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.061606 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:24.231873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:24.232185) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c507aa4e2a21bf01e7580fc431a313b0b442fc61 --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 c507aa4e2a21bf01e7580fc431a313b0b442fc61 --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=9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-10 20:41:24,350 truncating revision to first 12 chars 2016-02-10 20:41:24,351 Setting DEBUG logging. 2016-02-10 20:41:24,351 attempt 1/10 2016-02-10 20:41:24,351 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c507aa4e2a21?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 20:41:24,595 unpacking tar archive at: fx-team-c507aa4e2a21/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531575 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:24.781148) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:24.781507) ========= echo c507aa4e2a21bf01e7580fc431a313b0b442fc61 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c507aa4e2a21bf01e7580fc431a313b0b442fc61'] 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=9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c507aa4e2a21bf01e7580fc431a313b0b442fc61 program finished with exit code 0 elapsedTime=0.004036 script_repo_revision: 'c507aa4e2a21bf01e7580fc431a313b0b442fc61' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:24.829991) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:24.830330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 20:41:24.840098) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-02-10 20:41:24.840404) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:41:25 INFO - MultiFileLogger online at 20160210 20:41:25 in /builds/slave/test-pgo 20:41:25 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:41:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:41:25 INFO - {'append_to_log': False, 20:41:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:41:25 INFO - 'blob_upload_branch': 'Fx-Team', 20:41:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:41:25 INFO - 'branch': 'Fx-Team', 20:41:25 INFO - 'buildbot_json_path': 'buildprops.json', 20:41:25 INFO - 'config_files': ('talos/linux_config.py',), 20:41:25 INFO - 'default_actions': ('clobber', 20:41:25 INFO - 'read-buildbot-config', 20:41:25 INFO - 'download-and-extract', 20:41:25 INFO - 'populate-webroot', 20:41:25 INFO - 'create-virtualenv', 20:41:25 INFO - 'install', 20:41:25 INFO - 'run-tests'), 20:41:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:41:25 INFO - 'download_minidump_stackwalk': True, 20:41:25 INFO - 'download_symbols': 'ondemand', 20:41:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:41:25 INFO - 'tooltool.py': '/tools/tooltool.py', 20:41:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:41:25 INFO - '/tools/misc-python/virtualenv.py')}, 20:41:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:41:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:41:25 INFO - 'installer_path': 'installer.exe', 20:41:25 INFO - 'log_level': 'info', 20:41:25 INFO - 'log_name': 'talos', 20:41:25 INFO - 'log_to_console': True, 20:41:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:41:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:41:25 INFO - 'opt_config_files': (), 20:41:25 INFO - 'pip_index': False, 20:41:25 INFO - 'sps_profile': False, 20:41:25 INFO - 'sps_profile_interval': 0, 20:41:25 INFO - 'suite': 'dromaeojs', 20:41:25 INFO - 'system_bits': '32', 20:41:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:41:25 INFO - 'title': 'talos-linux64-ix-022', 20:41:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:41:25 INFO - 'use_talos_json': True, 20:41:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:41:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:41:25 INFO - 'work_dir': 'build'} 20:41:25 INFO - ##### 20:41:25 INFO - ##### Running clobber step. 20:41:25 INFO - ##### 20:41:25 INFO - Running pre-action listener: _resource_record_pre_action 20:41:25 INFO - Running main action method: clobber 20:41:25 INFO - rmtree: /builds/slave/test-pgo/build 20:41:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:41:26 INFO - Running post-action listener: _resource_record_post_action 20:41:26 INFO - ##### 20:41:26 INFO - ##### Running read-buildbot-config step. 20:41:26 INFO - ##### 20:41:26 INFO - Running pre-action listener: _resource_record_pre_action 20:41:26 INFO - Running main action method: read_buildbot_config 20:41:26 INFO - Using buildbot properties: 20:41:26 INFO - { 20:41:26 INFO - "project": "", 20:41:26 INFO - "product": "firefox", 20:41:26 INFO - "script_repo_revision": "production", 20:41:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:41:26 INFO - "repository": "", 20:41:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:41:26 INFO - "buildid": "20160210173008", 20:41:26 INFO - "pgo_build": "True", 20:41:26 INFO - "basedir": "/builds/slave/test-pgo", 20:41:26 INFO - "buildnumber": 638, 20:41:26 INFO - "slavename": "talos-linux64-ix-022", 20:41:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:41:26 INFO - "platform": "ubuntu64_hw", 20:41:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:41:26 INFO - "branch": "fx-team", 20:41:26 INFO - "repo_path": "integration/fx-team", 20:41:26 INFO - "revision": "c507aa4e2a21bf01e7580fc431a313b0b442fc61", 20:41:26 INFO - "stage_platform": "linux64-pgo", 20:41:26 INFO - "builduid": "e6b30a84d2a947c9ae0dfe6068ba70c6", 20:41:26 INFO - "slavebuilddir": "test" 20:41:26 INFO - } 20:41:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 20:41:26 INFO - Running post-action listener: _resource_record_post_action 20:41:26 INFO - ##### 20:41:26 INFO - ##### Running download-and-extract step. 20:41:26 INFO - ##### 20:41:26 INFO - Running pre-action listener: _resource_record_pre_action 20:41:26 INFO - Running main action method: download_and_extract 20:41:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:41:26 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:41:26 INFO - https://queue.taskcluster.net/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:41:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/test_packages.json 20:41:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/test_packages.json 20:41:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:41:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:41:33 INFO - Downloaded 1448 bytes. 20:41:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:41:33 INFO - Using the following test package requirements: 20:41:33 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:41:33 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:41:33 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:41:33 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:33 INFO - u'jsshell-linux-x86_64.zip'], 20:41:33 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:41:33 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:41:33 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:41:33 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:41:33 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:41:33 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:41:33 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:41:33 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:41: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:41:33 INFO - https://queue.taskcluster.net/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:41:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:41:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:41:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:41:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:41:43 INFO - Downloaded 23293159 bytes. 20:41:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:41:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:41:44 INFO - Return code: 0 20:41:44 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:41:44 INFO - https://queue.taskcluster.net/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:41:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:41:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:41:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:41:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:41:46 INFO - Downloaded 23293159 bytes. 20:41:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:41:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:41:47 INFO - Return code: 0 20:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:41:47 INFO - https://queue.taskcluster.net/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:41:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 20:41:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 20:41:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 20:41:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:41:49 INFO - Downloaded 10706547 bytes. 20:41:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:41:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 20:41:49 INFO - Return code: 0 20:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:41:49 INFO - https://queue.taskcluster.net/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:41:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:41:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:41:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:41:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:41:50 INFO - Downloaded 56466666 bytes. 20:41:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:41:50 INFO - mkdir: /builds/slave/test-pgo/properties 20:41:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:41:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:41:50 INFO - Contents: 20:41:50 INFO - build_url:https://queue.taskcluster.net/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:41:51 INFO - Running post-action listener: _resource_record_post_action 20:41:51 INFO - Running post-action listener: set_extra_try_arguments 20:41:51 INFO - ##### 20:41:51 INFO - ##### Running populate-webroot step. 20:41:51 INFO - ##### 20:41:51 INFO - Running pre-action listener: _resource_record_pre_action 20:41:51 INFO - Running main action method: populate_webroot 20:41:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:41:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:41:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:41:51 INFO - '--tppagecycles', 20:41:51 INFO - '7'], 20:41:51 INFO - 'tests': ['tsvgm']}}, 20:41:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:41:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:41:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:41:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:41:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:41:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:41:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:41:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:41:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:41:51 INFO - 'talos_options': ['--e10s'], 20:41:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:41:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:41:51 INFO - 'tests': ['damp', 'tps']}, 20:41:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:41:51 INFO - 'talos_options': ['--e10s'], 20:41:51 INFO - 'tests': ['damp', 'tps']}, 20:41:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:41:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:41:51 INFO - 'other': {'tests': ['a11yr', 20:41:51 INFO - 'ts_paint', 20:41:51 INFO - 'tpaint', 20:41:51 INFO - 'sessionrestore', 20:41:51 INFO - 'sessionrestore_no_auto_restore']}, 20:41:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:41:51 INFO - 'tests': ['a11yr', 20:41:51 INFO - 'ts_paint', 20:41:51 INFO - 'tpaint', 20:41:51 INFO - 'sessionrestore', 20:41:51 INFO - 'sessionrestore_no_auto_restore']}, 20:41:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:41:51 INFO - 'tests': ['a11yr', 20:41:51 INFO - 'ts_paint', 20:41:51 INFO - 'tpaint', 20:41:51 INFO - 'sessionrestore', 20:41:51 INFO - 'sessionrestore_no_auto_restore']}, 20:41:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:41:51 INFO - 'tests': ['a11yr', 20:41:51 INFO - 'ts_paint', 20:41:51 INFO - 'tpaint', 20:41:51 INFO - 'sessionrestore', 20:41:51 INFO - 'sessionrestore_no_auto_restore']}, 20:41:51 INFO - 'other_l64': {'tests': ['a11yr', 20:41:51 INFO - 'ts_paint', 20:41:51 INFO - 'tpaint', 20:41:51 INFO - 'sessionrestore', 20:41:51 INFO - 'sessionrestore_no_auto_restore']}, 20:41:51 INFO - 'other_nol64': {'tests': ['a11yr', 20:41:51 INFO - 'ts_paint', 20:41:51 INFO - 'tpaint', 20:41:51 INFO - 'sessionrestore', 20:41:51 INFO - 'sessionrestore_no_auto_restore']}, 20:41:51 INFO - 'svgr': {'tests': ['tsvgx', 20:41:51 INFO - 'tsvgr_opacity', 20:41:51 INFO - 'tart', 20:41:51 INFO - 'tscrollx', 20:41:51 INFO - 'cart']}, 20:41:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:41:51 INFO - 'tests': ['tsvgx', 20:41:51 INFO - 'tsvgr_opacity', 20:41:51 INFO - 'tart', 20:41:51 INFO - 'tscrollx', 20:41:51 INFO - 'cart']}, 20:41:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:41:51 INFO - 'tests': ['tp5o']}, 20:41:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:41:51 INFO - 'talos_options': ['--e10s'], 20:41:51 INFO - 'tests': ['tp5o']}, 20:41:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:41:51 INFO - 'talos_options': ['--xperf_path', 20:41:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:41:51 INFO - 'tests': ['tp5n']}, 20:41:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:41:51 INFO - 'talos_options': ['--e10s', 20:41:51 INFO - '--xperf_path', 20:41:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:41:51 INFO - 'tests': ['tp5n']}}, 20:41:51 INFO - 'talos.zip': {'path': '', 20:41:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:41:51 INFO - Running post-action listener: _resource_record_post_action 20:41:51 INFO - ##### 20:41:51 INFO - ##### Running create-virtualenv step. 20:41:51 INFO - ##### 20:41:51 INFO - Running pre-action listener: _resource_record_pre_action 20:41:51 INFO - Running main action method: create_virtualenv 20:41:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:41:51 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:41:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:41:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:41:51 INFO - Using real prefix '/usr' 20:41:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:41:51 INFO - Installing distribute.............................................................................................................................................................................................done. 20:41:53 INFO - Installing pip.................done. 20:41:53 INFO - Return code: 0 20:41:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24334f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8c0>, '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 0x248e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ec50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', '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:41:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:41:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:41:53 INFO - Using env: {'DISPLAY': ':0', 20:41:53 INFO - 'HOME': '/home/cltbld', 20:41:53 INFO - 'LANG': 'en_US.UTF-8', 20:41:53 INFO - 'LANGUAGE': 'en_US:en', 20:41:53 INFO - 'LOGNAME': 'cltbld', 20:41:53 INFO - 'MAIL': '/var/mail/cltbld', 20:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:53 INFO - 'MOZ_NO_REMOTE': '1', 20:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:53 INFO - 'NO_EM_RESTART': '1', 20:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:41:53 INFO - 'PWD': '/builds/slave/test-pgo', 20:41:53 INFO - 'SHELL': '/bin/bash', 20:41:53 INFO - 'SHLVL': '1', 20:41:53 INFO - 'TERM': 'linux', 20:41:53 INFO - 'TMOUT': '86400', 20:41:53 INFO - 'USER': 'cltbld', 20:41:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', 20:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:53 INFO - '_': '/tools/buildbot/bin/python'} 20:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:54 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:41:54 INFO - Cleaning up... 20:41:54 INFO - Return code: 0 20:41:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f24334f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8c0>, '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 0x248e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ec50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', '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:41:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:41:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:41:54 INFO - Using env: {'DISPLAY': ':0', 20:41:54 INFO - 'HOME': '/home/cltbld', 20:41:54 INFO - 'LANG': 'en_US.UTF-8', 20:41:54 INFO - 'LANGUAGE': 'en_US:en', 20:41:54 INFO - 'LOGNAME': 'cltbld', 20:41:54 INFO - 'MAIL': '/var/mail/cltbld', 20:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:54 INFO - 'MOZ_NO_REMOTE': '1', 20:41:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:54 INFO - 'NO_EM_RESTART': '1', 20:41:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:41:54 INFO - 'PWD': '/builds/slave/test-pgo', 20:41:54 INFO - 'SHELL': '/bin/bash', 20:41:54 INFO - 'SHLVL': '1', 20:41:54 INFO - 'TERM': 'linux', 20:41:54 INFO - 'TMOUT': '86400', 20:41:54 INFO - 'USER': 'cltbld', 20:41:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', 20:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:54 INFO - '_': '/tools/buildbot/bin/python'} 20:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:54 INFO - Downloading/unpacking psutil>=0.7.1 20:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:41:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:41:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:41:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:41:56 INFO - Installing collected packages: psutil 20:41:56 INFO - Running setup.py install for psutil 20:41:56 INFO - building 'psutil._psutil_linux' extension 20:41:56 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:41:56 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:41:56 INFO - building 'psutil._psutil_posix' extension 20:41:56 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:41:56 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:41:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:41:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:41:56 INFO - Successfully installed psutil 20:41:56 INFO - Cleaning up... 20:41:56 INFO - Return code: 0 20:41:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f24334f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8c0>, '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 0x248e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ec50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', '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:41:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 20:41:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:41:56 INFO - Using env: {'DISPLAY': ':0', 20:41:56 INFO - 'HOME': '/home/cltbld', 20:41:56 INFO - 'LANG': 'en_US.UTF-8', 20:41:56 INFO - 'LANGUAGE': 'en_US:en', 20:41:56 INFO - 'LOGNAME': 'cltbld', 20:41:56 INFO - 'MAIL': '/var/mail/cltbld', 20:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:56 INFO - 'MOZ_NO_REMOTE': '1', 20:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:56 INFO - 'NO_EM_RESTART': '1', 20:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:41:56 INFO - 'PWD': '/builds/slave/test-pgo', 20:41:56 INFO - 'SHELL': '/bin/bash', 20:41:56 INFO - 'SHLVL': '1', 20:41:56 INFO - 'TERM': 'linux', 20:41:56 INFO - 'TMOUT': '86400', 20:41:56 INFO - 'USER': 'cltbld', 20:41:56 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', 20:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:56 INFO - '_': '/tools/buildbot/bin/python'} 20:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:41:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:41:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:41:58 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:41:58 INFO - Installing collected packages: mozsystemmonitor 20:41:58 INFO - Running setup.py install for mozsystemmonitor 20:41:58 INFO - Successfully installed mozsystemmonitor 20:41:58 INFO - Cleaning up... 20:41:58 INFO - Return code: 0 20:41:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:41:58 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:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:58 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:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:41:58 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 0x7f24334f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8c0>, '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 0x248e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ec50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', '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:41:58 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:41:58 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:41:58 INFO - Using env: {'DISPLAY': ':0', 20:41:58 INFO - 'HOME': '/home/cltbld', 20:41:58 INFO - 'LANG': 'en_US.UTF-8', 20:41:58 INFO - 'LANGUAGE': 'en_US:en', 20:41:58 INFO - 'LOGNAME': 'cltbld', 20:41:58 INFO - 'MAIL': '/var/mail/cltbld', 20:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:41:58 INFO - 'MOZ_NO_REMOTE': '1', 20:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:41:58 INFO - 'NO_EM_RESTART': '1', 20:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:41:58 INFO - 'PWD': '/builds/slave/test-pgo', 20:41:58 INFO - 'SHELL': '/bin/bash', 20:41:58 INFO - 'SHLVL': '1', 20:41:58 INFO - 'TERM': 'linux', 20:41:58 INFO - 'TMOUT': '86400', 20:41:58 INFO - 'USER': 'cltbld', 20:41:58 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', 20:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:41:58 INFO - '_': '/tools/buildbot/bin/python'} 20:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:41:59 INFO - Downloading/unpacking blobuploader==1.2.4 20:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:41:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:41:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:00 INFO - Downloading blobuploader-1.2.4.tar.gz 20:42:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:42:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:42:01 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:42:01 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:42:01 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:42:01 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:42:01 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:42:01 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:42:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:42:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:42:01 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:42:01 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:42:01 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:42:01 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:42:01 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:42:01 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:42:01 INFO - Downloading docopt-0.6.1.tar.gz 20:42:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:42:01 INFO - Installing collected packages: blobuploader, requests, docopt 20:42:01 INFO - Running setup.py install for blobuploader 20:42:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:42:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:42:01 INFO - Running setup.py install for requests 20:42:02 INFO - Running setup.py install for docopt 20:42:02 INFO - Successfully installed blobuploader requests docopt 20:42:02 INFO - Cleaning up... 20:42:02 INFO - Return code: 0 20:42:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:42: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:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42: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:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:02 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 0x7f24334f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8c0>, '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 0x248e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ec50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', '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:42:02 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:42:02 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:42:02 INFO - Using env: {'DISPLAY': ':0', 20:42:02 INFO - 'HOME': '/home/cltbld', 20:42:02 INFO - 'LANG': 'en_US.UTF-8', 20:42:02 INFO - 'LANGUAGE': 'en_US:en', 20:42:02 INFO - 'LOGNAME': 'cltbld', 20:42:02 INFO - 'MAIL': '/var/mail/cltbld', 20:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:02 INFO - 'MOZ_NO_REMOTE': '1', 20:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:02 INFO - 'NO_EM_RESTART': '1', 20:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:02 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:02 INFO - 'SHELL': '/bin/bash', 20:42:02 INFO - 'SHLVL': '1', 20:42:02 INFO - 'TERM': 'linux', 20:42:02 INFO - 'TMOUT': '86400', 20:42:02 INFO - 'USER': 'cltbld', 20:42:02 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', 20:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:02 INFO - '_': '/tools/buildbot/bin/python'} 20:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:42:02 INFO - Running setup.py (path:/tmp/pip-u12cqT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:42:02 INFO - Running setup.py (path:/tmp/pip-R3FafQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:42:02 INFO - Running setup.py (path:/tmp/pip-x0eXyK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:42:02 INFO - Running setup.py (path:/tmp/pip-iOuiFr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:42:02 INFO - Running setup.py (path:/tmp/pip-9BI9zc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:42:02 INFO - Running setup.py (path:/tmp/pip-kqvdjj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:42:03 INFO - Running setup.py (path:/tmp/pip-SiHTkM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:42:03 INFO - Running setup.py (path:/tmp/pip-kOpBLJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:42:03 INFO - Running setup.py (path:/tmp/pip-VpmlA7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:42:03 INFO - Running setup.py (path:/tmp/pip-f9StJZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:42:03 INFO - Running setup.py (path:/tmp/pip-AoYYuO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:42:03 INFO - Running setup.py (path:/tmp/pip-6GEpsL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:42:03 INFO - Running setup.py (path:/tmp/pip-iWx4_E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:42:03 INFO - Running setup.py (path:/tmp/pip-oXAlKm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:42:03 INFO - Running setup.py (path:/tmp/pip-T48NQd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:42:03 INFO - Running setup.py (path:/tmp/pip-LGzvZQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:42:03 INFO - Running setup.py (path:/tmp/pip-RFqkBV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:42:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:42:03 INFO - Running setup.py install for manifestparser 20:42:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:42:03 INFO - Running setup.py install for mozcrash 20:42:04 INFO - Running setup.py install for mozdebug 20:42:04 INFO - Running setup.py install for mozdevice 20:42:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:42:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:42:04 INFO - Running setup.py install for mozfile 20:42:04 INFO - Running setup.py install for mozhttpd 20:42:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:42:04 INFO - Running setup.py install for mozinfo 20:42:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:42:04 INFO - Running setup.py install for mozInstall 20:42:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:42:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:42:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:42:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:42:04 INFO - Running setup.py install for mozleak 20:42:04 INFO - Running setup.py install for mozlog 20:42:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:42:04 INFO - Running setup.py install for moznetwork 20:42:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:42:04 INFO - Running setup.py install for mozprocess 20:42:05 INFO - Running setup.py install for mozprofile 20:42:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:42:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:42:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:42:05 INFO - Running setup.py install for mozrunner 20:42:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:42:05 INFO - Running setup.py install for mozscreenshot 20:42:05 INFO - Running setup.py install for moztest 20:42:05 INFO - Running setup.py install for mozversion 20:42:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:42:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:42:05 INFO - Cleaning up... 20:42:05 INFO - Return code: 0 20:42:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:42: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:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42: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:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:05 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 0x7f24334f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8c0>, '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 0x248e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ec50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', '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:42:05 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:42:05 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:42:05 INFO - Using env: {'DISPLAY': ':0', 20:42:05 INFO - 'HOME': '/home/cltbld', 20:42:05 INFO - 'LANG': 'en_US.UTF-8', 20:42:05 INFO - 'LANGUAGE': 'en_US:en', 20:42:05 INFO - 'LOGNAME': 'cltbld', 20:42:05 INFO - 'MAIL': '/var/mail/cltbld', 20:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:05 INFO - 'MOZ_NO_REMOTE': '1', 20:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:05 INFO - 'NO_EM_RESTART': '1', 20:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:05 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:05 INFO - 'SHELL': '/bin/bash', 20:42:05 INFO - 'SHLVL': '1', 20:42:05 INFO - 'TERM': 'linux', 20:42:05 INFO - 'TMOUT': '86400', 20:42:05 INFO - 'USER': 'cltbld', 20:42:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', 20:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:05 INFO - '_': '/tools/buildbot/bin/python'} 20:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:42:05 INFO - Running setup.py (path:/tmp/pip-2Z2hyg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:42:05 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:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:42:05 INFO - Running setup.py (path:/tmp/pip-uQaule-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:42:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:42:05 INFO - Running setup.py (path:/tmp/pip-GJb6pb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:42:06 INFO - Running setup.py (path:/tmp/pip-gomoM2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:42:06 INFO - Running setup.py (path:/tmp/pip-HMur4N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:42:06 INFO - Running setup.py (path:/tmp/pip-smwu7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:42:06 INFO - Running setup.py (path:/tmp/pip-jVYE4L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:42:06 INFO - Running setup.py (path:/tmp/pip-RFYxYa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:42:06 INFO - Running setup.py (path:/tmp/pip-ev8fc4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:42:06 INFO - Running setup.py (path:/tmp/pip-kiCCXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:42:06 INFO - Running setup.py (path:/tmp/pip-OLKovU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:42:06 INFO - Running setup.py (path:/tmp/pip-URKetm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:42:06 INFO - Running setup.py (path:/tmp/pip-1Acs04-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:42:06 INFO - Running setup.py (path:/tmp/pip-o80BUR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:42:06 INFO - Running setup.py (path:/tmp/pip-ErT3Se-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:42:06 INFO - Running setup.py (path:/tmp/pip-Y5Y6sX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:42:06 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:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:42:06 INFO - Running setup.py (path:/tmp/pip-mIJ207-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:42:07 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:42:07 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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:42:07 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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:42:07 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:42:07 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:42:07 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:42:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:42:07 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:42:07 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:42:07 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:42:07 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:42:07 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:42:07 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:42:08 INFO - Downloading blessings-1.6.tar.gz 20:42:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:42:08 INFO - Installing collected packages: blessings 20:42:08 INFO - Running setup.py install for blessings 20:42:08 INFO - Successfully installed blessings 20:42:08 INFO - Cleaning up... 20:42:09 INFO - Return code: 0 20:42:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:42:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:42:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:42:09 INFO - Reading from file tmpfile_stdout 20:42:09 INFO - Current package versions: 20:42:09 INFO - argparse == 1.2.1 20:42:09 INFO - blessings == 1.6 20:42:09 INFO - blobuploader == 1.2.4 20:42:09 INFO - docopt == 0.6.1 20:42:09 INFO - manifestparser == 1.1 20:42:09 INFO - mozInstall == 1.12 20:42:09 INFO - mozcrash == 0.16 20:42:09 INFO - mozdebug == 0.1 20:42:09 INFO - mozdevice == 0.48 20:42:09 INFO - mozfile == 1.2 20:42:09 INFO - mozhttpd == 0.7 20:42:09 INFO - mozinfo == 0.9 20:42:09 INFO - mozleak == 0.1 20:42:09 INFO - mozlog == 3.1 20:42:09 INFO - moznetwork == 0.27 20:42:09 INFO - mozprocess == 0.22 20:42:09 INFO - mozprofile == 0.28 20:42:09 INFO - mozrunner == 6.11 20:42:09 INFO - mozscreenshot == 0.1 20:42:09 INFO - mozsystemmonitor == 0.0 20:42:09 INFO - moztest == 0.7 20:42:09 INFO - mozversion == 1.4 20:42:09 INFO - psutil == 3.1.1 20:42:09 INFO - requests == 1.2.3 20:42:09 INFO - wsgiref == 0.1.2 20:42:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:42:09 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:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:09 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:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:09 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 0x7f24334f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8c0>, '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 0x248e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ec50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', '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:42:09 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:42:09 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:42:09 INFO - Using env: {'DISPLAY': ':0', 20:42:09 INFO - 'HOME': '/home/cltbld', 20:42:09 INFO - 'LANG': 'en_US.UTF-8', 20:42:09 INFO - 'LANGUAGE': 'en_US:en', 20:42:09 INFO - 'LOGNAME': 'cltbld', 20:42:09 INFO - 'MAIL': '/var/mail/cltbld', 20:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:09 INFO - 'MOZ_NO_REMOTE': '1', 20:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:09 INFO - 'NO_EM_RESTART': '1', 20:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:09 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:09 INFO - 'SHELL': '/bin/bash', 20:42:09 INFO - 'SHLVL': '1', 20:42:09 INFO - 'TERM': 'linux', 20:42:09 INFO - 'TMOUT': '86400', 20:42:09 INFO - 'USER': 'cltbld', 20:42:09 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', 20:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:09 INFO - '_': '/tools/buildbot/bin/python'} 20:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 INFO - Cleaning up... 20:42:09 INFO - Return code: 0 20:42:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:42:09 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:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:09 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:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:09 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 0x7f24334f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8c0>, '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 0x248e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ec50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', '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:42:09 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:42:09 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:42:09 INFO - Using env: {'DISPLAY': ':0', 20:42:09 INFO - 'HOME': '/home/cltbld', 20:42:09 INFO - 'LANG': 'en_US.UTF-8', 20:42:09 INFO - 'LANGUAGE': 'en_US:en', 20:42:09 INFO - 'LOGNAME': 'cltbld', 20:42:09 INFO - 'MAIL': '/var/mail/cltbld', 20:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:09 INFO - 'MOZ_NO_REMOTE': '1', 20:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:09 INFO - 'NO_EM_RESTART': '1', 20:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:09 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:09 INFO - 'SHELL': '/bin/bash', 20:42:09 INFO - 'SHLVL': '1', 20:42:09 INFO - 'TERM': 'linux', 20:42:09 INFO - 'TMOUT': '86400', 20:42:09 INFO - 'USER': 'cltbld', 20:42:09 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', 20:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:09 INFO - '_': '/tools/buildbot/bin/python'} 20:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:09 INFO - Downloading/unpacking jsonschema 20:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:09 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:42:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:42:11 INFO - Downloading/unpacking functools32 (from jsonschema) 20:42:11 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:42:11 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:42:11 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:42:11 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:42:11 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:42:11 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:42:11 INFO - Downloading functools32-3.2.3-2.tar.gz 20:42:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:42:11 INFO - warning: no files found matching '*.txt' 20:42:11 INFO - no previously-included directories found matching 'build' 20:42:11 INFO - no previously-included directories found matching 'dist' 20:42:11 INFO - no previously-included directories found matching '.git*' 20:42:11 INFO - Installing collected packages: jsonschema, functools32 20:42:11 INFO - Running setup.py install for functools32 20:42:11 INFO - warning: no files found matching '*.txt' 20:42:11 INFO - no previously-included directories found matching 'build' 20:42:11 INFO - no previously-included directories found matching 'dist' 20:42:11 INFO - no previously-included directories found matching '.git*' 20:42:11 INFO - Successfully installed jsonschema functools32 20:42:11 INFO - Cleaning up... 20:42:11 INFO - Return code: 0 20:42:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:42:11 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:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:11 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:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:11 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 0x7f24334f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fe670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8c0>, '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 0x248e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ec50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', '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:42:11 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:42:11 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:42:11 INFO - Using env: {'DISPLAY': ':0', 20:42:11 INFO - 'HOME': '/home/cltbld', 20:42:11 INFO - 'LANG': 'en_US.UTF-8', 20:42:11 INFO - 'LANGUAGE': 'en_US:en', 20:42:11 INFO - 'LOGNAME': 'cltbld', 20:42:11 INFO - 'MAIL': '/var/mail/cltbld', 20:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:11 INFO - 'MOZ_NO_REMOTE': '1', 20:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:11 INFO - 'NO_EM_RESTART': '1', 20:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:11 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:11 INFO - 'SHELL': '/bin/bash', 20:42:11 INFO - 'SHLVL': '1', 20:42:11 INFO - 'TERM': 'linux', 20:42:11 INFO - 'TMOUT': '86400', 20:42:11 INFO - 'USER': 'cltbld', 20:42:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', 20:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:11 INFO - '_': '/tools/buildbot/bin/python'} 20:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:12 INFO - Downloading/unpacking flake8 20:42:12 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:42:12 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:42:12 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:42:12 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:42:12 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:42:12 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:42:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:42:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:42:13 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:42:13 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:42:13 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:42:13 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:42:13 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:42:13 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:42:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:42:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:42:14 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:42:14 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:42:14 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:42:14 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:42:14 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:42:14 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:42:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:42:14 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:42:14 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:42:14 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:42:14 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:42:14 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:42:14 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:42:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:42:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:42:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:42:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:42:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:42:14 INFO - no previously-included directories found matching 'docs/_build' 20:42:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:42:14 INFO - Running setup.py install for pep8 20:42:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:42:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:42:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:42:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:42:14 INFO - no previously-included directories found matching 'docs/_build' 20:42:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:42:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:42:14 INFO - Cleaning up... 20:42:14 INFO - Return code: 0 20:42:14 INFO - Running post-action listener: _resource_record_post_action 20:42:14 INFO - Running post-action listener: _start_resource_monitoring 20:42:14 INFO - Starting resource monitoring. 20:42:14 INFO - ##### 20:42:14 INFO - ##### Running install step. 20:42:14 INFO - ##### 20:42:14 INFO - Running pre-action listener: _resource_record_pre_action 20:42:14 INFO - Running main action method: install 20:42:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:42:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:42:15 INFO - Reading from file tmpfile_stdout 20:42:15 INFO - Detecting whether we're running mozinstall >=1.0... 20:42:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:42:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:42:15 INFO - Reading from file tmpfile_stdout 20:42:15 INFO - Output received: 20:42:15 INFO - Usage: mozinstall [options] installer 20:42:15 INFO - Options: 20:42:15 INFO - -h, --help show this help message and exit 20:42:15 INFO - -d DEST, --destination=DEST 20:42:15 INFO - Directory to install application into. [default: 20:42:15 INFO - "/builds/slave/test-pgo"] 20:42:15 INFO - --app=APP Application being installed. [default: firefox] 20:42:15 INFO - mkdir: /builds/slave/test-pgo/build/application 20:42:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 20:42:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 20:42:31 INFO - Reading from file tmpfile_stdout 20:42:31 INFO - Output received: 20:42:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:42:31 INFO - Running post-action listener: _resource_record_post_action 20:42:31 INFO - ##### 20:42:31 INFO - ##### Running run-tests step. 20:42:31 INFO - ##### 20:42:31 INFO - Running pre-action listener: _resource_record_pre_action 20:42:31 INFO - Running main action method: run_tests 20:42:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:42:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:42:31 INFO - Python 2.7.3 20:42:31 INFO - Return code: 0 20:42:31 INFO - grabbing minidump binary from tooltool 20:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:31 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 0x248d8c0>, '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 0x248e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248ec50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:42:31 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:42:31 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:42:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:42:31 INFO - Return code: 0 20:42:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:42:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:42:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:42:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:42:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:42:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:42:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:42:32 INFO - Return code: 0 20:42:32 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/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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:42:32 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/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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:42:32 INFO - Using env: {'DISPLAY': ':0', 20:42:32 INFO - 'HOME': '/home/cltbld', 20:42:32 INFO - 'LANG': 'en_US.UTF-8', 20:42:32 INFO - 'LANGUAGE': 'en_US:en', 20:42:32 INFO - 'LOGNAME': 'cltbld', 20:42:32 INFO - 'MAIL': '/var/mail/cltbld', 20:42:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:42:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:32 INFO - 'MOZ_NO_REMOTE': '1', 20:42:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:32 INFO - 'NO_EM_RESTART': '1', 20:42:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:32 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:42:32 INFO - 'SHELL': '/bin/bash', 20:42:32 INFO - 'SHLVL': '1', 20:42:32 INFO - 'TERM': 'linux', 20:42:32 INFO - 'TMOUT': '86400', 20:42:32 INFO - 'USER': 'cltbld', 20:42:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993', 20:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:32 INFO - '_': '/tools/buildbot/bin/python'} 20:42:32 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/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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:42:32 INFO - mozversion application_buildid: 20160210173008 20:42:32 INFO - mozversion application_changeset: c507aa4e2a21bf01e7580fc431a313b0b442fc61 20:42:32 INFO - mozversion application_display_name: Nightly 20:42:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:42:32 INFO - mozversion application_name: Firefox 20:42:32 INFO - mozversion application_remotingname: firefox 20:42:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:42:32 INFO - mozversion application_vendor: Mozilla 20:42:32 INFO - mozversion application_version: 47.0a1 20:42:32 INFO - mozversion platform_buildid: 20160210173008 20:42:32 INFO - mozversion platform_changeset: c507aa4e2a21bf01e7580fc431a313b0b442fc61 20:42:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:42:32 INFO - mozversion platform_version: 47.0a1 20:42:32 INFO - using testdate: 1455165752 20:42:32 INFO - actual date: 1455165752 20:42:32 INFO - starting webserver on 'localhost:50522' 20:42:32 INFO - SUITE-START | Running 2 tests 20:42:32 INFO - TEST-START | dromaeo_css 20:42:32 INFO - operating with platform_type : linux_ 20:42:32 INFO - Initialising browser for dromaeo_css test... 20:42:32 INFO - TEST-INFO | started process 12940 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxGX0Vt/profile http://localhost:50522/getInfo.html) 20:42:36 INFO - PROCESS | 12940 | __metrics Screen width/height:1600/1200 20:42:36 INFO - PROCESS | 12940 | colorDepth:24 20:42:36 INFO - PROCESS | 12940 | Browser inner width/height: 1024/697 20:42:36 INFO - PROCESS | 12940 | __metrics 20:42:37 INFO - PROCESS | 12940 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:42:38 INFO - TEST-INFO | 12940: exit 0 20:42:38 INFO - Browser initialized. 20:42:38 INFO - Running cycle 1/1 for dromaeo_css test... 20:42:38 INFO - TEST-INFO | started process 13031 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxGX0Vt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:42:50 INFO - PROCESS | 13031 | RSS: Main: 152907776 20:42:50 INFO - PROCESS | 13031 | 20:43:41 INFO - PROCESS | 13031 | 1455165821688 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:45:50 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:50522/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50522/tests/dromaeo/cssquery-ext.html) 20:45:51 INFO - PROCESS | 13031 | RSS: Main: 277626880 20:45:51 INFO - PROCESS | 13031 | 20:48:53 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:50522/tests/dromaeo/cssquery-ext.html (next: http://localhost:50522/tests/dromaeo/cssquery-jquery.html) 20:48:54 INFO - PROCESS | 13031 | RSS: Main: 236564480 20:48:54 INFO - PROCESS | 13031 | 20:51:56 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:50522/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50522/tests/dromaeo/cssquery-mootools.html) 20:51:56 INFO - PROCESS | 13031 | RSS: Main: 242479104 20:51:56 INFO - PROCESS | 13031 | 20:54:58 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:50522/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50522/tests/dromaeo/cssquery-prototype.html) 20:54:59 INFO - PROCESS | 13031 | RSS: Main: 220160000 20:54:59 INFO - PROCESS | 13031 | 20:58:02 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:50522/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50522/tests/dromaeo/cssquery-yui.html) 20:58:02 INFO - PROCESS | 13031 | RSS: Main: 221982720 20:58:02 INFO - PROCESS | 13031 | 21:01:04 INFO - PROCESS | 13031 | Cycle 1(1): loaded http://localhost:50522/tests/dromaeo/cssquery-yui.html (next: http://localhost:50522/tests/dromaeo/cssquery-dojo.html) 21:01:05 INFO - PROCESS | 13031 | RSS: Main: 294821888 21:01:05 INFO - PROCESS | 13031 | 21:01:05 INFO - PROCESS | 13031 | __start_tp_report 21:01:05 INFO - PROCESS | 13031 | _x_x_mozilla_page_load 21:01:05 INFO - PROCESS | 13031 | _x_x_mozilla_page_load_details 21:01:05 INFO - PROCESS | 13031 | |i|pagename|runs| 21:01:05 INFO - PROCESS | 13031 | |0;dojo.html;3147.9055628331153;3158.66833982432;3180.6819318068196;3211.454052811022;3238.659940706225;5119.488051194879;5206.50538198871;5207.0366982108335;5271.130263506521;5291.708956007418;5229.450907654698;5279.5512381447625;5307.814226502073;5311.840644780653;5327.706976116312;4704.6001089907395;4741.6680832341835;4827.179379505493;4852.611791056707;4882.194437917739;4649.86050418488;4831.637627177958;4857.149998750205;4872.902541949159;4890.095332363524;4744.715317080969;4753.85738427846;4826.155422801031;4848.369711937461;4869.026194761026;4739.478657347689;4781.282807578857;4786.712797232177;4787.569118779292;4819.7108173509705;4713.449885419716;4725.314829349725;4753.31076993834;4776.426828780569;4816.686915350491;5020.3724534433195;5048;5075.289459475676;5102.489751024905;5153.716545589991;5601;5606.21512988182;5608.355039170466;5617;5626.803061892855;5532.723363831792;5636.915446268309;5654.491095801356;5659.717014149317;5663.773449062032;5150.304708864331;5156.226566015091;5158.148905430599;5165.096108181091;5276.366835979707;5766.077427611562;5770.653760774367;5772.191893134965;5812.941870581325;5821.563382746311;5508.394076651565;5526.392096869341;5527.143292789544;5535.308086489189;5544.306961629796;5512.834614961557;5551.028570000234;5558.916616250759;5568.7215639217875;5602.579806514527;5606.046972014768;5643.40744221859;5652.689102099342;5656.802011929645;5704;5567.443255674481;5579.888402231933;5598.580106491948;5614.550835933115;5620.185073164368;4215.936760948588;4303.139372125587;4368.497622773421;4376.387305777193;4408.404865343137;3831.5210598675167;3860.2665493556133;3871.903202419962;3872.3997780344093;3909.7263191576317;5204.8178313758835;5205.115130427836;5212.869678258074;5213.556847667991;5217.791288348423;5414.242006119146;5491.039068163055;5607.663540187602;5679.545636349082;5690.5447564194765;5072.746362681851;5094.541491265803;5097.46476619957;5101.234814777813;5131.692098474104;4694.131585656664;4694.225452800318;4697.600703940203;4728.503507131771;4739.715617062987;5600.215969764236;5676.148577713376;5758.395368486333;5769.711514424262;5857.209276747755;5551.583631227755;5597.944020559742;5608.130739735348;5612.074007788669;5614.326280846324;5773.74018169175;5781.566382521243;5808.73860676279;5816.883662326645;5828.446297601721;5425.1862220665635;5438.075527160471;5495.258140151188;5500.394956554695;5556.38879723222;5521.061419558604;5552.028395030773;5554.416786237387;5557.777688892399;5559.8610034747835;5369.060414427381;5397.298351214474;5436.456354364532;5439.401665816677;5474.671519708831;5411.540019098264;5446.210299506629;5505.421930697379;5508.55931525469;5522.06124958766;5381.27352807366;5397.379301380392;5398.055340315351;5399.703016333982;5401.837944861661;5470.781168753365;5479.0685583451705;5491.121420572849;5503.753240072627;5553.750081246434;5288.259643649815;5363.678179309254;5366.195070739421;5404.135338345845;5512.80705175333 21:01:05 INFO - PROCESS | 13031 | |1;ext.html;533.2268211093914;535.9330083739535;537.8413368056425;557.3506864502854;567.9829605111848;27705.861470692642;28049.719502804965;28056.85971570142;28108.15675529732;28109.718902810964;28505.42989140216;35962.2807543849;36613;36617;36876.81561592195;8422.241998220174;8633.395662303641;8663.090375510576;8674.566271686423;8682.088380720028;8766.298696104297;8929.821403571925;8937.865932011026;8937.95531022344;8942.239909607692;8914.331425143107;9022.09779022099;9022.50376229307;9026.954865225665;9040.367174297802;8875.112488751105;8945.642174313052;8950.328725345626;8953.194212520839;8957.104289571056;8844;8879.33404994628;8880.467171969702;8885.42244754089;8885.733427997171;38333.23333533342;38647.806760966014;38676;38703.61296387056;38718.419223711666;3225.9354812903844;3335.7498187635783;3659.1218107654236;3874.1136957333;3952.288588054149;29000.27499312513;29164.854175728986;29559;29635.110946671633;29845;3890.7081968852167;3933;3936.2324346752393;3964.623360780721;3986.0832008637885;193979;194751;195090;195268;195582;55343.44656553383;55700.44299557034;55827.441725582226;55844;55932.72033639806;52096.47903520992;52401;56723;59419.40580594225;60005;15482.30329635169;15504.844951550565;15558.9222053889;15562;15616;11361.977422032056;11952.940235298942;12117.333546655018;12119.878801212051;12124.333161676017;18925.14836832346;19150.904245478683;19215.231390744495;19267.325643602406;19406;7392.852142957111;7625.6568454418575;7659.770206893802;7671.2712292332135;7852.764417067498;988.2736188901152;997.7555498902815;1044.7805960748176;1065.3448129400363;1090.4438736244413;27613.86193069062;27919.162425127277;28156.8592157042;30155.547666785016;32017.519737203962;1085.7719878825378;1094.1574987259924;1102.2559772153763;1141.1042331769522;1184.1296646964474;14507.419703211754;14718.779218311734;14746.705065898837;14931.25343732809;14952.327145278488;303113;305765;306277;306721;307629;49266.26100608494;50093.24860127101;50167.74916125469;50168.74915625399;50236;1311.3377744238908;1313.1267706974945;1323.483841301893;1350.608323586149;1352.3305963548107;27677.584836227874;28753.568696469152;29160.562591561567;29182.854085729436;29185.85407072951;43188.13623727445;47417.76291118522;48617;49239.75380123076;49247;193909;194414;195183;195534;196120;26652;27096.32259193536;27133;27173.184804455897;27207.91168353244;42200.199982179955;42982.78508607437;43296.103350697325;43741.78129109334;43971.34042989422;36162.8191859039;36382.63617363898;36498.452523212705;37251.25497490089;37918.620813792615;35871;36230.27539449249;36241.64409433081;36967.26065478729;37343.81328093342;31857.20356991001;36589;36756.632433675324;37655.058623533536;37909.431358529095;26829.865850670623;29388;31722;31917.36165276635;32027.519587206676;25450.490990179722;25982.480350393264;26107.216783496526;26154.607680884423;26530.60204096979 21:01:05 INFO - PROCESS | 13031 | |2;jquery.html;368.2138634016375;369.18226129124;369.4698108214711;373.29819938515584;374.6010498818756;13871.237081960513;15507.612309692264;16260.430884919015;16789.748153777702;17480.562985925357;10893.945530272358;11264.887351126506;11539.942300288487;11566;11575.594854180106;3718.9442158367647;4795.23276275796;4928.310036594879;4941.407031156248;4947.282644016615;3792.27946690128;5145;5356.651817631861;5358.651687640291;5362.329708786402;5305.310309659739;5324.41431442541;5380.21986811912;5790.697093154049;5796.24648795656;5598.468145526169;5778.191053252548;5807.883842323172;5829.446202610745;5848.883022339551;5225.346831646044;5262.23697563855;5294.682319060868;5296.602754793406;5298.125809241471;20238.291659791983;20736.96315184235;20860.791392086037;20917.37247882566;20968.895155524126;1955.4915721912405;2125.192426877792;2233.4416395901026;2237.0827960536103;2274.40865375002;9703.854442183372;9722.902770972341;9723.124918757347;9758.756031099208;9882.851757223647;1811.8278763517444;1815.282963229517;1815.4190658989128;1851.3150134450204;1883.8210370014826;58409;59115;60239.69880150615;60263.39736602622;60636.09045864359;9833.704988850346;10084.74788130288;10312.742181445525;10326.638567650096;10414.739631509121;12920.676983075498;13543.796843047363;13697.794533082011;13741.656458588615;13772.586822395344;7038;7237.421006319481;7446.590437525988;7454.142773581108;7516.624168791648;7104.573725576482;7116.466265030143;7156.677949492181;7168.5698858067635;7172.713091476387;4168.166366726667;4213.810378532912;4266;4303.268444364466;4311.762853043113;1768.938087166943;1794.9820501794816;1836.6818145579432;1853.7404763333145;1899.6960486322123;930.734740598926;965.2278177458005;999.415342024909;1000.479750529735;1046.0428707732492;16681.749773753403;17153.571160721083;17455.690589015176;17537.386191483238;17631.030293333988;912.6303846942;917.2478567574658;994.1450352696675;1012.7620009297809;1014.5586669798661;9703.563339649732;9712.611495540099;10012.64955726546;10250.846237306447;10327.277090603586;382661;384947;387965;389508;482032;44994;47350.5264947353;70901;77394;79535;1095.2114477576133;1115.1803424482998;1129.5651174297955;1130.7512347283584;1132.2938177755173;15824.129672867643;15983;16009.439669611507;16122.435714749927;16365;30385.69614303917;31787.046388608378;32000.199995000312;32156.83921580377;33701.49447758237;42254.1549169021;42681.57318426776;43704.78147609369;43773;43940.12119757651;7182.892256616259;7470.140933792466;7475.514091584029;7517.060367454068;7595.126560445619;9140.817183656423;10528.842067369149;10985.450727463434;11022.283551569442;11525.654230373102;9675.676479481075;9852.68461911436;9909.207263419054;10112.089911907964;10364.637237696947;10145.644902428674;10236.795264094528;10264.819545752334;10452.372857628567;10759.946200268949;7712.295086055183;9007.684731034382;9878.209743220668;10519.579216831242;10574;7000.439964802906;7187.7484288051755;7229.819254518679;7346.96326518364;7519.661615227437;9754.804903902024;10292.433916134685;10326.586936522755;10370.42962637032;10782.514786834454 21:01:05 INFO - PROCESS | 13031 | |3;mootools.html;1369.3016561553618;1440.0999375390377;1456.6431224350035;1631.8612917901978;1814.582645991422;7014.9649251753735;7652.961735191323;7836.764897053084;7843.294103530681;7855.253750893656;7446.813829654261;7618.92381076189;7624.199459056802;7632.771016869503;7651.426143039266;2070.6583413736716;2119.7668256491775;2313.6760853480528;2360.9881950590266;2386.55848667997;2378.9286321410386;2416.5529377065213;2419.5040016796515;2419.6128619420897;2422.2854257993936;2354.6350315701093;2418.6855708757926;2420.5279970405777;2421.055788242587;2423.8424502407374;2339.520398318349;2362.6337917622795;2363.3855197648563;2365.3613524348416;2384.3443053160345;2323;2325.8837058147196;2349.189529612298;2366.6213405854983;2368.692070030885;7755.340796032344;7763.107242667109;7786.7663970080985;7791.337736292422;7796.727114550963;4861.1006963711825;5004.624653150991;5014.974925125351;5018.64869459138;5028.572571331441;3208.1498402923244;3262.1192278085023;3292;3300.1914530939835;3303.487959366302;994.7761753605454;999.7950420163849;1009.0565321424418;1755.9473215803418;1920.2223099644666;10501.10740587051;10609;10671.893281067167;10688.465576721055;10703.090237329836;4463.910721785611;4523.434570678665;4550.817967281272;4554.863354099382;4652.116097941381;9353.438793672402;9368.156865881967;9373.343865929455;9376.062393760705;9394.389364691273;5008.12357837377;5012.899742005139;5013.473585273567;5043.117454445457;5073.822416215415;4577.816887324537;4593.862184134481;4594.908101837945;4598.379218805485;4605.240135377625;3511.666391692785;3680.7975561343846;3696.242270334575;3707.8146092695256;3725.4411838224482;1227.6930767308172;1265.2092442223611;1270.39021269791;1278.4438769135456;1283.4096315694699;1011.0193112680688;1035.1408331085331;1037.9532921018422;1163.2264544078262;1324.0863803975226;7171.1394632644415;7327.487075904742;7344.081989751281;7352.338289553859;7375.631218439056;1080.270817198388;1089.591403223791;1104.7845670094255;1109.8113320735333;1134.65393055119;5773.336066352339;5833.329167145747;5838.416158384212;5841.766329346779;5853.502452291603;9318.95340523293;9368.90631093694;9486.573104210327;9507.286953478517;9604.711858644252;9345;9480.33637645372;9495.857562136573;9496.715098547054;9501.192398646193;7296.927030729731;7363.9631801841715;7414.110306763115;7453.329200371993;7478.326950574366;7139;7161.677724502306;7175;7187.209406965334;7201.4958952874895;8126.715564955198;8235;8366.790830229293;8564.52895090776;8564.571771411529;8718.520481373585;8791.07693692153;8805.427647203167;8810.678398240316;8812.779680508038;6198.442140207403;6607.768728094494;6797.524173307821;6823.488238382042;6845.418139458003;7283.781486555412;7493.325600695964;7518.022657054548;7535.208803075599;7541.924580754342;6943.062686537252;7105.893411598727;7118.359347658736;7225.530340527849;7232;6997.615131167631;7013;7025.192102908231;7149.999000140088;7251.637418128967;7159;7184.928150718426;7186.892196617159;7241.167265764505;7246.60143692102;6462.870742585216;6472.320406357265;6480.6435646038035;6486.0919471275;6487.54587178893;6525.771597994048;6604.471642268511;6626.370494802986;6641.900371494528;6643.202815662152 21:01:05 INFO - PROCESS | 13031 | |4;prototype.html;326.56566766200956;332.6241347277576;343.10449726214574;351.8539805980518;354.0723304941053;5595.888082238353;5717.714114294289;5738.225339579156;5804.100364443513;5804.390538993408;5560.138178582316;5681.460261275182;5704.172894930243;5711.885762284752;5724.255846739918;4543.318502224676;4544;4551.931721024187;4557.08858228354;4570.497245303014;4360.912781744379;4407.316865885777;4494.865154045384;4533.727976321431;4541.977290113545;4481.7983190756495;4494.4831344395325;4498.167838949805;4516.706414083091;4525.140223357552;4493.618042466378;4502.639788816887;4512.165249428866;4513.7517436540975;4519.683622146451;3996.2407142642805;4005.959940400617;4006.198760247962;4007.8196481158125;4012.3981402789523;5311.840644780663;5431.34823821144;5433;5483.314585676791;5492.258545096401;5127.256547800585;5145.76844042019;5149.433562308143;5152.330197074394;5154.175331946908;5808.448197421239;6119.66341851198;6128.601640893327;6128.662923539204;6129.295131059941;4173.9582604174175;4236.57634236577;4240.978795106035;4251.022264879064;4252.043290259667;6277.7175027123885;6303.243610766737;6348.016057511093;6361.3638636136475;6374.490040796772;4382.824687012548;4386.947132688132;4389.056352884081;4392.407025051641;4393.945453091299;4279.186954478639;4412.227860124465;4439.1121775645;4454.175977444183;4455;5056.924146137737;5057;5058;5059.19052951526;5059.747012649353;6039.48664363534;6045.939540604626;6106.511479081662;6148.385161483905;6149.877002459926;1544.5906834688817;1567.5375764149603;1567.6942996115877;1568.0670001349406;1571.724948134072;1054.847047178155;1058.4072919165292;1058.724731569782;1059.920505962056;1085.066842515436;5831.2127862738835;5837.0368889132815;5840;5844.357120716718;5851.268591426072;6306.842328941813;6315.715792789336;6316.463100636497;6318.147050148263;6329.810105696744;5796.971015144897;5819;5819.272590926134;5824.271966004249;5828.854278642983;3296.78570892896;3388.1360253135786;3397.2695870387984;3403.3363494118407;3405.250844814137;6556.901646475307;6566.080748695186;6578.736850526021;6581.670916454158;6581.901271480931;6458.741650334028;6459.257185423642;6459.386358295955;6468.708908099147;6471.482281417475;6392.16901802772;6549.214094308618;6558.311377305409;6558.508111891627;6559.048937904073;6114.419130182803;6180.7527698891545;6299;6303.117563541016;6310.7791227306825;6190.690465476618;6268.937310626835;6281.403266689657;6286.779962701284;6288.968555157195;6592.24189218246;6594.340565943367;6601.108850305147;6602.8349291268105;6603.20761508622;4300.655947524128;4382.671299652475;4382.934255986099;4389.034412429261;4390.692651514363;6385;6385.840353991188;6387.808365749035;6397;6399.232092148972;6196.876062478635;6213.96893015532;6215;6215.974364230033;6218.160548326099;5984.611000284967;6189.6286222826775;6193.783217587363;6202.193714817226;6203.689815509116;5998.370171131968;6046.7581296749395;6056.091586262096;6065.696715164136;6079.604825686316;6201.534884883562;6206.689665516797;6208.875822483616;6210.378962103934;6215.751369945152;5904.143899134516;6048.6975651218145;6072.05883088122;6073.514118870568;6074.633207528271 21:01:05 INFO - PROCESS | 13031 | |5;yui.html;600.4877107766274;677.4309579952838;680.9693563789629;683.9863202735944;694.1011390249627;13576.660583485405;13699.657508562292;13707.246101464416;13732.794008089886;13743.175409475414;12442.93778531106;12493.750124997494;12502.499900004012;12518.12373133881;12520.18618789778;821.4291067707945;839.2782207301716;839.3956351426963;839.9412041157121;840.1178762299592;822.7161629237934;823.5717426937989;825.8719898415756;826.1985873702499;826.2109685250572;879.134052957836;879.7580665317025;880.7445840706188;881.0748713850463;882.629295695806;872.4721543466238;873.9606717697719;874.4534665833854;877.171073335698;878.0736323179044;645.8675971425846;646.6734299178885;646.7122130651862;647.0133047103205;647.1877793369339;13494.460221591222;13502.594922152253;13535.458581656721;13536.86463135366;13542.93228533861;11634.883651163465;11727.061835053175;11857.644270671808;11932.582359617372;12038.277703337828;9463.101005404476;9576;9697.757556061084;9797.265205109574;9892.455914924676;4016.4778578784862;4055.290324193284;4067.28822456069;4072.8370865165357;4190.580941905785;44718;44789;45064.09871802579;45160.548394515965;45282.32076518822;8271.586420678943;8412.915870841212;8500.617472213766;8616.956915215384;8668.393212475066;16683.91658041702;16744.83255167457;16904.57738556546;16937.407190748265;16949.0678012708;7389.334959853639;7435.51669141504;7562.962185189039;7573.318401343795;7620.923790762133;4142.212979533879;4171.603697648779;4210.368444733314;4236.576342365739;4325.5674432557125;3106.1613364391487;3112.7042930921525;3119.313750974782;3128.4838001729913;3137.8901738439044;570.6946783470823;593.9316978547522;604.7490291528966;614.8954677704801;618.8855061813579;502.9446760856303;545.0706545340186;579.3828829497977;589.8201048680108;590.3918963467635;8270.545120018336;8389.664413423518;8458.74623761288;8473.703420380258;8479.364047696448;476.73323752416013;542.2530315519818;558.6452602597379;571.8598943258928;578.9218455508536;3850.8844734658005;3850.9037274068373;3875.7093218008763;3991.481107456012;4124.546299907008;55580.44419555834;56470;56547.43452565504;56643.71678141583;56720;43354;47876.88002798209;50390.748046259534;50694.493055068975;52116.21825672618;42536.57463425326;43877.78061109674;46385.53614463812;46949;46959.29561056587;7857.528548287121;7918.920810791818;8105.554194519123;8416.747497575083;8494.57527123629;30413.391732165674;30952.380952380376;35253.47119793154;36028.27943441169;36657.63342366542;42616.36075458809;42972.78513607412;43177.56822431736;43330;48366.27450588314;10685.51915163804;10866.293690910066;10995.835062474229;10998.835017474905;11261.774764504828;10782.406967616856;10878.728031798952;11301.547938082385;11313.830292545454;11616.477258523219;10332.173426126043;10483.52824122901;10646.041856232976;10684.46577671129;10738.946305268424;10465.476726163814;10726.892731072589;10745.946270268598;10932.508037138507;11046.558137674403;10289.691309260734;10673.306235094695;10756;10773.138148947908;10873.184511161537;8311.418200725891;8360.581970901552;8404.243618074403;8405.32757379396;8754.69358572447;8261.008678958564;8611.65553377858;8775.648974040967;8958.372913896226;9047.230985366054 21:01:05 INFO - PROCESS | 13031 | __end_tp_report 21:01:05 INFO - PROCESS | 13031 | __start_cc_report 21:01:05 INFO - PROCESS | 13031 | _x_x_mozilla_cycle_collect,944 21:01:05 INFO - PROCESS | 13031 | __end_cc_report 21:01:05 INFO - PROCESS | 13031 | __startTimestamp1455166865244__endTimestamp 21:01:05 INFO - PROCESS | 13031 | 21:01:05 INFO - PROCESS | 13031 | ------- Summary: start ------- 21:01:05 INFO - PROCESS | 13031 | Number of tests: 6 21:01:05 INFO - PROCESS | 13031 | 21:01:05 INFO - PROCESS | 13031 | [#0] dojo.html Cycles:165 Average:5195.29 Median:5398.06 stddev:565.15 (10.5%) stddev-sans-first:543.59 21:01:05 INFO - PROCESS | 13031 | Values: 3147.9 3158.7 3180.7 3211.5 3238.7 5119.5 5206.5 5207.0 5271.1 5291.7 5229.5 5279.6 5307.8 5311.8 5327.7 4704.6 4741.7 4827.2 4852.6 4882.2 4649.9 4831.6 4857.1 4872.9 4890.1 4744.7 4753.9 4826.2 4848.4 4869.0 4739.5 4781.3 4786.7 4787.6 4819.7 4713.4 4725.3 4753.3 4776.4 4816.7 5020.4 5048.0 5075.3 5102.5 5153.7 5601.0 5606.2 5608.4 5617.0 5626.8 5532.7 5636.9 5654.5 5659.7 5663.8 5150.3 5156.2 5158.1 5165.1 5276.4 5766.1 5770.7 5772.2 5812.9 5821.6 5508.4 5526.4 5527.1 5535.3 5544.3 5512.8 5551.0 5558.9 5568.7 5602.6 5606.0 5643.4 5652.7 5656.8 5704.0 5567.4 5579.9 5598.6 5614.6 5620.2 4215.9 4303.1 4368.5 4376.4 4408.4 3831.5 3860.3 3871.9 3872.4 3909.7 5204.8 5205.1 5212.9 5213.6 5217.8 5414.2 5491.0 5607.7 5679.5 5690.5 5072.7 5094.5 5097.5 5101.2 5131.7 4694.1 4694.2 4697.6 4728.5 4739.7 5600.2 5676.1 5758.4 5769.7 5857.2 5551.6 5597.9 5608.1 5612.1 5614.3 5773.7 5781.6 5808.7 5816.9 5828.4 5425.2 5438.1 5495.3 5500.4 5556.4 5521.1 5552.0 5554.4 5557.8 5559.9 5369.1 5397.3 5436.5 5439.4 5474.7 5411.5 5446.2 5505.4 5508.6 5522.1 5381.3 5397.4 5398.1 5399.7 5401.8 5470.8 5479.1 5491.1 5503.8 5553.8 5288.3 5363.7 5366.2 5404.1 5512.8 21:01:05 INFO - PROCESS | 13031 | 21:01:05 INFO - PROCESS | 13031 | [#1] ext.html Cycles:180 Average:40428.96 Median:36235.96 stddev:61980.20 (171.0%) stddev-sans-first:62081.68 21:01:05 INFO - PROCESS | 13031 | Values: 533.2 535.9 537.8 557.4 568.0 27705.9 28049.7 28056.9 28108.2 28109.7 28505.4 35962.3 36613.0 36617.0 36876.8 8422.2 8633.4 8663.1 8674.6 8682.1 8766.3 8929.8 8937.9 8938.0 8942.2 8914.3 9022.1 9022.5 9027.0 9040.4 8875.1 8945.6 8950.3 8953.2 8957.1 8844.0 8879.3 8880.5 8885.4 8885.7 38333.2 38647.8 38676.0 38703.6 38718.4 3225.9 3335.7 3659.1 3874.1 3952.3 29000.3 29164.9 29559.0 29635.1 29845.0 3890.7 3933.0 3936.2 3964.6 3986.1 193979.0 194751.0 195090.0 195268.0 195582.0 55343.4 55700.4 55827.4 55844.0 55932.7 52096.5 52401.0 56723.0 59419.4 60005.0 15482.3 15504.8 15558.9 15562.0 15616.0 11362.0 11952.9 12117.3 12119.9 12124.3 18925.1 19150.9 19215.2 19267.3 19406.0 7392.9 7625.7 7659.8 7671.3 7852.8 988.3 997.8 1044.8 1065.3 1090.4 27613.9 27919.2 28156.9 30155.5 32017.5 1085.8 1094.2 1102.3 1141.1 1184.1 14507.4 14718.8 14746.7 14931.3 14952.3 303113.0 305765.0 306277.0 306721.0 307629.0 49266.3 50093.2 50167.7 50168.7 50236.0 1311.3 1313.1 1323.5 1350.6 1352.3 27677.6 28753.6 29160.6 29182.9 29185.9 43188.1 47417.8 48617.0 49239.8 49247.0 193909.0 194414.0 195183.0 195534.0 196120.0 26652.0 27096.3 27133.0 27173.2 27207.9 42200.2 42982.8 43296.1 43741.8 43971.3 36162.8 36382.6 36498.5 37251.3 37918.6 35871.0 36230.3 36241.6 36967.3 37343.8 31857.2 36589.0 36756.6 37655.1 37909.4 26829.9 29388.0 31722.0 31917.4 32027.5 25450.5 25982.5 26107.2 26154.6 26530.6 21:01:05 INFO - PROCESS | 13031 | 21:01:05 INFO - PROCESS | 13031 | [#2] jquery.html Cycles:180 Average:23588.92 Median:383804.00 stddev:66718.48 (17.4%) stddev-sans-first:66882.86 21:01:05 INFO - PROCESS | 13031 | Values: 368.2 369.2 369.5 373.3 374.6 13871.2 15507.6 16260.4 16789.7 17480.6 10893.9 11264.9 11539.9 11566.0 11575.6 3718.9 4795.2 4928.3 4941.4 4947.3 3792.3 5145.0 5356.7 5358.7 5362.3 5305.3 5324.4 5380.2 5790.7 5796.2 5598.5 5778.2 5807.9 5829.4 5848.9 5225.3 5262.2 5294.7 5296.6 5298.1 20238.3 20737.0 20860.8 20917.4 20968.9 1955.5 2125.2 2233.4 2237.1 2274.4 9703.9 9722.9 9723.1 9758.8 9882.9 1811.8 1815.3 1815.4 1851.3 1883.8 58409.0 59115.0 60239.7 60263.4 60636.1 9833.7 10084.7 10312.7 10326.6 10414.7 12920.7 13543.8 13697.8 13741.7 13772.6 7038.0 7237.4 7446.6 7454.1 7516.6 7104.6 7116.5 7156.7 7168.6 7172.7 4168.2 4213.8 4266.0 4303.3 4311.8 1768.9 1795.0 1836.7 1853.7 1899.7 930.7 965.2 999.4 1000.5 1046.0 16681.7 17153.6 17455.7 17537.4 17631.0 912.6 917.2 994.1 1012.8 1014.6 9703.6 9712.6 10012.6 10250.8 10327.3 382661.0 384947.0 387965.0 389508.0 482032.0 44994.0 47350.5 70901.0 77394.0 79535.0 1095.2 1115.2 1129.6 1130.8 1132.3 15824.1 15983.0 16009.4 16122.4 16365.0 30385.7 31787.0 32000.2 32156.8 33701.5 42254.2 42681.6 43704.8 43773.0 43940.1 7182.9 7470.1 7475.5 7517.1 7595.1 9140.8 10528.8 10985.5 11022.3 11525.7 9675.7 9852.7 9909.2 10112.1 10364.6 10145.6 10236.8 10264.8 10452.4 10759.9 7712.3 9007.7 9878.2 10519.6 10574.0 7000.4 7187.7 7229.8 7347.0 7519.7 9754.8 10292.4 10326.6 10370.4 10782.5 21:01:05 INFO - PROCESS | 13031 | 21:01:05 INFO - PROCESS | 13031 | [#3] mootools.html Cycles:180 Average:5546.87 Median:6476.48 stddev:2802.43 (43.3%) stddev-sans-first:2792.69 21:01:05 INFO - PROCESS | 13031 | Values: 1369.3 1440.1 1456.6 1631.9 1814.6 7015.0 7653.0 7836.8 7843.3 7855.3 7446.8 7618.9 7624.2 7632.8 7651.4 2070.7 2119.8 2313.7 2361.0 2386.6 2378.9 2416.6 2419.5 2419.6 2422.3 2354.6 2418.7 2420.5 2421.1 2423.8 2339.5 2362.6 2363.4 2365.4 2384.3 2323.0 2325.9 2349.2 2366.6 2368.7 7755.3 7763.1 7786.8 7791.3 7796.7 4861.1 5004.6 5015.0 5018.6 5028.6 3208.1 3262.1 3292.0 3300.2 3303.5 994.8 999.8 1009.1 1755.9 1920.2 10501.1 10609.0 10671.9 10688.5 10703.1 4463.9 4523.4 4550.8 4554.9 4652.1 9353.4 9368.2 9373.3 9376.1 9394.4 5008.1 5012.9 5013.5 5043.1 5073.8 4577.8 4593.9 4594.9 4598.4 4605.2 3511.7 3680.8 3696.2 3707.8 3725.4 1227.7 1265.2 1270.4 1278.4 1283.4 1011.0 1035.1 1038.0 1163.2 1324.1 7171.1 7327.5 7344.1 7352.3 7375.6 1080.3 1089.6 1104.8 1109.8 1134.7 5773.3 5833.3 5838.4 5841.8 5853.5 9319.0 9368.9 9486.6 9507.3 9604.7 9345.0 9480.3 9495.9 9496.7 9501.2 7296.9 7364.0 7414.1 7453.3 7478.3 7139.0 7161.7 7175.0 7187.2 7201.5 8126.7 8235.0 8366.8 8564.5 8564.6 8718.5 8791.1 8805.4 8810.7 8812.8 6198.4 6607.8 6797.5 6823.5 6845.4 7283.8 7493.3 7518.0 7535.2 7541.9 6943.1 7105.9 7118.4 7225.5 7232.0 6997.6 7013.0 7025.2 7150.0 7251.6 7159.0 7184.9 7186.9 7241.2 7246.6 6462.9 6472.3 6480.6 6486.1 6487.5 6525.8 6604.5 6626.4 6641.9 6643.2 21:01:05 INFO - PROCESS | 13031 | 21:01:05 INFO - PROCESS | 13031 | [#4] prototype.html Cycles:180 Average:5139.15 Median:5806.42 stddev:1532.79 (26.4%) stddev-sans-first:1493.92 21:01:05 INFO - PROCESS | 13031 | Values: 326.6 332.6 343.1 351.9 354.1 5595.9 5717.7 5738.2 5804.1 5804.4 5560.1 5681.5 5704.2 5711.9 5724.3 4543.3 4544.0 4551.9 4557.1 4570.5 4360.9 4407.3 4494.9 4533.7 4542.0 4481.8 4494.5 4498.2 4516.7 4525.1 4493.6 4502.6 4512.2 4513.8 4519.7 3996.2 4006.0 4006.2 4007.8 4012.4 5311.8 5431.3 5433.0 5483.3 5492.3 5127.3 5145.8 5149.4 5152.3 5154.2 5808.4 6119.7 6128.6 6128.7 6129.3 4174.0 4236.6 4241.0 4251.0 4252.0 6277.7 6303.2 6348.0 6361.4 6374.5 4382.8 4386.9 4389.1 4392.4 4393.9 4279.2 4412.2 4439.1 4454.2 4455.0 5056.9 5057.0 5058.0 5059.2 5059.7 6039.5 6045.9 6106.5 6148.4 6149.9 1544.6 1567.5 1567.7 1568.1 1571.7 1054.8 1058.4 1058.7 1059.9 1085.1 5831.2 5837.0 5840.0 5844.4 5851.3 6306.8 6315.7 6316.5 6318.1 6329.8 5797.0 5819.0 5819.3 5824.3 5828.9 3296.8 3388.1 3397.3 3403.3 3405.3 6556.9 6566.1 6578.7 6581.7 6581.9 6458.7 6459.3 6459.4 6468.7 6471.5 6392.2 6549.2 6558.3 6558.5 6559.0 6114.4 6180.8 6299.0 6303.1 6310.8 6190.7 6268.9 6281.4 6286.8 6289.0 6592.2 6594.3 6601.1 6602.8 6603.2 4300.7 4382.7 4382.9 4389.0 4390.7 6385.0 6385.8 6387.8 6397.0 6399.2 6196.9 6214.0 6215.0 6216.0 6218.2 5984.6 6189.6 6193.8 6202.2 6203.7 5998.4 6046.8 6056.1 6065.7 6079.6 6201.5 6206.7 6208.9 6210.4 6215.8 5904.1 6048.7 6072.1 6073.5 6074.6 21:01:05 INFO - PROCESS | 13031 | 21:01:05 INFO - PROCESS | 13031 | [#5] yui.html Cycles:180 Average:13260.71 Median:24176.81 stddev:15450.23 (63.9%) stddev-sans-first:15464.32 21:01:05 INFO - PROCESS | 13031 | Values: 600.5 677.4 681.0 684.0 694.1 13576.7 13699.7 13707.2 13732.8 13743.2 12442.9 12493.8 12502.5 12518.1 12520.2 821.4 839.3 839.4 839.9 840.1 822.7 823.6 825.9 826.2 826.2 879.1 879.8 880.7 881.1 882.6 872.5 874.0 874.5 877.2 878.1 645.9 646.7 646.7 647.0 647.2 13494.5 13502.6 13535.5 13536.9 13542.9 11634.9 11727.1 11857.6 11932.6 12038.3 9463.1 9576.0 9697.8 9797.3 9892.5 4016.5 4055.3 4067.3 4072.8 4190.6 44718.0 44789.0 45064.1 45160.5 45282.3 8271.6 8412.9 8500.6 8617.0 8668.4 16683.9 16744.8 16904.6 16937.4 16949.1 7389.3 7435.5 7563.0 7573.3 7620.9 4142.2 4171.6 4210.4 4236.6 4325.6 3106.2 3112.7 3119.3 3128.5 3137.9 570.7 593.9 604.7 614.9 618.9 502.9 545.1 579.4 589.8 590.4 8270.5 8389.7 8458.7 8473.7 8479.4 476.7 542.3 558.6 571.9 578.9 3850.9 3850.9 3875.7 3991.5 4124.5 55580.4 56470.0 56547.4 56643.7 56720.0 43354.0 47876.9 50390.7 50694.5 52116.2 42536.6 43877.8 46385.5 46949.0 46959.3 7857.5 7918.9 8105.6 8416.7 8494.6 30413.4 30952.4 35253.5 36028.3 36657.6 42616.4 42972.8 43177.6 43330.0 48366.3 10685.5 10866.3 10995.8 10998.8 11261.8 10782.4 10878.7 11301.5 11313.8 11616.5 10332.2 10483.5 10646.0 10684.5 10738.9 10465.5 10726.9 10745.9 10932.5 11046.6 10289.7 10673.3 10756.0 10773.1 10873.2 8311.4 8360.6 8404.2 8405.3 8754.7 8261.0 8611.7 8775.6 8958.4 9047.2 21:01:05 INFO - PROCESS | 13031 | -------- Summary: end -------- 21:01:05 INFO - PROCESS | 13031 | 21:01:05 INFO - TEST-INFO | 13031: exit 0 21:01:05 INFO - TEST-OK | dromaeo_css | took 1113152ms 21:01:05 INFO - TEST-START | kraken 21:01:05 INFO - operating with platform_type : linux_ 21:01:05 INFO - Initialising browser for kraken test... 21:01:05 INFO - TEST-INFO | started process 13214 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdlXZq0/profile http://localhost:50522/getInfo.html) 21:01:09 INFO - PROCESS | 13214 | __metrics Screen width/height:1600/1200 21:01:09 INFO - PROCESS | 13214 | colorDepth:24 21:01:09 INFO - PROCESS | 13214 | Browser inner width/height: 1024/697 21:01:09 INFO - PROCESS | 13214 | __metrics 21:01:10 INFO - PROCESS | 13214 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:01:11 INFO - TEST-INFO | 13214: exit 0 21:01:11 INFO - Browser initialized. 21:01:11 INFO - Running cycle 1/1 for kraken test... 21:01:11 INFO - TEST-INFO | started process 13296 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdlXZq0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:01:23 INFO - PROCESS | 13296 | RSS: Main: 151601152 21:01:23 INFO - PROCESS | 13296 | 21:01:25 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50522/tests/kraken/driver.html?testName=audio-beat-detection) 21:01:26 INFO - PROCESS | 13296 | RSS: Main: 193163264 21:01:26 INFO - PROCESS | 13296 | 21:01:28 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50522/tests/kraken/driver.html?testName=audio-dft) 21:01:29 INFO - PROCESS | 13296 | RSS: Main: 182456320 21:01:29 INFO - PROCESS | 13296 | 21:01:32 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50522/tests/kraken/driver.html?testName=audio-fft) 21:01:32 INFO - PROCESS | 13296 | RSS: Main: 167440384 21:01:32 INFO - PROCESS | 13296 | 21:01:34 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50522/tests/kraken/driver.html?testName=audio-oscillator) 21:01:35 INFO - PROCESS | 13296 | RSS: Main: 170098688 21:01:35 INFO - PROCESS | 13296 | 21:01:37 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50522/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:01:38 INFO - PROCESS | 13296 | RSS: Main: 170434560 21:01:38 INFO - PROCESS | 13296 | 21:01:41 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50522/tests/kraken/driver.html?testName=imaging-darkroom) 21:01:41 INFO - PROCESS | 13296 | RSS: Main: 171331584 21:01:41 INFO - PROCESS | 13296 | 21:01:45 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50522/tests/kraken/driver.html?testName=imaging-desaturate) 21:01:45 INFO - PROCESS | 13296 | RSS: Main: 171085824 21:01:45 INFO - PROCESS | 13296 | 21:01:48 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50522/tests/kraken/driver.html?testName=json-parse-financial) 21:01:49 INFO - PROCESS | 13296 | RSS: Main: 170651648 21:01:49 INFO - PROCESS | 13296 | 21:01:50 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50522/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:01:51 INFO - PROCESS | 13296 | RSS: Main: 181407744 21:01:51 INFO - PROCESS | 13296 | 21:01:52 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50522/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:01:53 INFO - PROCESS | 13296 | RSS: Main: 177975296 21:01:53 INFO - PROCESS | 13296 | 21:01:55 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50522/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:01:56 INFO - PROCESS | 13296 | RSS: Main: 191488000 21:01:56 INFO - PROCESS | 13296 | 21:01:58 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50522/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:01:59 INFO - PROCESS | 13296 | RSS: Main: 195002368 21:01:59 INFO - PROCESS | 13296 | 21:02:01 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50522/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:02:02 INFO - PROCESS | 13296 | RSS: Main: 193134592 21:02:02 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:50522/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50522/tests/kraken/driver.html?testName=ai-astar) 21:02:04 INFO - PROCESS | 13296 | RSS: Main: 252948480 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | __start_tp_report 21:02:04 INFO - PROCESS | 13296 | _x_x_mozilla_page_load 21:02:04 INFO - PROCESS | 13296 | _x_x_mozilla_page_load_details 21:02:04 INFO - PROCESS | 13296 | |i|pagename|runs| 21:02:04 INFO - PROCESS | 13296 | |0;ai-astar;109;111;105;108;110;110;100;108;109;108 21:02:04 INFO - PROCESS | 13296 | |1;audio-beat-detection;150;126;151;164;132;149;153;135;165;127 21:02:04 INFO - PROCESS | 13296 | |2;audio-dft;160;161;163;159;161;162;159;166;162;161 21:02:04 INFO - PROCESS | 13296 | |3;audio-fft;73;72;102;93;73;73;73;110;93;73 21:02:04 INFO - PROCESS | 13296 | |4;audio-oscillator;96;95;138;95;97;95;146;96;95;134 21:02:04 INFO - PROCESS | 13296 | |5;imaging-gaussian-blur;119;115;115;115;115;115;115;114;115;114 21:02:04 INFO - PROCESS | 13296 | |6;imaging-darkroom;146;146;145;145;148;146;147;146;146;146 21:02:04 INFO - PROCESS | 13296 | |7;imaging-desaturate;96;96;96;96;96;95;95;96;96;95 21:02:04 INFO - PROCESS | 13296 | |8;json-parse-financial;53;55;56;55;54;55;54;69;53;52 21:02:04 INFO - PROCESS | 13296 | |9;json-stringify-tinderbox;65;66;68;66;67;66;67;66;67;66 21:02:04 INFO - PROCESS | 13296 | |10;stanford-crypto-aes;82;82;83;83;85;82;82;82;83;83 21:02:04 INFO - PROCESS | 13296 | |11;stanford-crypto-ccm;117;122;117;115;114;117;116;116;126;123 21:02:04 INFO - PROCESS | 13296 | |12;stanford-crypto-pbkdf2;150;140;149;150;151;140;158;148;151;151 21:02:04 INFO - PROCESS | 13296 | |13;stanford-crypto-sha256-iterative;67;68;67;66;67;66;66;68;67;68 21:02:04 INFO - PROCESS | 13296 | __end_tp_report 21:02:04 INFO - PROCESS | 13296 | __start_cc_report 21:02:04 INFO - PROCESS | 13296 | _x_x_mozilla_cycle_collect,994 21:02:04 INFO - PROCESS | 13296 | __end_cc_report 21:02:04 INFO - PROCESS | 13296 | __startTimestamp1455166924345__endTimestamp 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | ------- Summary: start ------- 21:02:04 INFO - PROCESS | 13296 | Number of tests: 14 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#0] ai-astar Cycles:10 Average:107.80 Median:109.00 stddev:3.19 (2.9%) stddev-sans-first:3.35 21:02:04 INFO - PROCESS | 13296 | Values: 109.0 111.0 105.0 108.0 110.0 110.0 100.0 108.0 109.0 108.0 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:150.50 stddev:14.36 (9.5%) stddev-sans-first:15.12 21:02:04 INFO - PROCESS | 13296 | Values: 150.0 126.0 151.0 164.0 132.0 149.0 153.0 135.0 165.0 127.0 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:2.07 (1.3%) stddev-sans-first:2.13 21:02:04 INFO - PROCESS | 13296 | Values: 160.0 161.0 163.0 159.0 161.0 162.0 159.0 166.0 162.0 161.0 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#3] audio-fft Cycles:10 Average:83.50 Median:73.00 stddev:14.56 (19.9%) stddev-sans-first:14.94 21:02:04 INFO - PROCESS | 13296 | Values: 73.0 72.0 102.0 93.0 73.0 73.0 73.0 110.0 93.0 73.0 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:95.00 stddev:21.34 (22.5%) stddev-sans-first:22.14 21:02:04 INFO - PROCESS | 13296 | Values: 96.0 95.0 138.0 95.0 97.0 95.0 146.0 96.0 95.0 134.0 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.40 (1.2%) stddev-sans-first:0.44 21:02:04 INFO - PROCESS | 13296 | Values: 119.0 115.0 115.0 115.0 115.0 115.0 115.0 114.0 115.0 114.0 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 21:02:04 INFO - PROCESS | 13296 | Values: 146.0 146.0 145.0 145.0 148.0 146.0 147.0 146.0 146.0 146.0 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 21:02:04 INFO - PROCESS | 13296 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:4.86 (8.8%) stddev-sans-first:5.06 21:02:04 INFO - PROCESS | 13296 | Values: 53.0 55.0 56.0 55.0 54.0 55.0 54.0 69.0 53.0 52.0 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 21:02:04 INFO - PROCESS | 13296 | Values: 65.0 66.0 68.0 66.0 67.0 66.0 67.0 66.0 67.0 66.0 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:0.95 (1.1%) stddev-sans-first:0.97 21:02:04 INFO - PROCESS | 13296 | Values: 82.0 82.0 83.0 83.0 85.0 82.0 82.0 82.0 83.0 83.0 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:117.00 stddev:3.95 (3.4%) stddev-sans-first:4.16 21:02:04 INFO - PROCESS | 13296 | Values: 117.0 122.0 117.0 115.0 114.0 117.0 116.0 116.0 126.0 123.0 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:150.50 stddev:5.35 (3.6%) stddev-sans-first:5.66 21:02:04 INFO - PROCESS | 13296 | Values: 150.0 140.0 149.0 150.0 151.0 140.0 158.0 148.0 151.0 151.0 21:02:04 INFO - PROCESS | 13296 | 21:02:04 INFO - PROCESS | 13296 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 21:02:04 INFO - PROCESS | 13296 | Values: 67.0 68.0 67.0 66.0 67.0 66.0 66.0 68.0 67.0 68.0 21:02:04 INFO - PROCESS | 13296 | -------- Summary: end -------- 21:02:04 INFO - PROCESS | 13296 | 21:02:05 INFO - TEST-INFO | 13296: exit 0 21:02:05 INFO - TEST-OK | kraken | took 59412ms 21:02:05 INFO - SUITE-END | took 1172s 21:02:05 INFO - Completed test suite (00:19:32) 21:02:05 INFO - Working with test: dromaeo_css 21:02:05 INFO - Generating results file: dromaeo_css 21:02:05 INFO - Working with test: kraken 21:02:05 INFO - Generating results file: kraken 21:02:05 INFO - javascript benchmark 21:02:05 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:02:05 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 21:02:05 INFO - process_Request line: dromaeo_css 6770.08 graph.html#tests=[[72,64,35]] 21:02:05 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:02:05 INFO - process_Request line: kraken 1502.40 graph.html#tests=[[232,64,35]] 21:02:05 INFO - RETURN: dromaeo_css: 6770.08 21:02:05 INFO - RETURN: kraken: 1502.40 21:02:05 INFO - javascript benchmark 21:02:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3147.9055628331153, 3158.66833982432, 3180.6819318068196, 3211.454052811022, 3238.659940706225, 5119.488051194879, 5206.50538198871, 5207.0366982108335, 5271.130263506521, 5291.708956007418, 5229.450907654698, 5279.5512381447625, 5307.814226502073, 5311.840644780653, 5327.706976116312, 4704.6001089907395, 4741.6680832341835, 4827.179379505493, 4852.611791056707, 4882.194437917739, 4649.86050418488, 4831.637627177958, 4857.149998750205, 4872.902541949159, 4890.095332363524, 4744.715317080969, 4753.85738427846, 4826.155422801031, 4848.369711937461, 4869.026194761026, 4739.478657347689, 4781.282807578857, 4786.712797232177, 4787.569118779292, 4819.7108173509705, 4713.449885419716, 4725.314829349725, 4753.31076993834, 4776.426828780569, 4816.686915350491, 5020.3724534433195, 5048.0, 5075.289459475676, 5102.489751024905, 5153.716545589991, 5601.0, 5606.21512988182, 5608.355039170466, 5617.0, 5626.803061892855, 5532.723363831792, 5636.915446268309, 5654.491095801356, 5659.717014149317, 5663.773449062032, 5150.304708864331, 5156.226566015091, 5158.148905430599, 5165.096108181091, 5276.366835979707, 5766.077427611562, 5770.653760774367, 5772.191893134965, 5812.941870581325, 5821.563382746311, 5508.394076651565, 5526.392096869341, 5527.143292789544, 5535.308086489189, 5544.306961629796, 5512.834614961557, 5551.028570000234, 5558.916616250759, 5568.7215639217875, 5602.579806514527, 5606.046972014768, 5643.40744221859, 5652.689102099342, 5656.802011929645, 5704.0, 5567.443255674481, 5579.888402231933, 5598.580106491948, 5614.550835933115, 5620.185073164368, 4215.936760948588, 4303.139372125587, 4368.497622773421, 4376.387305777193, 4408.404865343137, 3831.5210598675167, 3860.2665493556133, 3871.903202419962, 3872.3997780344093, 3909.7263191576317, 5204.8178313758835, 5205.115130427836, 5212.869678258074, 5213.556847667991, 5217.791288348423, 5414.242006119146, 5491.039068163055, 5607.663540187602, 5679.545636349082, 5690.5447564194765, 5072.746362681851, 5094.541491265803, 5097.46476619957, 5101.234814777813, 5131.692098474104, 4694.131585656664, 4694.225452800318, 4697.600703940203, 4728.503507131771, 4739.715617062987, 5600.215969764236, 5676.148577713376, 5758.395368486333, 5769.711514424262, 5857.209276747755, 5551.583631227755, 5597.944020559742, 5608.130739735348, 5612.074007788669, 5614.326280846324, 5773.74018169175, 5781.566382521243, 5808.73860676279, 5816.883662326645, 5828.446297601721, 5425.1862220665635, 5438.075527160471, 5495.258140151188, 5500.394956554695, 5556.38879723222, 5521.061419558604, 5552.028395030773, 5554.416786237387, 5557.777688892399, 5559.8610034747835, 5369.060414427381, 5397.298351214474, 5436.456354364532, 5439.401665816677, 5474.671519708831, 5411.540019098264, 5446.210299506629, 5505.421930697379, 5508.55931525469, 5522.06124958766, 5381.27352807366, 5397.379301380392, 5398.055340315351, 5399.703016333982, 5401.837944861661, 5470.781168753365, 5479.0685583451705, 5491.121420572849, 5503.753240072627, 5553.750081246434, 5288.259643649815, 5363.678179309254, 5366.195070739421, 5404.135338345845, 5512.80705175333], "unit": "score", "name": "dojo.html", "value": 5159.668725863235}, {"lowerIsBetter": false, "replicates": [533.2268211093914, 535.9330083739535, 537.8413368056425, 557.3506864502854, 567.9829605111848, 27705.861470692642, 28049.719502804965, 28056.85971570142, 28108.15675529732, 28109.718902810964, 28505.42989140216, 35962.2807543849, 36613.0, 36617.0, 36876.81561592195, 8422.241998220174, 8633.395662303641, 8663.090375510576, 8674.566271686423, 8682.088380720028, 8766.298696104297, 8929.821403571925, 8937.865932011026, 8937.95531022344, 8942.239909607692, 8914.331425143107, 9022.09779022099, 9022.50376229307, 9026.954865225665, 9040.367174297802, 8875.112488751105, 8945.642174313052, 8950.328725345626, 8953.194212520839, 8957.104289571056, 8844.0, 8879.33404994628, 8880.467171969702, 8885.42244754089, 8885.733427997171, 38333.23333533342, 38647.806760966014, 38676.0, 38703.61296387056, 38718.419223711666, 3225.9354812903844, 3335.7498187635783, 3659.1218107654236, 3874.1136957333, 3952.288588054149, 29000.27499312513, 29164.854175728986, 29559.0, 29635.110946671633, 29845.0, 3890.7081968852167, 3933.0, 3936.2324346752393, 3964.623360780721, 3986.0832008637885, 193979.0, 194751.0, 195090.0, 195268.0, 195582.0, 55343.44656553383, 55700.44299557034, 55827.441725582226, 55844.0, 55932.72033639806, 52096.47903520992, 52401.0, 56723.0, 59419.40580594225, 60005.0, 15482.30329635169, 15504.844951550565, 15558.9222053889, 15562.0, 15616.0, 11361.977422032056, 11952.940235298942, 12117.333546655018, 12119.878801212051, 12124.333161676017, 18925.14836832346, 19150.904245478683, 19215.231390744495, 19267.325643602406, 19406.0, 7392.852142957111, 7625.6568454418575, 7659.770206893802, 7671.2712292332135, 7852.764417067498, 988.2736188901152, 997.7555498902815, 1044.7805960748176, 1065.3448129400363, 1090.4438736244413, 27613.86193069062, 27919.162425127277, 28156.8592157042, 30155.547666785016, 32017.519737203962, 1085.7719878825378, 1094.1574987259924, 1102.2559772153763, 1141.1042331769522, 1184.1296646964474, 14507.419703211754, 14718.779218311734, 14746.705065898837, 14931.25343732809, 14952.327145278488, 303113.0, 305765.0, 306277.0, 306721.0, 307629.0, 49266.26100608494, 50093.24860127101, 50167.74916125469, 50168.74915625399, 50236.0, 1311.3377744238908, 1313.1267706974945, 1323.483841301893, 1350.608323586149, 1352.3305963548107, 27677.584836227874, 28753.568696469152, 29160.562591561567, 29182.854085729436, 29185.85407072951, 43188.13623727445, 47417.76291118522, 48617.0, 49239.75380123076, 49247.0, 193909.0, 194414.0, 195183.0, 195534.0, 196120.0, 26652.0, 27096.32259193536, 27133.0, 27173.184804455897, 27207.91168353244, 42200.199982179955, 42982.78508607437, 43296.103350697325, 43741.78129109334, 43971.34042989422, 36162.8191859039, 36382.63617363898, 36498.452523212705, 37251.25497490089, 37918.620813792615, 35871.0, 36230.27539449249, 36241.64409433081, 36967.26065478729, 37343.81328093342, 31857.20356991001, 36589.0, 36756.632433675324, 37655.058623533536, 37909.431358529095, 26829.865850670623, 29388.0, 31722.0, 31917.36165276635, 32027.519587206676, 25450.490990179722, 25982.480350393264, 26107.216783496526, 26154.607680884423, 26530.60204096979], "unit": "score", "name": "ext.html", "value": 17766.283729479936}, {"lowerIsBetter": false, "replicates": [368.2138634016375, 369.18226129124, 369.4698108214711, 373.29819938515584, 374.6010498818756, 13871.237081960513, 15507.612309692264, 16260.430884919015, 16789.748153777702, 17480.562985925357, 10893.945530272358, 11264.887351126506, 11539.942300288487, 11566.0, 11575.594854180106, 3718.9442158367647, 4795.23276275796, 4928.310036594879, 4941.407031156248, 4947.282644016615, 3792.27946690128, 5145.0, 5356.651817631861, 5358.651687640291, 5362.329708786402, 5305.310309659739, 5324.41431442541, 5380.21986811912, 5790.697093154049, 5796.24648795656, 5598.468145526169, 5778.191053252548, 5807.883842323172, 5829.446202610745, 5848.883022339551, 5225.346831646044, 5262.23697563855, 5294.682319060868, 5296.602754793406, 5298.125809241471, 20238.291659791983, 20736.96315184235, 20860.791392086037, 20917.37247882566, 20968.895155524126, 1955.4915721912405, 2125.192426877792, 2233.4416395901026, 2237.0827960536103, 2274.40865375002, 9703.854442183372, 9722.902770972341, 9723.124918757347, 9758.756031099208, 9882.851757223647, 1811.8278763517444, 1815.282963229517, 1815.4190658989128, 1851.3150134450204, 1883.8210370014826, 58409.0, 59115.0, 60239.69880150615, 60263.39736602622, 60636.09045864359, 9833.704988850346, 10084.74788130288, 10312.742181445525, 10326.638567650096, 10414.739631509121, 12920.676983075498, 13543.796843047363, 13697.794533082011, 13741.656458588615, 13772.586822395344, 7038.0, 7237.421006319481, 7446.590437525988, 7454.142773581108, 7516.624168791648, 7104.573725576482, 7116.466265030143, 7156.677949492181, 7168.5698858067635, 7172.713091476387, 4168.166366726667, 4213.810378532912, 4266.0, 4303.268444364466, 4311.762853043113, 1768.938087166943, 1794.9820501794816, 1836.6818145579432, 1853.7404763333145, 1899.6960486322123, 930.734740598926, 965.2278177458005, 999.415342024909, 1000.479750529735, 1046.0428707732492, 16681.749773753403, 17153.571160721083, 17455.690589015176, 17537.386191483238, 17631.030293333988, 912.6303846942, 917.2478567574658, 994.1450352696675, 1012.7620009297809, 1014.5586669798661, 9703.563339649732, 9712.611495540099, 10012.64955726546, 10250.846237306447, 10327.277090603586, 382661.0, 384947.0, 387965.0, 389508.0, 482032.0, 44994.0, 47350.5264947353, 70901.0, 77394.0, 79535.0, 1095.2114477576133, 1115.1803424482998, 1129.5651174297955, 1130.7512347283584, 1132.2938177755173, 15824.129672867643, 15983.0, 16009.439669611507, 16122.435714749927, 16365.0, 30385.69614303917, 31787.046388608378, 32000.199995000312, 32156.83921580377, 33701.49447758237, 42254.1549169021, 42681.57318426776, 43704.78147609369, 43773.0, 43940.12119757651, 7182.892256616259, 7470.140933792466, 7475.514091584029, 7517.060367454068, 7595.126560445619, 9140.817183656423, 10528.842067369149, 10985.450727463434, 11022.283551569442, 11525.654230373102, 9675.676479481075, 9852.68461911436, 9909.207263419054, 10112.089911907964, 10364.637237696947, 10145.644902428674, 10236.795264094528, 10264.819545752334, 10452.372857628567, 10759.946200268949, 7712.295086055183, 9007.684731034382, 9878.209743220668, 10519.579216831242, 10574.0, 7000.439964802906, 7187.7484288051755, 7229.819254518679, 7346.96326518364, 7519.661615227437, 9754.804903902024, 10292.433916134685, 10326.586936522755, 10370.42962637032, 10782.514786834454], "unit": "score", "name": "jquery.html", "value": 8074.079753433123}, {"lowerIsBetter": false, "replicates": [1369.3016561553618, 1440.0999375390377, 1456.6431224350035, 1631.8612917901978, 1814.582645991422, 7014.9649251753735, 7652.961735191323, 7836.764897053084, 7843.294103530681, 7855.253750893656, 7446.813829654261, 7618.92381076189, 7624.199459056802, 7632.771016869503, 7651.426143039266, 2070.6583413736716, 2119.7668256491775, 2313.6760853480528, 2360.9881950590266, 2386.55848667997, 2378.9286321410386, 2416.5529377065213, 2419.5040016796515, 2419.6128619420897, 2422.2854257993936, 2354.6350315701093, 2418.6855708757926, 2420.5279970405777, 2421.055788242587, 2423.8424502407374, 2339.520398318349, 2362.6337917622795, 2363.3855197648563, 2365.3613524348416, 2384.3443053160345, 2323.0, 2325.8837058147196, 2349.189529612298, 2366.6213405854983, 2368.692070030885, 7755.340796032344, 7763.107242667109, 7786.7663970080985, 7791.337736292422, 7796.727114550963, 4861.1006963711825, 5004.624653150991, 5014.974925125351, 5018.64869459138, 5028.572571331441, 3208.1498402923244, 3262.1192278085023, 3292.0, 3300.1914530939835, 3303.487959366302, 994.7761753605454, 999.7950420163849, 1009.0565321424418, 1755.9473215803418, 1920.2223099644666, 10501.10740587051, 10609.0, 10671.893281067167, 10688.465576721055, 10703.090237329836, 4463.910721785611, 4523.434570678665, 4550.817967281272, 4554.863354099382, 4652.116097941381, 9353.438793672402, 9368.156865881967, 9373.343865929455, 9376.062393760705, 9394.389364691273, 5008.12357837377, 5012.899742005139, 5013.473585273567, 5043.117454445457, 5073.822416215415, 4577.816887324537, 4593.862184134481, 4594.908101837945, 4598.379218805485, 4605.240135377625, 3511.666391692785, 3680.7975561343846, 3696.242270334575, 3707.8146092695256, 3725.4411838224482, 1227.6930767308172, 1265.2092442223611, 1270.39021269791, 1278.4438769135456, 1283.4096315694699, 1011.0193112680688, 1035.1408331085331, 1037.9532921018422, 1163.2264544078262, 1324.0863803975226, 7171.1394632644415, 7327.487075904742, 7344.081989751281, 7352.338289553859, 7375.631218439056, 1080.270817198388, 1089.591403223791, 1104.7845670094255, 1109.8113320735333, 1134.65393055119, 5773.336066352339, 5833.329167145747, 5838.416158384212, 5841.766329346779, 5853.502452291603, 9318.95340523293, 9368.90631093694, 9486.573104210327, 9507.286953478517, 9604.711858644252, 9345.0, 9480.33637645372, 9495.857562136573, 9496.715098547054, 9501.192398646193, 7296.927030729731, 7363.9631801841715, 7414.110306763115, 7453.329200371993, 7478.326950574366, 7139.0, 7161.677724502306, 7175.0, 7187.209406965334, 7201.4958952874895, 8126.715564955198, 8235.0, 8366.790830229293, 8564.52895090776, 8564.571771411529, 8718.520481373585, 8791.07693692153, 8805.427647203167, 8810.678398240316, 8812.779680508038, 6198.442140207403, 6607.768728094494, 6797.524173307821, 6823.488238382042, 6845.418139458003, 7283.781486555412, 7493.325600695964, 7518.022657054548, 7535.208803075599, 7541.924580754342, 6943.062686537252, 7105.893411598727, 7118.359347658736, 7225.530340527849, 7232.0, 6997.615131167631, 7013.0, 7025.192102908231, 7149.999000140088, 7251.637418128967, 7159.0, 7184.928150718426, 7186.892196617159, 7241.167265764505, 7246.60143692102, 6462.870742585216, 6472.320406357265, 6480.6435646038035, 6486.0919471275, 6487.54587178893, 6525.771597994048, 6604.471642268511, 6626.370494802986, 6641.900371494528, 6643.202815662152], "unit": "score", "name": "mootools.html", "value": 4606.363241351259}, {"lowerIsBetter": false, "replicates": [326.56566766200956, 332.6241347277576, 343.10449726214574, 351.8539805980518, 354.0723304941053, 5595.888082238353, 5717.714114294289, 5738.225339579156, 5804.100364443513, 5804.390538993408, 5560.138178582316, 5681.460261275182, 5704.172894930243, 5711.885762284752, 5724.255846739918, 4543.318502224676, 4544.0, 4551.931721024187, 4557.08858228354, 4570.497245303014, 4360.912781744379, 4407.316865885777, 4494.865154045384, 4533.727976321431, 4541.977290113545, 4481.7983190756495, 4494.4831344395325, 4498.167838949805, 4516.706414083091, 4525.140223357552, 4493.618042466378, 4502.639788816887, 4512.165249428866, 4513.7517436540975, 4519.683622146451, 3996.2407142642805, 4005.959940400617, 4006.198760247962, 4007.8196481158125, 4012.3981402789523, 5311.840644780663, 5431.34823821144, 5433.0, 5483.314585676791, 5492.258545096401, 5127.256547800585, 5145.76844042019, 5149.433562308143, 5152.330197074394, 5154.175331946908, 5808.448197421239, 6119.66341851198, 6128.601640893327, 6128.662923539204, 6129.295131059941, 4173.9582604174175, 4236.57634236577, 4240.978795106035, 4251.022264879064, 4252.043290259667, 6277.7175027123885, 6303.243610766737, 6348.016057511093, 6361.3638636136475, 6374.490040796772, 4382.824687012548, 4386.947132688132, 4389.056352884081, 4392.407025051641, 4393.945453091299, 4279.186954478639, 4412.227860124465, 4439.1121775645, 4454.175977444183, 4455.0, 5056.924146137737, 5057.0, 5058.0, 5059.19052951526, 5059.747012649353, 6039.48664363534, 6045.939540604626, 6106.511479081662, 6148.385161483905, 6149.877002459926, 1544.5906834688817, 1567.5375764149603, 1567.6942996115877, 1568.0670001349406, 1571.724948134072, 1054.847047178155, 1058.4072919165292, 1058.724731569782, 1059.920505962056, 1085.066842515436, 5831.2127862738835, 5837.0368889132815, 5840.0, 5844.357120716718, 5851.268591426072, 6306.842328941813, 6315.715792789336, 6316.463100636497, 6318.147050148263, 6329.810105696744, 5796.971015144897, 5819.0, 5819.272590926134, 5824.271966004249, 5828.854278642983, 3296.78570892896, 3388.1360253135786, 3397.2695870387984, 3403.3363494118407, 3405.250844814137, 6556.901646475307, 6566.080748695186, 6578.736850526021, 6581.670916454158, 6581.901271480931, 6458.741650334028, 6459.257185423642, 6459.386358295955, 6468.708908099147, 6471.482281417475, 6392.16901802772, 6549.214094308618, 6558.311377305409, 6558.508111891627, 6559.048937904073, 6114.419130182803, 6180.7527698891545, 6299.0, 6303.117563541016, 6310.7791227306825, 6190.690465476618, 6268.937310626835, 6281.403266689657, 6286.779962701284, 6288.968555157195, 6592.24189218246, 6594.340565943367, 6601.108850305147, 6602.8349291268105, 6603.20761508622, 4300.655947524128, 4382.671299652475, 4382.934255986099, 4389.034412429261, 4390.692651514363, 6385.0, 6385.840353991188, 6387.808365749035, 6397.0, 6399.232092148972, 6196.876062478635, 6213.96893015532, 6215.0, 6215.974364230033, 6218.160548326099, 5984.611000284967, 6189.6286222826775, 6193.783217587363, 6202.193714817226, 6203.689815509116, 5998.370171131968, 6046.7581296749395, 6056.091586262096, 6065.696715164136, 6079.604825686316, 6201.534884883562, 6206.689665516797, 6208.875822483616, 6210.378962103934, 6215.751369945152, 5904.143899134516, 6048.6975651218145, 6072.05883088122, 6073.514118870568, 6074.633207528271], "unit": "score", "name": "prototype.html", "value": 4646.953984464359}, {"lowerIsBetter": false, "replicates": [600.4877107766274, 677.4309579952838, 680.9693563789629, 683.9863202735944, 694.1011390249627, 13576.660583485405, 13699.657508562292, 13707.246101464416, 13732.794008089886, 13743.175409475414, 12442.93778531106, 12493.750124997494, 12502.499900004012, 12518.12373133881, 12520.18618789778, 821.4291067707945, 839.2782207301716, 839.3956351426963, 839.9412041157121, 840.1178762299592, 822.7161629237934, 823.5717426937989, 825.8719898415756, 826.1985873702499, 826.2109685250572, 879.134052957836, 879.7580665317025, 880.7445840706188, 881.0748713850463, 882.629295695806, 872.4721543466238, 873.9606717697719, 874.4534665833854, 877.171073335698, 878.0736323179044, 645.8675971425846, 646.6734299178885, 646.7122130651862, 647.0133047103205, 647.1877793369339, 13494.460221591222, 13502.594922152253, 13535.458581656721, 13536.86463135366, 13542.93228533861, 11634.883651163465, 11727.061835053175, 11857.644270671808, 11932.582359617372, 12038.277703337828, 9463.101005404476, 9576.0, 9697.757556061084, 9797.265205109574, 9892.455914924676, 4016.4778578784862, 4055.290324193284, 4067.28822456069, 4072.8370865165357, 4190.580941905785, 44718.0, 44789.0, 45064.09871802579, 45160.548394515965, 45282.32076518822, 8271.586420678943, 8412.915870841212, 8500.617472213766, 8616.956915215384, 8668.393212475066, 16683.91658041702, 16744.83255167457, 16904.57738556546, 16937.407190748265, 16949.0678012708, 7389.334959853639, 7435.51669141504, 7562.962185189039, 7573.318401343795, 7620.923790762133, 4142.212979533879, 4171.603697648779, 4210.368444733314, 4236.576342365739, 4325.5674432557125, 3106.1613364391487, 3112.7042930921525, 3119.313750974782, 3128.4838001729913, 3137.8901738439044, 570.6946783470823, 593.9316978547522, 604.7490291528966, 614.8954677704801, 618.8855061813579, 502.9446760856303, 545.0706545340186, 579.3828829497977, 589.8201048680108, 590.3918963467635, 8270.545120018336, 8389.664413423518, 8458.74623761288, 8473.703420380258, 8479.364047696448, 476.73323752416013, 542.2530315519818, 558.6452602597379, 571.8598943258928, 578.9218455508536, 3850.8844734658005, 3850.9037274068373, 3875.7093218008763, 3991.481107456012, 4124.546299907008, 55580.44419555834, 56470.0, 56547.43452565504, 56643.71678141583, 56720.0, 43354.0, 47876.88002798209, 50390.748046259534, 50694.493055068975, 52116.21825672618, 42536.57463425326, 43877.78061109674, 46385.53614463812, 46949.0, 46959.29561056587, 7857.528548287121, 7918.920810791818, 8105.554194519123, 8416.747497575083, 8494.57527123629, 30413.391732165674, 30952.380952380376, 35253.47119793154, 36028.27943441169, 36657.63342366542, 42616.36075458809, 42972.78513607412, 43177.56822431736, 43330.0, 48366.27450588314, 10685.51915163804, 10866.293690910066, 10995.835062474229, 10998.835017474905, 11261.774764504828, 10782.406967616856, 10878.728031798952, 11301.547938082385, 11313.830292545454, 11616.477258523219, 10332.173426126043, 10483.52824122901, 10646.041856232976, 10684.46577671129, 10738.946305268424, 10465.476726163814, 10726.892731072589, 10745.946270268598, 10932.508037138507, 11046.558137674403, 10289.691309260734, 10673.306235094695, 10756.0, 10773.138148947908, 10873.184511161537, 8311.418200725891, 8360.581970901552, 8404.243618074403, 8405.32757379396, 8754.69358572447, 8261.008678958564, 8611.65553377858, 8775.648974040967, 8958.372913896226, 9047.230985366054], "unit": "score", "name": "yui.html", "value": 6076.990187124728}], "name": "dromaeo_css", "value": 6770.081136197855}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 108.0, 110.0, 110.0, 100.0, 108.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 151.0, 164.0, 132.0, 149.0, 153.0, 135.0, 165.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 163.0, 159.0, 161.0, 162.0, 159.0, 166.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 102.0, 93.0, 73.0, 73.0, 73.0, 110.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 138.0, 95.0, 97.0, 95.0, 146.0, 96.0, 95.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 56.0, 55.0, 54.0, 55.0, 54.0, 69.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 68.0, 66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 83.0, 85.0, 82.0, 82.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [117.0, 122.0, 117.0, 115.0, 114.0, 117.0, 116.0, 116.0, 126.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [150.0, 140.0, 149.0, 150.0, 151.0, 140.0, 158.0, 148.0, 151.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 66.0, 67.0, 66.0, 66.0, 68.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1502.4}]} 21:02:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1502.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6770.08"}}} 21:02:05 INFO - Return code: 0 21:02:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 21:02:05 INFO - # TBPL SUCCESS # 21:02:05 INFO - Running post-action listener: _resource_record_post_action 21:02:05 INFO - Running post-run listener: _resource_record_post_run 21:02:06 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 20480; Write bytes: 526602240; Read time: 48; Write time: 345884 21:02:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 240242688; Read time: 0; Write time: 176940 21:02:06 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 20480; Write bytes: 286359552; Read time: 48; Write time: 168944 21:02:06 INFO - Running post-run listener: _upload_blobber_files 21:02:06 INFO - Blob upload gear active. 21:02:06 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 21:02:06 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 21:02:06 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'] 21:02:06 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 21:02:07 INFO - (blobuploader) - INFO - Open directory for files ... 21:02:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:02:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:02:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:02:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:02:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:02:07 INFO - (blobuploader) - INFO - Done attempting. 21:02:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 21:02:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:02:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:02:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:02:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:02:08 INFO - (blobuploader) - INFO - Done attempting. 21:02:08 INFO - (blobuploader) - INFO - Iteration through files over. 21:02:08 INFO - Return code: 0 21:02:08 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 21:02:08 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 21:02:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e7746f6eb2f1053df829c49fff37ca146a8ae5b47c81e5fa36645aa356b837a8c50b5f719742df15b5d17f3d906517973df2785c622e9d5a3eec335bef3b294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fa2886cf08ff96ac50c0277109faff26e549bb8623c5d2df5ef02a3b97820ff7783055f05c0fc05d78d6641ce2b21cdbae4c6c13dd8ab3f2fad7d3ba40f2fc4"} 21:02:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 21:02:08 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 21:02:08 INFO - Contents: 21:02:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e7746f6eb2f1053df829c49fff37ca146a8ae5b47c81e5fa36645aa356b837a8c50b5f719742df15b5d17f3d906517973df2785c622e9d5a3eec335bef3b294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fa2886cf08ff96ac50c0277109faff26e549bb8623c5d2df5ef02a3b97820ff7783055f05c0fc05d78d6641ce2b21cdbae4c6c13dd8ab3f2fad7d3ba40f2fc4"} 21:02:08 INFO - Running post-run listener: copy_logs_to_upload_dir 21:02:08 INFO - Copying logs to upload dir... 21:02:08 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 21:02:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.961822 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-02-10 21:02:08.819717) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 21:02:08.823616) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993 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/6e7746f6eb2f1053df829c49fff37ca146a8ae5b47c81e5fa36645aa356b837a8c50b5f719742df15b5d17f3d906517973df2785c622e9d5a3eec335bef3b294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fa2886cf08ff96ac50c0277109faff26e549bb8623c5d2df5ef02a3b97820ff7783055f05c0fc05d78d6641ce2b21cdbae4c6c13dd8ab3f2fad7d3ba40f2fc4"} build_url:https://queue.taskcluster.net/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/dQGM7u0mQXain_eQZycNvA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6e7746f6eb2f1053df829c49fff37ca146a8ae5b47c81e5fa36645aa356b837a8c50b5f719742df15b5d17f3d906517973df2785c622e9d5a3eec335bef3b294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fa2886cf08ff96ac50c0277109faff26e549bb8623c5d2df5ef02a3b97820ff7783055f05c0fc05d78d6641ce2b21cdbae4c6c13dd8ab3f2fad7d3ba40f2fc4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 21:02:08.847909) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 21:02:08.848197) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1455163746.749314-549804993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 21:02:08.933848) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 21:02:08.934162) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 21:02:08.934448) ========= ========= Total master_lag: 0.23 =========