builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1456795521.16 results: success (0) buildid: 20160229143016 builduid: 304208db15cd4d9599394a7b2e8a31d6 revision: 446932a345fe1631718eb0b6bcb3e098c2958265 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.157865) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.158889) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.159558) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006242 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.188145) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.188909) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.203311) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.204031) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004666 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.257671) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.258350) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.259223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.259951) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 17:25:21-- 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% 43.6M=0s 2016-02-29 17:25:21 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.409895 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.688617) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.689027) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018117 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.742361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:21.743217) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 446932a345fe1631718eb0b6bcb3e098c2958265 --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 446932a345fe1631718eb0b6bcb3e098c2958265 --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=edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 17:25:22,030 truncating revision to first 12 chars 2016-02-29 17:25:22,030 Setting DEBUG logging. 2016-02-29 17:25:22,030 attempt 1/10 2016-02-29 17:25:22,030 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/446932a345fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 17:25:22,298 unpacking tar archive at: fx-team-446932a345fe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539708 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:22.298221) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:22.298613) ========= echo 446932a345fe1631718eb0b6bcb3e098c2958265 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'446932a345fe1631718eb0b6bcb3e098c2958265'] 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=edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 446932a345fe1631718eb0b6bcb3e098c2958265 program finished with exit code 0 elapsedTime=0.003618 script_repo_revision: '446932a345fe1631718eb0b6bcb3e098c2958265' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:22.347873) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:22.348239) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 17:25:22.355702) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2016-02-29 17:25:22.356041) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:25:22 INFO - MultiFileLogger online at 20160229 17:25:22 in /builds/slave/test-pgo 17:25:22 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 17:25:22 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:25:22 INFO - {'append_to_log': False, 17:25:22 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:25:22 INFO - 'blob_upload_branch': 'Fx-Team', 17:25:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:25:22 INFO - 'branch': 'Fx-Team', 17:25:22 INFO - 'buildbot_json_path': 'buildprops.json', 17:25:22 INFO - 'config_files': ('talos/linux_config.py',), 17:25:22 INFO - 'default_actions': ('clobber', 17:25:22 INFO - 'read-buildbot-config', 17:25:22 INFO - 'download-and-extract', 17:25:22 INFO - 'populate-webroot', 17:25:22 INFO - 'create-virtualenv', 17:25:22 INFO - 'install', 17:25:22 INFO - 'run-tests'), 17:25:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:25:22 INFO - 'download_minidump_stackwalk': True, 17:25:22 INFO - 'download_symbols': 'ondemand', 17:25:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:25:22 INFO - 'tooltool.py': '/tools/tooltool.py', 17:25:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:25:22 INFO - '/tools/misc-python/virtualenv.py')}, 17:25:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:25:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:25:22 INFO - 'installer_path': 'installer.exe', 17:25:22 INFO - 'log_level': 'info', 17:25:22 INFO - 'log_name': 'talos', 17:25:22 INFO - 'log_to_console': True, 17:25:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:25:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:25:22 INFO - 'opt_config_files': (), 17:25:22 INFO - 'pip_index': False, 17:25:22 INFO - 'sps_profile': False, 17:25:22 INFO - 'sps_profile_interval': 0, 17:25:22 INFO - 'suite': 'dromaeojs', 17:25:22 INFO - 'system_bits': '32', 17:25:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:25:22 INFO - 'title': 'talos-linux64-ix-033', 17:25:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:25:22 INFO - 'use_talos_json': True, 17:25:22 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:25:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:25:22 INFO - 'work_dir': 'build'} 17:25:22 INFO - ##### 17:25:22 INFO - ##### Running clobber step. 17:25:22 INFO - ##### 17:25:22 INFO - Running pre-action listener: _resource_record_pre_action 17:25:22 INFO - Running main action method: clobber 17:25:22 INFO - rmtree: /builds/slave/test-pgo/build 17:25:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:25:23 INFO - Running post-action listener: _resource_record_post_action 17:25:23 INFO - ##### 17:25:23 INFO - ##### Running read-buildbot-config step. 17:25:23 INFO - ##### 17:25:23 INFO - Running pre-action listener: _resource_record_pre_action 17:25:23 INFO - Running main action method: read_buildbot_config 17:25:23 INFO - Using buildbot properties: 17:25:23 INFO - { 17:25:23 INFO - "project": "", 17:25:23 INFO - "product": "firefox", 17:25:23 INFO - "script_repo_revision": "production", 17:25:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:25:23 INFO - "repository": "", 17:25:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:25:23 INFO - "buildid": "20160229143016", 17:25:23 INFO - "pgo_build": "True", 17:25:23 INFO - "basedir": "/builds/slave/test-pgo", 17:25:23 INFO - "buildnumber": 964, 17:25:23 INFO - "slavename": "talos-linux64-ix-033", 17:25:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:25:23 INFO - "platform": "ubuntu64_hw", 17:25:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:25:23 INFO - "branch": "fx-team", 17:25:23 INFO - "repo_path": "integration/fx-team", 17:25:23 INFO - "revision": "446932a345fe1631718eb0b6bcb3e098c2958265", 17:25:23 INFO - "stage_platform": "linux64-pgo", 17:25:23 INFO - "builduid": "304208db15cd4d9599394a7b2e8a31d6", 17:25:23 INFO - "slavebuilddir": "test" 17:25:23 INFO - } 17:25:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 17:25:23 INFO - Running post-action listener: _resource_record_post_action 17:25:23 INFO - ##### 17:25:23 INFO - ##### Running download-and-extract step. 17:25:23 INFO - ##### 17:25:23 INFO - Running pre-action listener: _resource_record_pre_action 17:25:23 INFO - Running main action method: download_and_extract 17:25:23 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:23 INFO - https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:25:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/test_packages.json 17:25:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/test_packages.json 17:25:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:25:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:25:23 INFO - Downloaded 1448 bytes. 17:25:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:25:23 INFO - Using the following test package requirements: 17:25:23 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:23 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:25:23 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:25:23 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:23 INFO - u'jsshell-linux-x86_64.zip'], 17:25:23 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:25:23 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:23 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:25:23 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:25:23 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:25:23 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:23 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:25:23 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:23 INFO - https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:25:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:25:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:25:24 INFO - Downloaded 23372555 bytes. 17:25:24 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'] 17:25:24 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 17:25:26 INFO - Return code: 0 17:25:26 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 17:25: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')]} 17:25:26 INFO - https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:25:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:25:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:25:27 INFO - Downloaded 23372555 bytes. 17:25:27 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'] 17:25:27 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 17:25:31 INFO - Return code: 0 17:25: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')]} 17:25:31 INFO - https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:25:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:25:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:25:32 INFO - Downloaded 10713410 bytes. 17:25:32 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'] 17:25:32 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 17:25:32 INFO - Return code: 0 17:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:32 INFO - https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:25:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:25:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:25:34 INFO - Downloaded 56618535 bytes. 17:25:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:34 INFO - mkdir: /builds/slave/test-pgo/properties 17:25:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:25:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:25:34 INFO - Contents: 17:25:34 INFO - build_url:https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:25:35 INFO - Running post-action listener: _resource_record_post_action 17:25:35 INFO - Running post-action listener: set_extra_try_arguments 17:25:35 INFO - ##### 17:25:35 INFO - ##### Running populate-webroot step. 17:25:35 INFO - ##### 17:25:35 INFO - Running pre-action listener: _resource_record_pre_action 17:25:35 INFO - Running main action method: populate_webroot 17:25:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:25:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:25:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:25:35 INFO - '--tppagecycles', 17:25:35 INFO - '7'], 17:25:35 INFO - 'tests': ['tsvgm']}}, 17:25:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:25:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:25:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:25:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:25:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:25:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:25:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:35 INFO - 'talos_options': ['--e10s'], 17:25:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:35 INFO - 'tests': ['damp', 'tps']}, 17:25:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:35 INFO - 'talos_options': ['--e10s'], 17:25:35 INFO - 'tests': ['damp', 'tps']}, 17:25:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:25:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:25:35 INFO - 'other': {'tests': ['a11yr', 17:25:35 INFO - 'ts_paint', 17:25:35 INFO - 'tpaint', 17:25:35 INFO - 'sessionrestore', 17:25:35 INFO - 'sessionrestore_no_auto_restore']}, 17:25:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:25:35 INFO - 'tests': ['a11yr', 17:25:35 INFO - 'ts_paint', 17:25:35 INFO - 'tpaint', 17:25:35 INFO - 'sessionrestore', 17:25:35 INFO - 'sessionrestore_no_auto_restore']}, 17:25:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:25:35 INFO - 'tests': ['a11yr', 17:25:35 INFO - 'ts_paint', 17:25:35 INFO - 'tpaint', 17:25:35 INFO - 'sessionrestore', 17:25:35 INFO - 'sessionrestore_no_auto_restore']}, 17:25:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:25:35 INFO - 'tests': ['a11yr', 17:25:35 INFO - 'ts_paint', 17:25:35 INFO - 'tpaint', 17:25:35 INFO - 'sessionrestore', 17:25:35 INFO - 'sessionrestore_no_auto_restore']}, 17:25:35 INFO - 'other_l64': {'tests': ['a11yr', 17:25:35 INFO - 'ts_paint', 17:25:35 INFO - 'tpaint', 17:25:35 INFO - 'sessionrestore', 17:25:35 INFO - 'sessionrestore_no_auto_restore']}, 17:25:35 INFO - 'other_nol64': {'tests': ['a11yr', 17:25:35 INFO - 'ts_paint', 17:25:35 INFO - 'tpaint', 17:25:35 INFO - 'sessionrestore', 17:25:35 INFO - 'sessionrestore_no_auto_restore']}, 17:25:35 INFO - 'svgr': {'tests': ['tsvgx', 17:25:35 INFO - 'tsvgr_opacity', 17:25:35 INFO - 'tart', 17:25:35 INFO - 'tscrollx', 17:25:35 INFO - 'cart']}, 17:25:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:25:35 INFO - 'tests': ['tsvgx', 17:25:35 INFO - 'tsvgr_opacity', 17:25:35 INFO - 'tart', 17:25:35 INFO - 'tscrollx', 17:25:35 INFO - 'cart']}, 17:25:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:35 INFO - 'tests': ['tp5o']}, 17:25:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:35 INFO - 'talos_options': ['--e10s'], 17:25:35 INFO - 'tests': ['tp5o']}, 17:25:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:35 INFO - 'talos_options': ['--xperf_path', 17:25:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:35 INFO - 'tests': ['tp5n']}, 17:25:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:35 INFO - 'talos_options': ['--e10s', 17:25:35 INFO - '--xperf_path', 17:25:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:35 INFO - 'tests': ['tp5n']}}, 17:25:35 INFO - 'talos.zip': {'path': '', 17:25:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:25:35 INFO - Running post-action listener: _resource_record_post_action 17:25:35 INFO - ##### 17:25:35 INFO - ##### Running create-virtualenv step. 17:25:35 INFO - ##### 17:25:35 INFO - Running pre-action listener: _resource_record_pre_action 17:25:35 INFO - Running main action method: create_virtualenv 17:25:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:25:35 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 17:25:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:25:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:25:35 INFO - Using real prefix '/usr' 17:25:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:25:36 INFO - Installing distribute.............................................................................................................................................................................................done. 17:25:38 INFO - Installing pip.................done. 17:25:38 INFO - Return code: 0 17:25:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:25:38 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')]} 17:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:38 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')]} 17:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:38 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 0x7f35a65baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfd8c0>, '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 0x2bfe7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfec50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', '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 17:25:38 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 17:25:38 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 17:25:38 INFO - Using env: {'DISPLAY': ':0', 17:25:38 INFO - 'HOME': '/home/cltbld', 17:25:38 INFO - 'LANG': 'en_US.UTF-8', 17:25:38 INFO - 'LANGUAGE': 'en_US:en', 17:25:38 INFO - 'LOGNAME': 'cltbld', 17:25:38 INFO - 'MAIL': '/var/mail/cltbld', 17:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:38 INFO - 'MOZ_NO_REMOTE': '1', 17:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:38 INFO - 'NO_EM_RESTART': '1', 17:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:38 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:38 INFO - 'SHELL': '/bin/bash', 17:25:38 INFO - 'SHLVL': '1', 17:25:38 INFO - 'TERM': 'linux', 17:25:38 INFO - 'TMOUT': '86400', 17:25:38 INFO - 'USER': 'cltbld', 17:25:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', 17:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:38 INFO - '_': '/tools/buildbot/bin/python'} 17:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:38 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 17:25:38 INFO - Cleaning up... 17:25:38 INFO - Return code: 0 17:25:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:25:38 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')]} 17:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:38 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')]} 17:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:38 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 0x7f35a65baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfd8c0>, '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 0x2bfe7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfec50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', '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 17:25:38 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 17:25:38 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 17:25:38 INFO - Using env: {'DISPLAY': ':0', 17:25:38 INFO - 'HOME': '/home/cltbld', 17:25:38 INFO - 'LANG': 'en_US.UTF-8', 17:25:38 INFO - 'LANGUAGE': 'en_US:en', 17:25:38 INFO - 'LOGNAME': 'cltbld', 17:25:38 INFO - 'MAIL': '/var/mail/cltbld', 17:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:38 INFO - 'MOZ_NO_REMOTE': '1', 17:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:38 INFO - 'NO_EM_RESTART': '1', 17:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:38 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:38 INFO - 'SHELL': '/bin/bash', 17:25:38 INFO - 'SHLVL': '1', 17:25:38 INFO - 'TERM': 'linux', 17:25:38 INFO - 'TMOUT': '86400', 17:25:38 INFO - 'USER': 'cltbld', 17:25:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', 17:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:38 INFO - '_': '/tools/buildbot/bin/python'} 17:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:38 INFO - Downloading/unpacking psutil>=0.7.1 17:25:38 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 17:25:38 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 17:25:38 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 17:25:38 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 17:25:38 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 17:25:38 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 17:25:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:25:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:40 INFO - Installing collected packages: psutil 17:25:40 INFO - Running setup.py install for psutil 17:25:40 INFO - building 'psutil._psutil_linux' extension 17:25:40 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 17:25:40 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 17:25:40 INFO - building 'psutil._psutil_posix' extension 17:25:40 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 17:25:40 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 17:25:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:41 INFO - Successfully installed psutil 17:25:41 INFO - Cleaning up... 17:25:41 INFO - Return code: 0 17:25:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:25:41 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')]} 17:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:41 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')]} 17:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:41 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 0x7f35a65baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfd8c0>, '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 0x2bfe7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfec50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', '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 17:25:41 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 17:25:41 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 17:25:41 INFO - Using env: {'DISPLAY': ':0', 17:25:41 INFO - 'HOME': '/home/cltbld', 17:25:41 INFO - 'LANG': 'en_US.UTF-8', 17:25:41 INFO - 'LANGUAGE': 'en_US:en', 17:25:41 INFO - 'LOGNAME': 'cltbld', 17:25:41 INFO - 'MAIL': '/var/mail/cltbld', 17:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:41 INFO - 'MOZ_NO_REMOTE': '1', 17:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:41 INFO - 'NO_EM_RESTART': '1', 17:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:41 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:41 INFO - 'SHELL': '/bin/bash', 17:25:41 INFO - 'SHLVL': '1', 17:25:41 INFO - 'TERM': 'linux', 17:25:41 INFO - 'TMOUT': '86400', 17:25:41 INFO - 'USER': 'cltbld', 17:25:41 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', 17:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:41 INFO - '_': '/tools/buildbot/bin/python'} 17:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:25:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:25:43 INFO - Installing collected packages: mozsystemmonitor 17:25:43 INFO - Running setup.py install for mozsystemmonitor 17:25:43 INFO - Successfully installed mozsystemmonitor 17:25:43 INFO - Cleaning up... 17:25:43 INFO - Return code: 0 17:25:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f35a65baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfd8c0>, '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 0x2bfe7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfec50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', '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 17:25:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:25:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:25:43 INFO - Using env: {'DISPLAY': ':0', 17:25:43 INFO - 'HOME': '/home/cltbld', 17:25:43 INFO - 'LANG': 'en_US.UTF-8', 17:25:43 INFO - 'LANGUAGE': 'en_US:en', 17:25:43 INFO - 'LOGNAME': 'cltbld', 17:25:43 INFO - 'MAIL': '/var/mail/cltbld', 17:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:43 INFO - 'MOZ_NO_REMOTE': '1', 17:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:43 INFO - 'NO_EM_RESTART': '1', 17:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:43 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:43 INFO - 'SHELL': '/bin/bash', 17:25:43 INFO - 'SHLVL': '1', 17:25:43 INFO - 'TERM': 'linux', 17:25:43 INFO - 'TMOUT': '86400', 17:25:43 INFO - 'USER': 'cltbld', 17:25:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', 17:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:43 INFO - '_': '/tools/buildbot/bin/python'} 17:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:43 INFO - Downloading/unpacking blobuploader==1.2.4 17:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:45 INFO - Downloading blobuploader-1.2.4.tar.gz 17:25:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:25:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:25:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:46 INFO - Downloading docopt-0.6.1.tar.gz 17:25:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:25:46 INFO - Installing collected packages: blobuploader, requests, docopt 17:25:46 INFO - Running setup.py install for blobuploader 17:25:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:25:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:25:46 INFO - Running setup.py install for requests 17:25:46 INFO - Running setup.py install for docopt 17:25:46 INFO - Successfully installed blobuploader requests docopt 17:25:46 INFO - Cleaning up... 17:25:46 INFO - Return code: 0 17:25:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:46 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 0x7f35a65baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfd8c0>, '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 0x2bfe7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfec50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', '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 17:25:46 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 17:25:46 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 17:25:46 INFO - Using env: {'DISPLAY': ':0', 17:25:46 INFO - 'HOME': '/home/cltbld', 17:25:46 INFO - 'LANG': 'en_US.UTF-8', 17:25:46 INFO - 'LANGUAGE': 'en_US:en', 17:25:46 INFO - 'LOGNAME': 'cltbld', 17:25:46 INFO - 'MAIL': '/var/mail/cltbld', 17:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:46 INFO - 'MOZ_NO_REMOTE': '1', 17:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:46 INFO - 'NO_EM_RESTART': '1', 17:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:46 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:46 INFO - 'SHELL': '/bin/bash', 17:25:46 INFO - 'SHLVL': '1', 17:25:46 INFO - 'TERM': 'linux', 17:25:46 INFO - 'TMOUT': '86400', 17:25:46 INFO - 'USER': 'cltbld', 17:25:46 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', 17:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:46 INFO - '_': '/tools/buildbot/bin/python'} 17:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:25:47 INFO - Running setup.py (path:/tmp/pip-ldlj0y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:25:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:25:47 INFO - Running setup.py (path:/tmp/pip-bXuDAv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:25:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:25:47 INFO - Running setup.py (path:/tmp/pip-Pg8YJ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:25:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:25:47 INFO - Running setup.py (path:/tmp/pip-niblh1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:25:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:25:47 INFO - Running setup.py (path:/tmp/pip-5HAtTK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:25:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:25:47 INFO - Running setup.py (path:/tmp/pip-i9mNAT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:25:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:25:47 INFO - Running setup.py (path:/tmp/pip-Kt9PQS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:25:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:25:47 INFO - Running setup.py (path:/tmp/pip-9kCgtb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:25:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:25:47 INFO - Running setup.py (path:/tmp/pip-7UTmr4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:25:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:25:47 INFO - Running setup.py (path:/tmp/pip-uV3Q7h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:25:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:25:47 INFO - Running setup.py (path:/tmp/pip-bloQvC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:25:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:25:47 INFO - Running setup.py (path:/tmp/pip-UBUrrW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:25:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:25:48 INFO - Running setup.py (path:/tmp/pip-RGV5tq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:25:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:25:48 INFO - Running setup.py (path:/tmp/pip-P3lpZd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:25:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:25:48 INFO - Running setup.py (path:/tmp/pip-pU42Sf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:25:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:25:48 INFO - Running setup.py (path:/tmp/pip-8HjSBv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:25:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:25:48 INFO - Running setup.py (path:/tmp/pip-7_v_N0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:25:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:25:48 INFO - Running setup.py install for manifestparser 17:25:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:25:48 INFO - Running setup.py install for mozcrash 17:25:48 INFO - Running setup.py install for mozdebug 17:25:48 INFO - Running setup.py install for mozdevice 17:25:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:25:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:25:48 INFO - Running setup.py install for mozfile 17:25:48 INFO - Running setup.py install for mozhttpd 17:25:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:25:49 INFO - Running setup.py install for mozinfo 17:25:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:25:49 INFO - Running setup.py install for mozInstall 17:25:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:25:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:25:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:25:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:25:49 INFO - Running setup.py install for mozleak 17:25:49 INFO - Running setup.py install for mozlog 17:25:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:25:49 INFO - Running setup.py install for moznetwork 17:25:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:25:49 INFO - Running setup.py install for mozprocess 17:25:49 INFO - Running setup.py install for mozprofile 17:25:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:25:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:25:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:25:49 INFO - Running setup.py install for mozrunner 17:25:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:25:49 INFO - Running setup.py install for mozscreenshot 17:25:49 INFO - Running setup.py install for moztest 17:25:50 INFO - Running setup.py install for mozversion 17:25:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:25:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:25:50 INFO - Cleaning up... 17:25:50 INFO - Return code: 0 17:25:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35a65baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfd8c0>, '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 0x2bfe7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfec50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', '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 17:25:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:25:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:25:50 INFO - Using env: {'DISPLAY': ':0', 17:25:50 INFO - 'HOME': '/home/cltbld', 17:25:50 INFO - 'LANG': 'en_US.UTF-8', 17:25:50 INFO - 'LANGUAGE': 'en_US:en', 17:25:50 INFO - 'LOGNAME': 'cltbld', 17:25:50 INFO - 'MAIL': '/var/mail/cltbld', 17:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:50 INFO - 'MOZ_NO_REMOTE': '1', 17:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:50 INFO - 'NO_EM_RESTART': '1', 17:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:50 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:50 INFO - 'SHELL': '/bin/bash', 17:25:50 INFO - 'SHLVL': '1', 17:25:50 INFO - 'TERM': 'linux', 17:25:50 INFO - 'TMOUT': '86400', 17:25:50 INFO - 'USER': 'cltbld', 17:25:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', 17:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:50 INFO - '_': '/tools/buildbot/bin/python'} 17:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:25:50 INFO - Running setup.py (path:/tmp/pip-rirFHS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:25:50 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)) 17:25:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:25:50 INFO - Running setup.py (path:/tmp/pip-BSXL7i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:25:50 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)) 17:25:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:25:50 INFO - Running setup.py (path:/tmp/pip-T63y86-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:25:50 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)) 17:25:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:25:50 INFO - Running setup.py (path:/tmp/pip-BeUmKL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:25:50 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)) 17:25:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:25:50 INFO - Running setup.py (path:/tmp/pip-OEgKdu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:25:50 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)) 17:25:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:25:50 INFO - Running setup.py (path:/tmp/pip-X5URc_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:25:50 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)) 17:25:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:25:50 INFO - Running setup.py (path:/tmp/pip-MxwStV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:25:50 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)) 17:25:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:25:50 INFO - Running setup.py (path:/tmp/pip-uB6Fmg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:25:50 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)) 17:25:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:25:50 INFO - Running setup.py (path:/tmp/pip-t_4H2M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 17:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:25:51 INFO - Running setup.py (path:/tmp/pip-9MWo9u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:25:51 INFO - Running setup.py (path:/tmp/pip-7KrWm_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 17:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:25:51 INFO - Running setup.py (path:/tmp/pip-Vdur5i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 17:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:25:51 INFO - Running setup.py (path:/tmp/pip-o9z34R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:25:51 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)) 17:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:25:51 INFO - Running setup.py (path:/tmp/pip-SHWhUj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:25:51 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)) 17:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:25:51 INFO - Running setup.py (path:/tmp/pip-Td51Yq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:25:51 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)) 17:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:25:51 INFO - Running setup.py (path:/tmp/pip-pWfHlc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:25:51 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)) 17:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:25:51 INFO - Running setup.py (path:/tmp/pip-leSjJs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:25:51 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)) 17:25:51 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)) 17:25:51 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)) 17:25:51 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)) 17:25:51 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)) 17:25:51 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)) 17:25:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:25:51 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 17:25:51 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 17:25:51 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 17:25:51 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 17:25:51 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 17:25:51 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 17:25:53 INFO - Downloading blessings-1.6.tar.gz 17:25:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:25:53 INFO - Installing collected packages: blessings 17:25:53 INFO - Running setup.py install for blessings 17:25:53 INFO - Successfully installed blessings 17:25:53 INFO - Cleaning up... 17:25:53 INFO - Return code: 0 17:25:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:25:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:25:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:25:54 INFO - Reading from file tmpfile_stdout 17:25:54 INFO - Current package versions: 17:25:54 INFO - argparse == 1.2.1 17:25:54 INFO - blessings == 1.6 17:25:54 INFO - blobuploader == 1.2.4 17:25:54 INFO - docopt == 0.6.1 17:25:54 INFO - manifestparser == 1.1 17:25:54 INFO - mozInstall == 1.12 17:25:54 INFO - mozcrash == 0.16 17:25:54 INFO - mozdebug == 0.1 17:25:54 INFO - mozdevice == 0.48 17:25:54 INFO - mozfile == 1.2 17:25:54 INFO - mozhttpd == 0.7 17:25:54 INFO - mozinfo == 0.9 17:25:54 INFO - mozleak == 0.1 17:25:54 INFO - mozlog == 3.1 17:25:54 INFO - moznetwork == 0.27 17:25:54 INFO - mozprocess == 0.22 17:25:54 INFO - mozprofile == 0.28 17:25:54 INFO - mozrunner == 6.11 17:25:54 INFO - mozscreenshot == 0.1 17:25:54 INFO - mozsystemmonitor == 0.0 17:25:54 INFO - moztest == 0.7 17:25:54 INFO - mozversion == 1.4 17:25:54 INFO - psutil == 3.1.1 17:25:54 INFO - requests == 1.2.3 17:25:54 INFO - wsgiref == 0.1.2 17:25:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:25: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')]} 17:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35a65baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfd8c0>, '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 0x2bfe7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfec50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', '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 17:25:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 17:25:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:25:54 INFO - Using env: {'DISPLAY': ':0', 17:25:54 INFO - 'HOME': '/home/cltbld', 17:25:54 INFO - 'LANG': 'en_US.UTF-8', 17:25:54 INFO - 'LANGUAGE': 'en_US:en', 17:25:54 INFO - 'LOGNAME': 'cltbld', 17:25:54 INFO - 'MAIL': '/var/mail/cltbld', 17:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:54 INFO - 'MOZ_NO_REMOTE': '1', 17:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:54 INFO - 'NO_EM_RESTART': '1', 17:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:54 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:54 INFO - 'SHELL': '/bin/bash', 17:25:54 INFO - 'SHLVL': '1', 17:25:54 INFO - 'TERM': 'linux', 17:25:54 INFO - 'TMOUT': '86400', 17:25:54 INFO - 'USER': 'cltbld', 17:25:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', 17:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:54 INFO - '_': '/tools/buildbot/bin/python'} 17:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 17:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 17:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 17:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 17:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 17:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 17:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 17:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:25:54 INFO - Cleaning up... 17:25:54 INFO - Return code: 0 17:25:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:25: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')]} 17:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35a65baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfd8c0>, '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 0x2bfe7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfec50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', '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 17:25:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 17:25:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:25:54 INFO - Using env: {'DISPLAY': ':0', 17:25:54 INFO - 'HOME': '/home/cltbld', 17:25:54 INFO - 'LANG': 'en_US.UTF-8', 17:25:54 INFO - 'LANGUAGE': 'en_US:en', 17:25:54 INFO - 'LOGNAME': 'cltbld', 17:25:54 INFO - 'MAIL': '/var/mail/cltbld', 17:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:54 INFO - 'MOZ_NO_REMOTE': '1', 17:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:54 INFO - 'NO_EM_RESTART': '1', 17:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:54 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:54 INFO - 'SHELL': '/bin/bash', 17:25:54 INFO - 'SHLVL': '1', 17:25:54 INFO - 'TERM': 'linux', 17:25:54 INFO - 'TMOUT': '86400', 17:25:54 INFO - 'USER': 'cltbld', 17:25:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', 17:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:54 INFO - '_': '/tools/buildbot/bin/python'} 17:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:54 INFO - Downloading/unpacking jsonschema 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:25:56 INFO - Downloading/unpacking functools32 (from jsonschema) 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25:56 INFO - Downloading functools32-3.2.3-2.tar.gz 17:25:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:25:56 INFO - warning: no files found matching '*.txt' 17:25:56 INFO - no previously-included directories found matching 'build' 17:25:56 INFO - no previously-included directories found matching 'dist' 17:25:56 INFO - no previously-included directories found matching '.git*' 17:25:56 INFO - Installing collected packages: jsonschema, functools32 17:25:56 INFO - Running setup.py install for functools32 17:25:56 INFO - warning: no files found matching '*.txt' 17:25:56 INFO - no previously-included directories found matching 'build' 17:25:56 INFO - no previously-included directories found matching 'dist' 17:25:56 INFO - no previously-included directories found matching '.git*' 17:25:56 INFO - Successfully installed jsonschema functools32 17:25:56 INFO - Cleaning up... 17:25:56 INFO - Return code: 0 17:25:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:25: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')]} 17:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35a65baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6e670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfd8c0>, '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 0x2bfe7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfec50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', '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 17:25: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', 'flake8'] in /builds/slave/test-pgo/build 17:25: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 flake8 17:25:56 INFO - Using env: {'DISPLAY': ':0', 17:25:56 INFO - 'HOME': '/home/cltbld', 17:25:56 INFO - 'LANG': 'en_US.UTF-8', 17:25:56 INFO - 'LANGUAGE': 'en_US:en', 17:25:56 INFO - 'LOGNAME': 'cltbld', 17:25:56 INFO - 'MAIL': '/var/mail/cltbld', 17:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:56 INFO - 'MOZ_NO_REMOTE': '1', 17:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:56 INFO - 'NO_EM_RESTART': '1', 17:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:56 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:56 INFO - 'SHELL': '/bin/bash', 17:25:56 INFO - 'SHLVL': '1', 17:25:56 INFO - 'TERM': 'linux', 17:25:56 INFO - 'TMOUT': '86400', 17:25:56 INFO - 'USER': 'cltbld', 17:25:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', 17:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:56 INFO - '_': '/tools/buildbot/bin/python'} 17:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:57 INFO - Downloading/unpacking flake8 17:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:25:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:25:58 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 17:25:58 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 17:25:58 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 17:25:58 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 17:25:58 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 17:25:58 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 17:25:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:25:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:25:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:25:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:25:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:25:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:25:59 INFO - no previously-included directories found matching 'docs/_build' 17:25:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:25:59 INFO - Running setup.py install for pep8 17:25:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:25:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:25:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:25:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:25:59 INFO - no previously-included directories found matching 'docs/_build' 17:25:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:25:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:25:59 INFO - Cleaning up... 17:25:59 INFO - Return code: 0 17:25:59 INFO - Running post-action listener: _resource_record_post_action 17:25:59 INFO - Running post-action listener: _start_resource_monitoring 17:25:59 INFO - Starting resource monitoring. 17:25:59 INFO - ##### 17:25:59 INFO - ##### Running install step. 17:25:59 INFO - ##### 17:25:59 INFO - Running pre-action listener: _resource_record_pre_action 17:25:59 INFO - Running main action method: install 17:25:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:25:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:25:59 INFO - Reading from file tmpfile_stdout 17:25:59 INFO - Detecting whether we're running mozinstall >=1.0... 17:25:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:25:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:26:00 INFO - Reading from file tmpfile_stdout 17:26:00 INFO - Output received: 17:26:00 INFO - Usage: mozinstall [options] installer 17:26:00 INFO - Options: 17:26:00 INFO - -h, --help show this help message and exit 17:26:00 INFO - -d DEST, --destination=DEST 17:26:00 INFO - Directory to install application into. [default: 17:26:00 INFO - "/builds/slave/test-pgo"] 17:26:00 INFO - --app=APP Application being installed. [default: firefox] 17:26:00 INFO - mkdir: /builds/slave/test-pgo/build/application 17:26:00 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'] 17:26:00 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 17:26:27 INFO - Reading from file tmpfile_stdout 17:26:27 INFO - Output received: 17:26:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:26:27 INFO - Running post-action listener: _resource_record_post_action 17:26:27 INFO - ##### 17:26:27 INFO - ##### Running run-tests step. 17:26:27 INFO - ##### 17:26:27 INFO - Running pre-action listener: _resource_record_pre_action 17:26:27 INFO - Running main action method: run_tests 17:26:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:26:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:26:27 INFO - Python 2.7.3 17:26:27 INFO - Return code: 0 17:26:27 INFO - grabbing minidump binary from tooltool 17:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:26:27 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 0x2bfd8c0>, '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 0x2bfe7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfec50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:26:27 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 17:26:27 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 17:26:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:26:27 INFO - Return code: 0 17:26:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:26:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:26:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:26:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:26:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:26:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:26:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:26:28 INFO - Return code: 0 17:26:28 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/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 17:26:28 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/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 17:26:28 INFO - Using env: {'DISPLAY': ':0', 17:26:28 INFO - 'HOME': '/home/cltbld', 17:26:28 INFO - 'LANG': 'en_US.UTF-8', 17:26:28 INFO - 'LANGUAGE': 'en_US:en', 17:26:28 INFO - 'LOGNAME': 'cltbld', 17:26:28 INFO - 'MAIL': '/var/mail/cltbld', 17:26:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:26:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:28 INFO - 'MOZ_NO_REMOTE': '1', 17:26:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:28 INFO - 'NO_EM_RESTART': '1', 17:26:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:26:28 INFO - 'PWD': '/builds/slave/test-pgo', 17:26:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:26:28 INFO - 'SHELL': '/bin/bash', 17:26:28 INFO - 'SHLVL': '1', 17:26:28 INFO - 'TERM': 'linux', 17:26:28 INFO - 'TMOUT': '86400', 17:26:28 INFO - 'USER': 'cltbld', 17:26:28 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940', 17:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:28 INFO - '_': '/tools/buildbot/bin/python'} 17:26:28 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/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 17:26:28 INFO - mozversion application_buildid: 20160229143016 17:26:28 INFO - mozversion application_changeset: 446932a345fe1631718eb0b6bcb3e098c2958265 17:26:28 INFO - mozversion application_display_name: Nightly 17:26:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:26:28 INFO - mozversion application_name: Firefox 17:26:28 INFO - mozversion application_remotingname: firefox 17:26:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:26:28 INFO - mozversion application_vendor: Mozilla 17:26:28 INFO - mozversion application_version: 47.0a1 17:26:28 INFO - mozversion platform_buildid: 20160229143016 17:26:28 INFO - mozversion platform_changeset: 446932a345fe1631718eb0b6bcb3e098c2958265 17:26:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:26:28 INFO - mozversion platform_version: 47.0a1 17:26:28 INFO - using testdate: 1456795588 17:26:28 INFO - actual date: 1456795588 17:26:28 INFO - starting webserver on 'localhost:39661' 17:26:28 INFO - SUITE-START | Running 2 tests 17:26:28 INFO - TEST-START | dromaeo_css 17:26:28 INFO - operating with platform_type : linux_ 17:26:28 INFO - Initialising browser for dromaeo_css test... 17:26:28 INFO - TEST-INFO | started process 27567 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3Shoxu/profile http://localhost:39661/getInfo.html) 17:27:23 INFO - PROCESS | 27567 | __metrics Screen width/height:1600/1200 17:27:23 INFO - PROCESS | 27567 | colorDepth:24 17:27:23 INFO - PROCESS | 27567 | Browser inner width/height: 1024/697 17:27:23 INFO - PROCESS | 27567 | __metrics 17:27:27 INFO - PROCESS | 27567 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:27:27 INFO - PROCESS | 27567 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:27:27 INFO - PROCESS | 27567 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:27:27 INFO - PROCESS | 27567 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:27:27 INFO - PROCESS | 27567 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:27:27 INFO - PROCESS | 27567 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:27:27 INFO - PROCESS | 27567 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:27:27 INFO - PROCESS | 27567 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:27:28 INFO - TEST-INFO | 27567: exit 0 17:27:28 INFO - Browser initialized. 17:27:28 INFO - Running cycle 1/1 for dromaeo_css test... 17:27:28 INFO - TEST-INFO | started process 27667 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3Shoxu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:40 INFO - PROCESS | 27667 | RSS: Main: 153436160 17:27:40 INFO - PROCESS | 27667 | 17:28:32 INFO - PROCESS | 27667 | 1456795712163 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] 17:30:41 INFO - PROCESS | 27667 | Cycle 1(1): loaded http://localhost:39661/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39661/tests/dromaeo/cssquery-ext.html) 17:30:42 INFO - PROCESS | 27667 | RSS: Main: 258945024 17:30:42 INFO - PROCESS | 27667 | 17:33:44 INFO - PROCESS | 27667 | Cycle 1(1): loaded http://localhost:39661/tests/dromaeo/cssquery-ext.html (next: http://localhost:39661/tests/dromaeo/cssquery-jquery.html) 17:33:45 INFO - PROCESS | 27667 | RSS: Main: 235118592 17:33:45 INFO - PROCESS | 27667 | 17:36:46 INFO - PROCESS | 27667 | Cycle 1(1): loaded http://localhost:39661/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39661/tests/dromaeo/cssquery-mootools.html) 17:36:47 INFO - PROCESS | 27667 | RSS: Main: 231895040 17:36:47 INFO - PROCESS | 27667 | 17:39:49 INFO - PROCESS | 27667 | Cycle 1(1): loaded http://localhost:39661/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39661/tests/dromaeo/cssquery-prototype.html) 17:39:49 INFO - PROCESS | 27667 | RSS: Main: 200638464 17:39:49 INFO - PROCESS | 27667 | 17:42:52 INFO - PROCESS | 27667 | Cycle 1(1): loaded http://localhost:39661/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39661/tests/dromaeo/cssquery-yui.html) 17:42:53 INFO - PROCESS | 27667 | RSS: Main: 218365952 17:42:53 INFO - PROCESS | 27667 | 17:45:55 INFO - PROCESS | 27667 | Cycle 1(1): loaded http://localhost:39661/tests/dromaeo/cssquery-yui.html (next: http://localhost:39661/tests/dromaeo/cssquery-dojo.html) 17:45:56 INFO - PROCESS | 27667 | RSS: Main: 316403712 17:45:56 INFO - PROCESS | 27667 | 17:45:56 INFO - PROCESS | 27667 | __start_tp_report 17:45:56 INFO - PROCESS | 27667 | _x_x_mozilla_page_load 17:45:56 INFO - PROCESS | 27667 | _x_x_mozilla_page_load_details 17:45:56 INFO - PROCESS | 27667 | |i|pagename|runs| 17:45:56 INFO - PROCESS | 27667 | |0;dojo.html;3085.398347322272;3085.9970509584364;3119.937601247975;3126.999360204734;3154.0695494829024;4898.216285394333;4905.583025442837;4929.359183306174;4988.226824842155;4996.975015124928;5000.949990500094;5001;5065.974670126653;5075.137226671465;5098.7960481580785;4477.6417886569;4504.211762941481;4617.445906491209;4638.257878739402;4645.674802763808;4583.862484125465;4597.701149425294;4638.397008388904;4649.186392381337;4666.113438446701;4474.44069491312;4496.460424749019;4504.054148628792;4514.751688657123;4533.184026875161;4576.610988066019;4577.519360467137;4589.518100599423;4608.216603177468;4644.489106198315;4480.955190448087;4537.546245375469;4556.04323092151;4571.6114130298965;4583.954160458419;4911.8772030699165;4912.287718280865;4933.629977751683;4938.135826230396;4960.379952505937;5344.732763361855;5386.111291636876;5390.245365648812;5393.325834270716;5437.075697131497;5249.501297376743;5370.167624018283;5372.623916325859;5396.406395296514;5403.945960540384;4990.8253211137435;5006.724630145341;5008.474110218374;5012.874678133039;5063.746812659389;5428.430014848384;5429.267048948421;5430.728463576885;5432.674039557639;5487.835364939058;5096.439391666913;5192.662476939063;5231.71225582589;5251.684898906078;5251.973740131351;5262.368515778131;5264.6051546134195;5268.78924843002;5278.366596008504;5279.392869819943;5265.921011184835;5267.183586544092;5268.315119034578;5279.604029697788;5316.574674026146;5234.869128271747;5272.288241087481;5273.499017593323;5302.125149350314;5328.813491527778;4064.3293856513346;4067.8169482373364;4074.2258970795456;4074.837006519706;4098.221337945781;3662.597114317423;3679.061839230979;3700.093477098128;3711.406175011985;3737.8131093445218;5066.493350664904;5070.340855688811;5074.264231686385;5106.770195341219;5118.360204974379;5257.342832145981;5288.497592728685;5309.522143007148;5312.495312945264;5354.491323324278;4883.072216278895;5015.799368025311;5021.397432308147;5021.698698078127;5058.696478211319;4517.164324599894;4540.387047748512;4569.29175977724;4571.748553829505;4577.908441831145;5525.309336332878;5538.169274608841;5539.7784088636;5542.722863856871;5575.498205161555;5250;5277.419483856849;5286.392064912584;5291.841244762663;5295.073362161529;5588.329400471969;5592.972035139798;5595.63628364155;5607.859803504945;5643.125315576092;5243.5542978847225;5245.370555533361;5263.5525980292105;5268.262443258023;5313.521783039545;5214.556762675215;5314.202869569595;5328.280682107866;5357.919631205613;5388.622796404214;5165.974170129125;5216.347956505437;5217.921731174111;5219.112750832443;5221.321228240305;5207.192885102815;5208.192730126836;5211.843644690665;5215.713135777569;5238.004779091961;5060.696358218519;5061.822836200715;5077.974610127074;5115.309433226466;5132.640715149903;5201.453847345974;5223.503767142115;5224.373075230997;5231.529162375405;5234.712090834888;4994.500549945122;5095.92356114666;5133.383993920754;5148.2020286855595;5194.922076168785 17:45:56 INFO - PROCESS | 27667 | |1;ext.html;519.8570393141886;521.6166117903342;578.9536837053037;581.6887964938758;583.3757879069398;27935.441291174164;28432.85783571082;34972.300553988935;35349.2930141397;35387;38315;38685.61314386862;38697.41953870694;38701;38778.418323725164;8451.154884511561;8640.827183456327;8650;8652.740417787476;8655.48067115975;8479.491230526188;8607.139286071406;8610.784730381727;8627.61175747093;8631.13688631135;8592.957035214846;8689.739307820775;8764.474131552128;8824.779380515507;8938.106189381075;8700.30397568193;8782.912170878306;8864.911350886538;8870.42342247752;8873.600687969058;8702.260307873776;8863.689770857989;8889.377743557954;8890.777730556787;8891.510966896818;38338.80830595857;38991.805040974614;39110.21779564393;39175.60824391748;39194.60805391938;3265.591801024872;3285;3330.8667653293837;3365.915852103717;3493.441049432104;25980.480390392277;26474;26697.73302266972;26927.865360673266;27425.86287068572;3184.7292980096718;3218.8476864844324;3281.6882396172327;3294.3081952789944;3306.1073510152123;265867;266469.6676516624;266707;266773;267173;55684.44315556873;56168.43831561714;56577.43422565804;56592;56721;50210.497895020584;50683.23975140376;50818.491815081376;50954.490455095714;51057;13592.524261650993;13716.0398772087;13741.381637826322;13749.037567370387;13751.381187846571;11248.662540123809;11303.321800691985;11315.943420282845;11325.830112548318;11329.376884271443;19370.70943935842;19508.90245548763;19554.706679399536;19701;20399.388018359474;7553.357964573072;8001.599920003977;8001.759947201594;8044.396670249755;8096.716614918568;945.5083356654501;956.5743244256239;1041.510490069666;1050.3382868792612;1065.8347956066666;25677.229683109537;25763;25816.225513234633;25820.354491137496;25853.224403267934;1024.6977141743203;1036.5387402605768;1039.7296702857311;1105.1103861391657;1141.0985321595847;13360;13972.650683732785;13996.580102596938;14146.36341364641;14269.500567480089;294093;295806;296835;297174;297639;50694.74652626713;51079.23381149286;51177.23234151491;51243.48756512462;51336.229956550684;1005.3163848583034;1291.1736488647273;1328.3291937571464;1333.726586049877;1344.6907211341252;24586;25939.481210376063;26216.606750899133;26446.603300950115;26741.732582673925;38021;38678.2264354717;39195;39223.41164882472;39347.213055739296;183396;193737;194298;194524;294952;28792.424151517273;28978.7102128976;29249.26876828011;29374;29707.405851883275;35401.29197415986;36547.086322842144;36962.07594810151;37109.62890371062;37365.4395184067;30958.690413096483;31447.84276078605;33155.33689326248;33159.17102072467;33191.17022074467;29558.704412956457;29716;30040.24899377533;30080;30278.697213027586;33481.49777753384;33495.16262093467;33637.49543756895;33702.49446258259;37381.81309093546;29096.7090329094;30602.151074289955;30758.538621921136;33880.32239355249;34864.825675871456;23317.3004809856;23532.33262658174;24534.754652453248;24704.629430558198;24959.500809983336 17:45:56 INFO - PROCESS | 27667 | |2;jquery.html;326.27078479598094;328.2827022954843;335.33672982009233;338.5632534031099;340.8551365669593;16312.184390780458;16696.332146714132;17251.74122388162;17282.654346913056;17362;13973.930130349334;14169.645758856033;14311.78532322016;14330.28348582572;14359.856401435982;5220.530152286294;5433.429489903562;5441.319835020622;5448.91826622601;5462.918056229159;5094.592432605401;5304.655197412156;5308.23030660554;5311.044012077825;5311.575073994071;5249.1601343785005;5255.553277971358;5258.815941442051;5260.763265653055;5261.210818377255;5017.573506251973;5222.817201397933;5223.869403264911;5231.65994210377;5243.318368612075;4562.5665561771575;4569.2003899317815;4586.564276393738;4595.701279416827;4615.953840461586;10705.892941070568;11156.665300041012;11162;11165.553377864875;19194.328198513125;2088.4883203615213;2148.1085349579907;2153.8923053847243;2165.588538177741;2170.804627583525;8550.828983420359;8702.869456958151;8752.343574231958;8960.059193784624;11957.760844783055;1789.9463016109537;1807.9457616271534;1825.8174182581768;1837.9632407351778;1843.9262429502803;55908;61560.69219653918;61920;62849;63409.04886426661;9263.351565390492;9269.536523173814;9443.858342124873;9449.858252126223;9630.422174669542;12075.57735479254;12156.452959616661;12159.209651372632;12175.391230438443;12195.08536859739;7040.6479676016;7133.928660713326;7134.607596582134;7195.96402017997;7273.236310187354;6576.704048317742;6730.562513436709;6752.3922846944015;6756.189257289157;6953.826154346182;3823.3500304948225;3944.5463771666628;4042.0905296308683;4042.656374208166;4092.6725861930972;1495.7158139953374;1512.8562786535263;1693.898366098038;1695.804982427012;1695.8304169582943;901.197933838884;935.209747763139;938.1650331205233;962.3215632978734;980.2452111873818;15353;15979.440719574759;16061;16392.426265080903;16436.01383916969;906.0305473143804;914.8856392950881;934.313279739391;988.5353883674806;1003.4481035430484;8919.331050171133;9213.12475314844;9324.919822146507;9388.483633400228;9404;397840;398058;400497;403683;406591;47971.52028479741;61524;64583.67708161429;67235.3276467229;68070.65964670244;946.2713710442921;947.3699989507038;966.5795379010153;967.4630580028012;984.7291994701371;14387.85612143907;14564.635884102558;14829.555113346616;15067.321970511133;15295;27812.58281125744;32927.176820579676;33647;33774.662253378134;33985.66014339924;44046.559534404245;44997.55002449934;45898.77050614726;46218.30672539847;46607.30089048735;7281;7445.590492522963;7506.549607023596;7647.732329368446;7700.037495313086;11588.304701717923;12234.877651223374;12349.3825308736;12412.317322547347;12415.875841241472;9995.800083998425;10362.740931476774;10532.875353330735;10799.67600971972;10850.565977360817;10212.744681383025;10391.792164156826;10536;10608.151347891995;10691.893081069089;10880.238383313092;10884.673459796219;10971.122310215324;11058.336499810037;11229.382383968634;7060.54106483077;7082.291770822876;7349.044624199034;7469.365103966006;7484.812879678052;10203.489825508546;10464.31981921203;10791;11002.33985960845;11034.779304414027 17:45:56 INFO - PROCESS | 27667 | |3;mootools.html;1338.738945905549;1447.5874375802896;1465.0623600895428;1608.6219738361483;1759.3314540474619;6489.123968264289;7180.71277148914;7336.669849856756;7338.3395494405495;7358.558486490814;7028.613426261553;7180.712771489148;7187.173475050371;7190.820229494252;7198.316159964808;1929.324736342276;2151.064287035137;2185.5410363823535;2199.7250343707037;2254.966175507369;2203.6253836847773;2210.0386331945574;2211.9004644790944;2214.070090561968;2217.4788924602703;2135.2740068376747;2188.5951099046647;2191.22211614876;2194.550117225973;2197.165077270635;2194.2978246960897;2220.600291947449;2227.509947811487;2252.155441709359;2255.5150642611916;2181.4873504726374;2210.767869373725;2218.3344996500987;2226.5546890621777;2235.608768465512;7461.515001524937;7513.887291690629;7521.398288136936;7535.623218839091;7553.093628764584;4330.783460826978;4431.379606855043;4432.290833466662;4434.955650443519;4448.599626033672;2826.5336219523756;2879.84160871152;2940.6471223453323;2947.631546056743;2948.7198716121934;876.4215617692292;886.8359353519555;913.3789023464042;922.2345453273833;1736.2534110332551;10143.695689129338;10195.49022548877;10205.489725513695;10220.948895255551;10239.18086553074;3607.3687104756564;3732.64539868712;3772.5284339457567;3774.245150969817;3873.0898238913833;7917.327027202752;7950.4832185907735;7965.920340796518;7967.521948683097;7978.361731061501;3890.805459727059;4394.692371533962;4422.778861056999;4425.446819147606;4429.75636339998;3913.295606790748;3936.252112098692;3938.1729836734035;3942.743721658083;3993;3243.594550681165;3316.2538428853795;3320.037189215149;3344.3144155448076;3346.113279980807;962.9903700963041;986.6053578568486;992.3648864726581;993.895640957689;996.7009897030862;1158.6639874436487;1285.6143157052848;1287.8583355831038;1298.2989185839729;1301.7266374061364;6971.477139214579;7001.299870012958;7019.8596028079155;7021.29787021304;7047.68285427157;434.71526150371557;453.77764895201113;456.05823973494626;456.92917597772396;458.16613762951107;5475.917861232085;5511.3937466878615;5551.306086739158;5552.666839989613;5561.972190139023;8683.348748843735;8905.643774248958;9124.087591240956;9140.90859091414;9193.126652967958;9037.77405564866;9048.728538143734;9063.546822658973;9076.09239076087;9101;6535.705893234815;6813.557118787263;6815.35254150845;7292.635368231568;7351.816204594821;6807;6930.61881596517;6971.930280697331;6977.058097157022;6988.650567471708;7937.801554961172;8015.438919275828;8070.798230044061;8096.878546821685;8196.180381961756;8227.753167404748;8320.16798320163;8400.117987611213;8559.058503564478;8559.229669329541;6530.183727034121;6617.669116544057;6705.631190284581;6728.9570116632;6740.561863478858;7182.60495672743;7204.027456293543;7207.243239459991;7210.206877243394;7244.166920803964;6156.507479401726;6197.907031394442;6250.343713910156;6426.839329016812;6543.280239173592;5979.1928089707335;6303.653299068412;6410.9038364425505;6438.581492202992;6527;6719.025741267586;6726.630035348103;6763.188417389944;6772.627505487246;6779.389854913082;6030.7889223876955;6035.034394496859;6058.757649694139;6076.726547305293;6240.906386404298;6330.177076979963;6384.233891932812;6386.16979792624;6386.9680651596445;6394.26465956421 17:45:56 INFO - PROCESS | 27667 | |4;prototype.html;286.5000573998373;292.4180880048703;296.8738286228352;297.47050250554014;299.8380874327863;5803.535717142629;5929.822105336847;5934.792282270121;5943.465088142067;5999.370066143058;5786.594938354317;5818.389069147742;5839.883202335951;5847.356790753014;5922.763089476426;4219.978900105495;4273.636740877029;4387.8025488853;4388.056567837914;4395;4378.883384736903;4389.5390983946545;4394.780260986954;4400.537943515917;4403.119376124771;4338.392625032482;4348.434703488542;4353.73877567347;4363.978180109111;4367.148406060819;4191.55988621195;4232.703710740249;4263.936040959357;4327.415798867144;4355.651547876162;3686.1706116123923;3688.6495782900583;3694.8891533254045;3701.2967536168044;3721.218544105741;5564.666120032811;5565.332160140809;5568.777248910039;5573.219749235111;5582.078956972095;5041.344625198737;5043.84868453947;5050.2929589857085;5050.974745126287;5057.595392368602;6187.257529096492;6194.225721784777;6198.659073750942;6200.348963358872;6201.410865967726;3997.4603428537357;4119.114390406047;4124.8143833527265;4127.050778320973;4129;6452.6772011737485;6505.381988711065;6532.967335163294;6537.280899101095;6547;4133.090720041586;4136.91726165481;4138.503379594468;4140.792960351971;4141.585841415835;4153;4161.542230354658;4166.291730405838;4169.854055108117;4189.7695626740215;4982.10322142018;4989.3264409305;4991.201407774739;4995.875103122378;4996.325496057985;6287.245530536365;6288.496920246369;6291.874162516816;6292.685365731695;6296.811095667137;1440.7550716378241;1458.6645071633584;1488.4269556220934;1489.3819065088085;1491.686745783376;904.8552231642906;953.3755390219418;966.9323147379756;972.1833659725722;976.6776963601994;5941.7623295067715;6088.299845517734;6093.664848433379;6095.908561371583;6109;6496.740130394731;6502.869942601122;6520.641364724891;6570.835729106715;6576.671166441754;6073.635581865102;6076.058210977306;6078.1186727924205;6081.939180608226;6086.1175129606845;3457.4640930655787;3489.9302013959577;3490.7730997485082;3495.2834668892815;3495.493153492729;6644.60132392058;6842.897356539655;6879.208890977501;6907.516473846883;6915.792526224222;6607.041978913031;6633.436157926631;6643.3391652086975;6650.73397064112;6651;6879.862402751917;6885.139357580302;6889.104416425833;6891.310868913069;6898;6459.547831651739;6470.288268290578;6477.546571739933;6488.545801793829;6491.221053473613;6265.185525881789;6432.45324147434;6441;6442.645654489048;6473.417392434703;6880.036794848826;6884.552504087218;6904.758333458506;6920.861582768417;6927.272636373108;4216.620504154641;4246.915061698687;4249.575042495726;4252.149570086057;4252.574742525722;6487.286398496256;6491.350864913471;6491.837704057436;6502.284748677736;6505.642189679613;6296.464800491826;6319.46284565817;6372.58578192416;6376.808695739135;6378.712957916812;6158.398816307703;6309.085182648399;6310.810675679737;6318.08387783778;6342.270638876588;6185.195924529782;6203.4416902479;6204.565680402328;6206.162168107247;6218.844528886814;6321.620702757849;6323.430891219812;6348;6349.238091429058;6353.523485738496;5944.881102377842;6058.848528786815;6191.690415479298;6207.81376558704;6211.472024877936 17:45:56 INFO - PROCESS | 27667 | |5;yui.html;714.1822613107992;755.7317152410894;760.1448370583093;762.4738930138208;800.5636927874308;13734.244616546086;14017.649558761035;14051.086679365846;14055.648608784786;14057.718845623094;14465.78301325481;14655.706885862302;14683.853161468409;14686.853131468682;14708.043977141479;679.6771533521562;817.5871185051556;821.8191997760483;825.1294883897516;825.6449726617552;803.0483876606211;823.2179429541959;826.1119296755982;826.243986752121;826.4917075998247;841.6212704283066;847.7541512961234;850.4429598612918;854.3250831842837;854.7136709202393;703.6657587645827;838.5555655502593;842.321930845669;846.3525403066659;847.5338563789891;626;626.8777588370269;627.2567008095422;627.4509803921569;627.5638431290255;14046.087004344685;14089.577312680534;14108.858911410856;14119.78820317696;14128.293585320693;12157.209781364183;12416.875831241663;12511.436985335682;12707.110502264844;12954.80567791484;9253.953730231373;9364.110409511086;9484.573194206278;9524.14282714552;9651.034896510362;3637.7271704621994;3662.8351724172476;3686.3733165361955;3770.170562476278;3772.2078363543687;49951.75024124856;50168.49831501711;50240;50396.24405633919;50404.24393634099;9611.759706007266;9788.363756355815;9800.411975281364;9918.80162396748;10177.745556361002;18027.098645067694;18121.275148994155;18138.727919081226;18187.727184092248;18219.54451138732;7516.924830751732;7521.849563008709;7764.922350776533;7800.336971357385;7845.882311765328;4030.4760381150263;4072.531658859269;4110.403991421227;4155.335146376626;4199.853005144805;2859.785516086302;2869.4548035873117;2871.425714857037;2876.8273903565855;2889.581010753429;513.9897202056013;515.5025400488547;520.9817656382085;525.9105951988095;534.0200731657375;512.5207930584841;572.7193675099255;621.6984762390238;632.908228306893;650.7104338569292;7807.414443916729;7996;8031.277185053374;8066.838663226703;8242.381821363422;466.7129715225112;549.9752511136928;615.7198474694003;639.2329204954074;653.5229282623711;3794.962050379461;3858.8456461741216;3859.054531639766;3935.9016024599614;3985.4221137934837;55764.44235557593;55873.1619025715;55970.16044759332;56001.71999139978;58391.416085839446;47781.28328075082;47826.28260576094;48401.51598484041;48406;48564.75717621389;43769.78115109404;43908.38961909017;43923.121537569066;44157;44894.77552612216;7497.887531687138;7633.923660763321;7933.801654958672;7959.801004974922;8094.069182043905;32472.53873575742;33314.33371332511;33341.499877501374;33641.327173456884;33834.8308258467;39688.80155599319;39833.60166398299;42150.36774448447;43913.12173756571;44865.77567112144;9997.300188986992;10045.347052441568;10373.429461379697;10567.365958042543;10603.584058961622;10347.172226221734;10475.633352832614;10602.575896964036;11036.944815275872;11045.889541104487;10381.273310868166;10624.150067994387;10915.945420273165;10951.233413660968;10992.340459572451;9774.706758797247;9778.364406313567;9925.619916781789;10081.647142349982;10239.846402303823;10179;10478.580856765644;10775.191860610328;10809.027187553158;10829.025387715143;9218.677346292847;9220.354575179674;9431.481268530297;9436.969714970184;9695;8168.305694016075;8933.687320943736;9097.317701172306;9149.542522873697;9187.402818816756 17:45:56 INFO - PROCESS | 27667 | __end_tp_report 17:45:56 INFO - PROCESS | 27667 | __start_cc_report 17:45:56 INFO - PROCESS | 27667 | _x_x_mozilla_cycle_collect,795 17:45:56 INFO - PROCESS | 27667 | __end_cc_report 17:45:56 INFO - PROCESS | 27667 | __startTimestamp1456796756178__endTimestamp 17:45:56 INFO - PROCESS | 27667 | 17:45:56 INFO - PROCESS | 27667 | ------- Summary: start ------- 17:45:56 INFO - PROCESS | 27667 | Number of tests: 6 17:45:56 INFO - PROCESS | 27667 | 17:45:56 INFO - PROCESS | 27667 | [#0] dojo.html Cycles:165 Average:4961.37 Median:5132.64 stddev:528.44 (10.3%) stddev-sans-first:509.16 17:45:56 INFO - PROCESS | 27667 | Values: 3085.4 3086.0 3119.9 3127.0 3154.1 4898.2 4905.6 4929.4 4988.2 4997.0 5000.9 5001.0 5066.0 5075.1 5098.8 4477.6 4504.2 4617.4 4638.3 4645.7 4583.9 4597.7 4638.4 4649.2 4666.1 4474.4 4496.5 4504.1 4514.8 4533.2 4576.6 4577.5 4589.5 4608.2 4644.5 4481.0 4537.5 4556.0 4571.6 4584.0 4911.9 4912.3 4933.6 4938.1 4960.4 5344.7 5386.1 5390.2 5393.3 5437.1 5249.5 5370.2 5372.6 5396.4 5403.9 4990.8 5006.7 5008.5 5012.9 5063.7 5428.4 5429.3 5430.7 5432.7 5487.8 5096.4 5192.7 5231.7 5251.7 5252.0 5262.4 5264.6 5268.8 5278.4 5279.4 5265.9 5267.2 5268.3 5279.6 5316.6 5234.9 5272.3 5273.5 5302.1 5328.8 4064.3 4067.8 4074.2 4074.8 4098.2 3662.6 3679.1 3700.1 3711.4 3737.8 5066.5 5070.3 5074.3 5106.8 5118.4 5257.3 5288.5 5309.5 5312.5 5354.5 4883.1 5015.8 5021.4 5021.7 5058.7 4517.2 4540.4 4569.3 4571.7 4577.9 5525.3 5538.2 5539.8 5542.7 5575.5 5250.0 5277.4 5286.4 5291.8 5295.1 5588.3 5593.0 5595.6 5607.9 5643.1 5243.6 5245.4 5263.6 5268.3 5313.5 5214.6 5314.2 5328.3 5357.9 5388.6 5166.0 5216.3 5217.9 5219.1 5221.3 5207.2 5208.2 5211.8 5215.7 5238.0 5060.7 5061.8 5078.0 5115.3 5132.6 5201.5 5223.5 5224.4 5231.5 5234.7 4994.5 5095.9 5133.4 5148.2 5194.9 17:45:56 INFO - PROCESS | 27667 | 17:45:56 INFO - PROCESS | 27667 | [#1] ext.html Cycles:180 Average:41667.11 Median:3300.21 stddev:68387.01 (2072.2%) stddev-sans-first:68509.07 17:45:56 INFO - PROCESS | 27667 | Values: 519.9 521.6 579.0 581.7 583.4 27935.4 28432.9 34972.3 35349.3 35387.0 38315.0 38685.6 38697.4 38701.0 38778.4 8451.2 8640.8 8650.0 8652.7 8655.5 8479.5 8607.1 8610.8 8627.6 8631.1 8593.0 8689.7 8764.5 8824.8 8938.1 8700.3 8782.9 8864.9 8870.4 8873.6 8702.3 8863.7 8889.4 8890.8 8891.5 38338.8 38991.8 39110.2 39175.6 39194.6 3265.6 3285.0 3330.9 3365.9 3493.4 25980.5 26474.0 26697.7 26927.9 27425.9 3184.7 3218.8 3281.7 3294.3 3306.1 265867.0 266469.7 266707.0 266773.0 267173.0 55684.4 56168.4 56577.4 56592.0 56721.0 50210.5 50683.2 50818.5 50954.5 51057.0 13592.5 13716.0 13741.4 13749.0 13751.4 11248.7 11303.3 11315.9 11325.8 11329.4 19370.7 19508.9 19554.7 19701.0 20399.4 7553.4 8001.6 8001.8 8044.4 8096.7 945.5 956.6 1041.5 1050.3 1065.8 25677.2 25763.0 25816.2 25820.4 25853.2 1024.7 1036.5 1039.7 1105.1 1141.1 13360.0 13972.7 13996.6 14146.4 14269.5 294093.0 295806.0 296835.0 297174.0 297639.0 50694.7 51079.2 51177.2 51243.5 51336.2 1005.3 1291.2 1328.3 1333.7 1344.7 24586.0 25939.5 26216.6 26446.6 26741.7 38021.0 38678.2 39195.0 39223.4 39347.2 183396.0 193737.0 194298.0 194524.0 294952.0 28792.4 28978.7 29249.3 29374.0 29707.4 35401.3 36547.1 36962.1 37109.6 37365.4 30958.7 31447.8 33155.3 33159.2 33191.2 29558.7 29716.0 30040.2 30080.0 30278.7 33481.5 33495.2 33637.5 33702.5 37381.8 29096.7 30602.2 30758.5 33880.3 34864.8 23317.3 23532.3 24534.8 24704.6 24959.5 17:45:56 INFO - PROCESS | 27667 | 17:45:56 INFO - PROCESS | 27667 | [#2] jquery.html Cycles:180 Average:23315.54 Median:24069.62 stddev:65756.16 (273.2%) stddev-sans-first:65917.97 17:45:56 INFO - PROCESS | 27667 | Values: 326.3 328.3 335.3 338.6 340.9 16312.2 16696.3 17251.7 17282.7 17362.0 13973.9 14169.6 14311.8 14330.3 14359.9 5220.5 5433.4 5441.3 5448.9 5462.9 5094.6 5304.7 5308.2 5311.0 5311.6 5249.2 5255.6 5258.8 5260.8 5261.2 5017.6 5222.8 5223.9 5231.7 5243.3 4562.6 4569.2 4586.6 4595.7 4616.0 10705.9 11156.7 11162.0 11165.6 19194.3 2088.5 2148.1 2153.9 2165.6 2170.8 8550.8 8702.9 8752.3 8960.1 11957.8 1789.9 1807.9 1825.8 1838.0 1843.9 55908.0 61560.7 61920.0 62849.0 63409.0 9263.4 9269.5 9443.9 9449.9 9630.4 12075.6 12156.5 12159.2 12175.4 12195.1 7040.6 7133.9 7134.6 7196.0 7273.2 6576.7 6730.6 6752.4 6756.2 6953.8 3823.4 3944.5 4042.1 4042.7 4092.7 1495.7 1512.9 1693.9 1695.8 1695.8 901.2 935.2 938.2 962.3 980.2 15353.0 15979.4 16061.0 16392.4 16436.0 906.0 914.9 934.3 988.5 1003.4 8919.3 9213.1 9324.9 9388.5 9404.0 397840.0 398058.0 400497.0 403683.0 406591.0 47971.5 61524.0 64583.7 67235.3 68070.7 946.3 947.4 966.6 967.5 984.7 14387.9 14564.6 14829.6 15067.3 15295.0 27812.6 32927.2 33647.0 33774.7 33985.7 44046.6 44997.6 45898.8 46218.3 46607.3 7281.0 7445.6 7506.5 7647.7 7700.0 11588.3 12234.9 12349.4 12412.3 12415.9 9995.8 10362.7 10532.9 10799.7 10850.6 10212.7 10391.8 10536.0 10608.2 10691.9 10880.2 10884.7 10971.1 11058.3 11229.4 7060.5 7082.3 7349.0 7469.4 7484.8 10203.5 10464.3 10791.0 11002.3 11034.8 17:45:56 INFO - PROCESS | 27667 | 17:45:56 INFO - PROCESS | 27667 | [#3] mootools.html Cycles:180 Average:5156.28 Median:6316.92 stddev:2706.31 (42.8%) stddev-sans-first:2698.69 17:45:56 INFO - PROCESS | 27667 | Values: 1338.7 1447.6 1465.1 1608.6 1759.3 6489.1 7180.7 7336.7 7338.3 7358.6 7028.6 7180.7 7187.2 7190.8 7198.3 1929.3 2151.1 2185.5 2199.7 2255.0 2203.6 2210.0 2211.9 2214.1 2217.5 2135.3 2188.6 2191.2 2194.6 2197.2 2194.3 2220.6 2227.5 2252.2 2255.5 2181.5 2210.8 2218.3 2226.6 2235.6 7461.5 7513.9 7521.4 7535.6 7553.1 4330.8 4431.4 4432.3 4435.0 4448.6 2826.5 2879.8 2940.6 2947.6 2948.7 876.4 886.8 913.4 922.2 1736.3 10143.7 10195.5 10205.5 10220.9 10239.2 3607.4 3732.6 3772.5 3774.2 3873.1 7917.3 7950.5 7965.9 7967.5 7978.4 3890.8 4394.7 4422.8 4425.4 4429.8 3913.3 3936.3 3938.2 3942.7 3993.0 3243.6 3316.3 3320.0 3344.3 3346.1 963.0 986.6 992.4 993.9 996.7 1158.7 1285.6 1287.9 1298.3 1301.7 6971.5 7001.3 7019.9 7021.3 7047.7 434.7 453.8 456.1 456.9 458.2 5475.9 5511.4 5551.3 5552.7 5562.0 8683.3 8905.6 9124.1 9140.9 9193.1 9037.8 9048.7 9063.5 9076.1 9101.0 6535.7 6813.6 6815.4 7292.6 7351.8 6807.0 6930.6 6971.9 6977.1 6988.7 7937.8 8015.4 8070.8 8096.9 8196.2 8227.8 8320.2 8400.1 8559.1 8559.2 6530.2 6617.7 6705.6 6729.0 6740.6 7182.6 7204.0 7207.2 7210.2 7244.2 6156.5 6197.9 6250.3 6426.8 6543.3 5979.2 6303.7 6410.9 6438.6 6527.0 6719.0 6726.6 6763.2 6772.6 6779.4 6030.8 6035.0 6058.8 6076.7 6240.9 6330.2 6384.2 6386.2 6387.0 6394.3 17:45:56 INFO - PROCESS | 27667 | 17:45:56 INFO - PROCESS | 27667 | [#4] prototype.html Cycles:180 Average:5192.29 Median:6080.03 stddev:1652.86 (27.2%) stddev-sans-first:1615.97 17:45:56 INFO - PROCESS | 27667 | Values: 286.5 292.4 296.9 297.5 299.8 5803.5 5929.8 5934.8 5943.5 5999.4 5786.6 5818.4 5839.9 5847.4 5922.8 4220.0 4273.6 4387.8 4388.1 4395.0 4378.9 4389.5 4394.8 4400.5 4403.1 4338.4 4348.4 4353.7 4364.0 4367.1 4191.6 4232.7 4263.9 4327.4 4355.7 3686.2 3688.6 3694.9 3701.3 3721.2 5564.7 5565.3 5568.8 5573.2 5582.1 5041.3 5043.8 5050.3 5051.0 5057.6 6187.3 6194.2 6198.7 6200.3 6201.4 3997.5 4119.1 4124.8 4127.1 4129.0 6452.7 6505.4 6533.0 6537.3 6547.0 4133.1 4136.9 4138.5 4140.8 4141.6 4153.0 4161.5 4166.3 4169.9 4189.8 4982.1 4989.3 4991.2 4995.9 4996.3 6287.2 6288.5 6291.9 6292.7 6296.8 1440.8 1458.7 1488.4 1489.4 1491.7 904.9 953.4 966.9 972.2 976.7 5941.8 6088.3 6093.7 6095.9 6109.0 6496.7 6502.9 6520.6 6570.8 6576.7 6073.6 6076.1 6078.1 6081.9 6086.1 3457.5 3489.9 3490.8 3495.3 3495.5 6644.6 6842.9 6879.2 6907.5 6915.8 6607.0 6633.4 6643.3 6650.7 6651.0 6879.9 6885.1 6889.1 6891.3 6898.0 6459.5 6470.3 6477.5 6488.5 6491.2 6265.2 6432.5 6441.0 6442.6 6473.4 6880.0 6884.6 6904.8 6920.9 6927.3 4216.6 4246.9 4249.6 4252.1 4252.6 6487.3 6491.4 6491.8 6502.3 6505.6 6296.5 6319.5 6372.6 6376.8 6378.7 6158.4 6309.1 6310.8 6318.1 6342.3 6185.2 6203.4 6204.6 6206.2 6218.8 6321.6 6323.4 6348.0 6349.2 6353.5 5944.9 6058.8 6191.7 6207.8 6211.5 17:45:56 INFO - PROCESS | 27667 | 17:45:56 INFO - PROCESS | 27667 | [#5] yui.html Cycles:180 Average:13396.20 Median:50318.12 stddev:15539.15 (30.9%) stddev-sans-first:15553.55 17:45:56 INFO - PROCESS | 27667 | Values: 714.2 755.7 760.1 762.5 800.6 13734.2 14017.6 14051.1 14055.6 14057.7 14465.8 14655.7 14683.9 14686.9 14708.0 679.7 817.6 821.8 825.1 825.6 803.0 823.2 826.1 826.2 826.5 841.6 847.8 850.4 854.3 854.7 703.7 838.6 842.3 846.4 847.5 626.0 626.9 627.3 627.5 627.6 14046.1 14089.6 14108.9 14119.8 14128.3 12157.2 12416.9 12511.4 12707.1 12954.8 9254.0 9364.1 9484.6 9524.1 9651.0 3637.7 3662.8 3686.4 3770.2 3772.2 49951.8 50168.5 50240.0 50396.2 50404.2 9611.8 9788.4 9800.4 9918.8 10177.7 18027.1 18121.3 18138.7 18187.7 18219.5 7516.9 7521.8 7764.9 7800.3 7845.9 4030.5 4072.5 4110.4 4155.3 4199.9 2859.8 2869.5 2871.4 2876.8 2889.6 514.0 515.5 521.0 525.9 534.0 512.5 572.7 621.7 632.9 650.7 7807.4 7996.0 8031.3 8066.8 8242.4 466.7 550.0 615.7 639.2 653.5 3795.0 3858.8 3859.1 3935.9 3985.4 55764.4 55873.2 55970.2 56001.7 58391.4 47781.3 47826.3 48401.5 48406.0 48564.8 43769.8 43908.4 43923.1 44157.0 44894.8 7497.9 7633.9 7933.8 7959.8 8094.1 32472.5 33314.3 33341.5 33641.3 33834.8 39688.8 39833.6 42150.4 43913.1 44865.8 9997.3 10045.3 10373.4 10567.4 10603.6 10347.2 10475.6 10602.6 11036.9 11045.9 10381.3 10624.2 10915.9 10951.2 10992.3 9774.7 9778.4 9925.6 10081.6 10239.8 10179.0 10478.6 10775.2 10809.0 10829.0 9218.7 9220.4 9431.5 9437.0 9695.0 8168.3 8933.7 9097.3 9149.5 9187.4 17:45:56 INFO - PROCESS | 27667 | -------- Summary: end -------- 17:45:56 INFO - PROCESS | 27667 | 17:45:56 INFO - PROCESS | 27667 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:45:56 INFO - PROCESS | 27667 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:45:56 INFO - PROCESS | 27667 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:45:56 INFO - PROCESS | 27667 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:45:56 INFO - PROCESS | 27667 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:45:56 INFO - PROCESS | 27667 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:45:56 INFO - PROCESS | 27667 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:45:57 INFO - TEST-INFO | 27667: exit 0 17:45:57 INFO - TEST-OK | dromaeo_css | took 1168671ms 17:45:57 INFO - TEST-START | kraken 17:45:57 INFO - operating with platform_type : linux_ 17:45:57 INFO - Initialising browser for kraken test... 17:45:57 INFO - TEST-INFO | started process 27857 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEKj6Lg/profile http://localhost:39661/getInfo.html) 17:46:04 INFO - PROCESS | 27857 | __metrics Screen width/height:1600/1200 17:46:04 INFO - PROCESS | 27857 | colorDepth:24 17:46:04 INFO - PROCESS | 27857 | Browser inner width/height: 1024/697 17:46:04 INFO - PROCESS | 27857 | __metrics 17:46:06 INFO - PROCESS | 27857 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:46:06 INFO - PROCESS | 27857 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:46:06 INFO - PROCESS | 27857 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:46:06 INFO - PROCESS | 27857 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:46:06 INFO - PROCESS | 27857 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:46:06 INFO - PROCESS | 27857 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:46:06 INFO - PROCESS | 27857 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:46:06 INFO - PROCESS | 27857 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:46:08 INFO - TEST-INFO | 27857: exit 0 17:46:08 INFO - Browser initialized. 17:46:08 INFO - Running cycle 1/1 for kraken test... 17:46:08 INFO - TEST-INFO | started process 27942 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEKj6Lg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:46:19 INFO - PROCESS | 27942 | RSS: Main: 153444352 17:46:19 INFO - PROCESS | 27942 | 17:46:22 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39661/tests/kraken/driver.html?testName=audio-beat-detection) 17:46:22 INFO - PROCESS | 27942 | RSS: Main: 197718016 17:46:22 INFO - PROCESS | 27942 | 17:46:25 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39661/tests/kraken/driver.html?testName=audio-dft) 17:46:26 INFO - PROCESS | 27942 | RSS: Main: 185028608 17:46:26 INFO - PROCESS | 27942 | 17:46:29 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39661/tests/kraken/driver.html?testName=audio-fft) 17:46:29 INFO - PROCESS | 27942 | RSS: Main: 171081728 17:46:29 INFO - PROCESS | 27942 | 17:46:31 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39661/tests/kraken/driver.html?testName=audio-oscillator) 17:46:32 INFO - PROCESS | 27942 | RSS: Main: 174555136 17:46:32 INFO - PROCESS | 27942 | 17:46:34 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39661/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:46:34 INFO - PROCESS | 27942 | RSS: Main: 174743552 17:46:34 INFO - PROCESS | 27942 | 17:46:37 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39661/tests/kraken/driver.html?testName=imaging-darkroom) 17:46:38 INFO - PROCESS | 27942 | RSS: Main: 176189440 17:46:38 INFO - PROCESS | 27942 | 17:46:42 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39661/tests/kraken/driver.html?testName=imaging-desaturate) 17:46:42 INFO - PROCESS | 27942 | RSS: Main: 174456832 17:46:42 INFO - PROCESS | 27942 | 17:46:45 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39661/tests/kraken/driver.html?testName=json-parse-financial) 17:46:46 INFO - PROCESS | 27942 | RSS: Main: 174645248 17:46:46 INFO - PROCESS | 27942 | 17:46:47 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39661/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:46:48 INFO - PROCESS | 27942 | RSS: Main: 190824448 17:46:48 INFO - PROCESS | 27942 | 17:46:50 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39661/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:46:50 INFO - PROCESS | 27942 | RSS: Main: 186368000 17:46:50 INFO - PROCESS | 27942 | 17:46:52 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39661/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:46:53 INFO - PROCESS | 27942 | RSS: Main: 195973120 17:46:53 INFO - PROCESS | 27942 | 17:46:55 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:46:56 INFO - PROCESS | 27942 | RSS: Main: 204034048 17:46:56 INFO - PROCESS | 27942 | 17:46:58 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:47:00 INFO - PROCESS | 27942 | RSS: Main: 203735040 17:47:00 INFO - PROCESS | 27942 | 17:47:02 INFO - PROCESS | 27942 | Cycle 1(1): loaded http://localhost:39661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39661/tests/kraken/driver.html?testName=ai-astar) 17:47:07 INFO - PROCESS | 27942 | RSS: Main: 263606272 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | __start_tp_report 17:47:08 INFO - PROCESS | 27942 | _x_x_mozilla_page_load 17:47:08 INFO - PROCESS | 27942 | _x_x_mozilla_page_load_details 17:47:08 INFO - PROCESS | 27942 | |i|pagename|runs| 17:47:08 INFO - PROCESS | 27942 | |0;ai-astar;111;111;106;111;110;110;101;110;109;110 17:47:08 INFO - PROCESS | 27942 | |1;audio-beat-detection;153;125;155;167;128;163;156;132;179;128 17:47:08 INFO - PROCESS | 27942 | |2;audio-dft;162;161;163;162;161;160;161;163;162;162 17:47:08 INFO - PROCESS | 27942 | |3;audio-fft;73;72;95;94;74;72;71;101;94;72 17:47:08 INFO - PROCESS | 27942 | |4;audio-oscillator;96;95;153;96;96;96;149;96;95;151 17:47:08 INFO - PROCESS | 27942 | |5;imaging-gaussian-blur;119;116;115;115;115;115;115;115;115;115 17:47:08 INFO - PROCESS | 27942 | |6;imaging-darkroom;146;145;146;146;146;145;146;146;146;146 17:47:08 INFO - PROCESS | 27942 | |7;imaging-desaturate;96;97;97;96;96;97;96;96;96;96 17:47:08 INFO - PROCESS | 27942 | |8;json-parse-financial;58;58;56;55;56;56;57;58;55;55 17:47:08 INFO - PROCESS | 27942 | |9;json-stringify-tinderbox;68;69;69;69;69;68;74;68;69;68 17:47:08 INFO - PROCESS | 27942 | |10;stanford-crypto-aes;82;80;82;82;82;84;82;83;95;86 17:47:08 INFO - PROCESS | 27942 | |11;stanford-crypto-ccm;116;115;123;117;115;119;129;117;121;116 17:47:08 INFO - PROCESS | 27942 | |12;stanford-crypto-pbkdf2;153;146;152;154;152;143;151;152;161;152 17:47:08 INFO - PROCESS | 27942 | |13;stanford-crypto-sha256-iterative;68;71;70;69;69;68;72;69;68;70 17:47:08 INFO - PROCESS | 27942 | __end_tp_report 17:47:08 INFO - PROCESS | 27942 | __start_cc_report 17:47:08 INFO - PROCESS | 27942 | _x_x_mozilla_cycle_collect,1060 17:47:08 INFO - PROCESS | 27942 | __end_cc_report 17:47:08 INFO - PROCESS | 27942 | __startTimestamp1456796822729__endTimestamp 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | ------- Summary: start ------- 17:47:08 INFO - PROCESS | 27942 | Number of tests: 14 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.14 (2.9%) stddev-sans-first:3.24 17:47:08 INFO - PROCESS | 27942 | Values: 111.0 111.0 106.0 111.0 110.0 110.0 101.0 110.0 109.0 110.0 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:155.50 stddev:19.05 (12.3%) stddev-sans-first:20.14 17:47:08 INFO - PROCESS | 27942 | Values: 153.0 125.0 155.0 167.0 128.0 163.0 156.0 132.0 179.0 128.0 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 17:47:08 INFO - PROCESS | 27942 | Values: 162.0 161.0 163.0 162.0 161.0 160.0 161.0 163.0 162.0 162.0 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#3] audio-fft Cycles:10 Average:81.80 Median:73.50 stddev:12.40 (16.9%) stddev-sans-first:12.74 17:47:08 INFO - PROCESS | 27942 | Values: 73.0 72.0 95.0 94.0 74.0 72.0 71.0 101.0 94.0 72.0 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#4] audio-oscillator Cycles:10 Average:112.30 Median:96.00 stddev:26.73 (27.8%) stddev-sans-first:27.69 17:47:08 INFO - PROCESS | 27942 | Values: 96.0 95.0 153.0 96.0 96.0 96.0 149.0 96.0 95.0 151.0 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.00 stddev:1.27 (1.1%) stddev-sans-first:0.33 17:47:08 INFO - PROCESS | 27942 | Values: 119.0 116.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 17:47:08 INFO - PROCESS | 27942 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:47:08 INFO - PROCESS | 27942 | Values: 96.0 97.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.26 (2.2%) stddev-sans-first:1.20 17:47:08 INFO - PROCESS | 27942 | Values: 58.0 58.0 56.0 55.0 56.0 56.0 57.0 58.0 55.0 55.0 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:1.79 (2.6%) stddev-sans-first:1.86 17:47:08 INFO - PROCESS | 27942 | Values: 68.0 69.0 69.0 69.0 69.0 68.0 74.0 68.0 69.0 68.0 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:82.50 stddev:4.24 (5.1%) stddev-sans-first:4.44 17:47:08 INFO - PROCESS | 27942 | Values: 82.0 80.0 82.0 82.0 82.0 84.0 82.0 83.0 95.0 86.0 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:118.00 stddev:4.44 (3.8%) stddev-sans-first:4.59 17:47:08 INFO - PROCESS | 27942 | Values: 116.0 115.0 123.0 117.0 115.0 119.0 129.0 117.0 121.0 116.0 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:152.00 stddev:4.74 (3.1%) stddev-sans-first:5.00 17:47:08 INFO - PROCESS | 27942 | Values: 153.0 146.0 152.0 154.0 152.0 143.0 151.0 152.0 161.0 152.0 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.35 (1.9%) stddev-sans-first:1.33 17:47:08 INFO - PROCESS | 27942 | Values: 68.0 71.0 70.0 69.0 69.0 68.0 72.0 69.0 68.0 70.0 17:47:08 INFO - PROCESS | 27942 | -------- Summary: end -------- 17:47:08 INFO - PROCESS | 27942 | 17:47:08 INFO - PROCESS | 27942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:47:08 INFO - PROCESS | 27942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:47:08 INFO - PROCESS | 27942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:47:08 INFO - PROCESS | 27942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:47:08 INFO - PROCESS | 27942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:47:10 INFO - Browser shutdown timed out after 5 seconds, terminating process. 17:47:10 INFO - Terminating psutil.Process(pid=27942, name='firefox') 17:47:10 INFO - TEST-INFO | 27942: exit 0 17:47:10 INFO - TEST-OK | kraken | took 73643ms 17:47:10 INFO - SUITE-END | took 1242s 17:47:10 INFO - Completed test suite (00:20:42) 17:47:10 INFO - Working with test: dromaeo_css 17:47:10 INFO - Generating results file: dromaeo_css 17:47:10 INFO - Working with test: kraken 17:47:10 INFO - Generating results file: kraken 17:47:10 INFO - javascript benchmark 17:47:10 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:47:10 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:47:10 INFO - process_Request line: dromaeo_css 6545.70 graph.html#tests=[[72,64,35]] 17:47:10 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:47:10 INFO - process_Request line: kraken 1520.00 graph.html#tests=[[232,64,35]] 17:47:10 INFO - RETURN: dromaeo_css: 6545.70 17:47:10 INFO - RETURN: kraken: 1520.00 17:47:10 INFO - javascript benchmark 17:47:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3085.398347322272, 3085.9970509584364, 3119.937601247975, 3126.999360204734, 3154.0695494829024, 4898.216285394333, 4905.583025442837, 4929.359183306174, 4988.226824842155, 4996.975015124928, 5000.949990500094, 5001.0, 5065.974670126653, 5075.137226671465, 5098.7960481580785, 4477.6417886569, 4504.211762941481, 4617.445906491209, 4638.257878739402, 4645.674802763808, 4583.862484125465, 4597.701149425294, 4638.397008388904, 4649.186392381337, 4666.113438446701, 4474.44069491312, 4496.460424749019, 4504.054148628792, 4514.751688657123, 4533.184026875161, 4576.610988066019, 4577.519360467137, 4589.518100599423, 4608.216603177468, 4644.489106198315, 4480.955190448087, 4537.546245375469, 4556.04323092151, 4571.6114130298965, 4583.954160458419, 4911.8772030699165, 4912.287718280865, 4933.629977751683, 4938.135826230396, 4960.379952505937, 5344.732763361855, 5386.111291636876, 5390.245365648812, 5393.325834270716, 5437.075697131497, 5249.501297376743, 5370.167624018283, 5372.623916325859, 5396.406395296514, 5403.945960540384, 4990.8253211137435, 5006.724630145341, 5008.474110218374, 5012.874678133039, 5063.746812659389, 5428.430014848384, 5429.267048948421, 5430.728463576885, 5432.674039557639, 5487.835364939058, 5096.439391666913, 5192.662476939063, 5231.71225582589, 5251.684898906078, 5251.973740131351, 5262.368515778131, 5264.6051546134195, 5268.78924843002, 5278.366596008504, 5279.392869819943, 5265.921011184835, 5267.183586544092, 5268.315119034578, 5279.604029697788, 5316.574674026146, 5234.869128271747, 5272.288241087481, 5273.499017593323, 5302.125149350314, 5328.813491527778, 4064.3293856513346, 4067.8169482373364, 4074.2258970795456, 4074.837006519706, 4098.221337945781, 3662.597114317423, 3679.061839230979, 3700.093477098128, 3711.406175011985, 3737.8131093445218, 5066.493350664904, 5070.340855688811, 5074.264231686385, 5106.770195341219, 5118.360204974379, 5257.342832145981, 5288.497592728685, 5309.522143007148, 5312.495312945264, 5354.491323324278, 4883.072216278895, 5015.799368025311, 5021.397432308147, 5021.698698078127, 5058.696478211319, 4517.164324599894, 4540.387047748512, 4569.29175977724, 4571.748553829505, 4577.908441831145, 5525.309336332878, 5538.169274608841, 5539.7784088636, 5542.722863856871, 5575.498205161555, 5250.0, 5277.419483856849, 5286.392064912584, 5291.841244762663, 5295.073362161529, 5588.329400471969, 5592.972035139798, 5595.63628364155, 5607.859803504945, 5643.125315576092, 5243.5542978847225, 5245.370555533361, 5263.5525980292105, 5268.262443258023, 5313.521783039545, 5214.556762675215, 5314.202869569595, 5328.280682107866, 5357.919631205613, 5388.622796404214, 5165.974170129125, 5216.347956505437, 5217.921731174111, 5219.112750832443, 5221.321228240305, 5207.192885102815, 5208.192730126836, 5211.843644690665, 5215.713135777569, 5238.004779091961, 5060.696358218519, 5061.822836200715, 5077.974610127074, 5115.309433226466, 5132.640715149903, 5201.453847345974, 5223.503767142115, 5224.373075230997, 5231.529162375405, 5234.712090834888, 4994.500549945122, 5095.92356114666, 5133.383993920754, 5148.2020286855595, 5194.922076168785], "unit": "score", "name": "dojo.html", "value": 4928.893431764992}, {"lowerIsBetter": false, "replicates": [519.8570393141886, 521.6166117903342, 578.9536837053037, 581.6887964938758, 583.3757879069398, 27935.441291174164, 28432.85783571082, 34972.300553988935, 35349.2930141397, 35387.0, 38315.0, 38685.61314386862, 38697.41953870694, 38701.0, 38778.418323725164, 8451.154884511561, 8640.827183456327, 8650.0, 8652.740417787476, 8655.48067115975, 8479.491230526188, 8607.139286071406, 8610.784730381727, 8627.61175747093, 8631.13688631135, 8592.957035214846, 8689.739307820775, 8764.474131552128, 8824.779380515507, 8938.106189381075, 8700.30397568193, 8782.912170878306, 8864.911350886538, 8870.42342247752, 8873.600687969058, 8702.260307873776, 8863.689770857989, 8889.377743557954, 8890.777730556787, 8891.510966896818, 38338.80830595857, 38991.805040974614, 39110.21779564393, 39175.60824391748, 39194.60805391938, 3265.591801024872, 3285.0, 3330.8667653293837, 3365.915852103717, 3493.441049432104, 25980.480390392277, 26474.0, 26697.73302266972, 26927.865360673266, 27425.86287068572, 3184.7292980096718, 3218.8476864844324, 3281.6882396172327, 3294.3081952789944, 3306.1073510152123, 265867.0, 266469.6676516624, 266707.0, 266773.0, 267173.0, 55684.44315556873, 56168.43831561714, 56577.43422565804, 56592.0, 56721.0, 50210.497895020584, 50683.23975140376, 50818.491815081376, 50954.490455095714, 51057.0, 13592.524261650993, 13716.0398772087, 13741.381637826322, 13749.037567370387, 13751.381187846571, 11248.662540123809, 11303.321800691985, 11315.943420282845, 11325.830112548318, 11329.376884271443, 19370.70943935842, 19508.90245548763, 19554.706679399536, 19701.0, 20399.388018359474, 7553.357964573072, 8001.599920003977, 8001.759947201594, 8044.396670249755, 8096.716614918568, 945.5083356654501, 956.5743244256239, 1041.510490069666, 1050.3382868792612, 1065.8347956066666, 25677.229683109537, 25763.0, 25816.225513234633, 25820.354491137496, 25853.224403267934, 1024.6977141743203, 1036.5387402605768, 1039.7296702857311, 1105.1103861391657, 1141.0985321595847, 13360.0, 13972.650683732785, 13996.580102596938, 14146.36341364641, 14269.500567480089, 294093.0, 295806.0, 296835.0, 297174.0, 297639.0, 50694.74652626713, 51079.23381149286, 51177.23234151491, 51243.48756512462, 51336.229956550684, 1005.3163848583034, 1291.1736488647273, 1328.3291937571464, 1333.726586049877, 1344.6907211341252, 24586.0, 25939.481210376063, 26216.606750899133, 26446.603300950115, 26741.732582673925, 38021.0, 38678.2264354717, 39195.0, 39223.41164882472, 39347.213055739296, 183396.0, 193737.0, 194298.0, 194524.0, 294952.0, 28792.424151517273, 28978.7102128976, 29249.26876828011, 29374.0, 29707.405851883275, 35401.29197415986, 36547.086322842144, 36962.07594810151, 37109.62890371062, 37365.4395184067, 30958.690413096483, 31447.84276078605, 33155.33689326248, 33159.17102072467, 33191.17022074467, 29558.704412956457, 29716.0, 30040.24899377533, 30080.0, 30278.697213027586, 33481.49777753384, 33495.16262093467, 33637.49543756895, 33702.49446258259, 37381.81309093546, 29096.7090329094, 30602.151074289955, 30758.538621921136, 33880.32239355249, 34864.825675871456, 23317.3004809856, 23532.33262658174, 24534.754652453248, 24704.629430558198, 24959.500809983336], "unit": "score", "name": "ext.html", "value": 17237.285352559986}, {"lowerIsBetter": false, "replicates": [326.27078479598094, 328.2827022954843, 335.33672982009233, 338.5632534031099, 340.8551365669593, 16312.184390780458, 16696.332146714132, 17251.74122388162, 17282.654346913056, 17362.0, 13973.930130349334, 14169.645758856033, 14311.78532322016, 14330.28348582572, 14359.856401435982, 5220.530152286294, 5433.429489903562, 5441.319835020622, 5448.91826622601, 5462.918056229159, 5094.592432605401, 5304.655197412156, 5308.23030660554, 5311.044012077825, 5311.575073994071, 5249.1601343785005, 5255.553277971358, 5258.815941442051, 5260.763265653055, 5261.210818377255, 5017.573506251973, 5222.817201397933, 5223.869403264911, 5231.65994210377, 5243.318368612075, 4562.5665561771575, 4569.2003899317815, 4586.564276393738, 4595.701279416827, 4615.953840461586, 10705.892941070568, 11156.665300041012, 11162.0, 11165.553377864875, 19194.328198513125, 2088.4883203615213, 2148.1085349579907, 2153.8923053847243, 2165.588538177741, 2170.804627583525, 8550.828983420359, 8702.869456958151, 8752.343574231958, 8960.059193784624, 11957.760844783055, 1789.9463016109537, 1807.9457616271534, 1825.8174182581768, 1837.9632407351778, 1843.9262429502803, 55908.0, 61560.69219653918, 61920.0, 62849.0, 63409.04886426661, 9263.351565390492, 9269.536523173814, 9443.858342124873, 9449.858252126223, 9630.422174669542, 12075.57735479254, 12156.452959616661, 12159.209651372632, 12175.391230438443, 12195.08536859739, 7040.6479676016, 7133.928660713326, 7134.607596582134, 7195.96402017997, 7273.236310187354, 6576.704048317742, 6730.562513436709, 6752.3922846944015, 6756.189257289157, 6953.826154346182, 3823.3500304948225, 3944.5463771666628, 4042.0905296308683, 4042.656374208166, 4092.6725861930972, 1495.7158139953374, 1512.8562786535263, 1693.898366098038, 1695.804982427012, 1695.8304169582943, 901.197933838884, 935.209747763139, 938.1650331205233, 962.3215632978734, 980.2452111873818, 15353.0, 15979.440719574759, 16061.0, 16392.426265080903, 16436.01383916969, 906.0305473143804, 914.8856392950881, 934.313279739391, 988.5353883674806, 1003.4481035430484, 8919.331050171133, 9213.12475314844, 9324.919822146507, 9388.483633400228, 9404.0, 397840.0, 398058.0, 400497.0, 403683.0, 406591.0, 47971.52028479741, 61524.0, 64583.67708161429, 67235.3276467229, 68070.65964670244, 946.2713710442921, 947.3699989507038, 966.5795379010153, 967.4630580028012, 984.7291994701371, 14387.85612143907, 14564.635884102558, 14829.555113346616, 15067.321970511133, 15295.0, 27812.58281125744, 32927.176820579676, 33647.0, 33774.662253378134, 33985.66014339924, 44046.559534404245, 44997.55002449934, 45898.77050614726, 46218.30672539847, 46607.30089048735, 7281.0, 7445.590492522963, 7506.549607023596, 7647.732329368446, 7700.037495313086, 11588.304701717923, 12234.877651223374, 12349.3825308736, 12412.317322547347, 12415.875841241472, 9995.800083998425, 10362.740931476774, 10532.875353330735, 10799.67600971972, 10850.565977360817, 10212.744681383025, 10391.792164156826, 10536.0, 10608.151347891995, 10691.893081069089, 10880.238383313092, 10884.673459796219, 10971.122310215324, 11058.336499810037, 11229.382383968634, 7060.54106483077, 7082.291770822876, 7349.044624199034, 7469.365103966006, 7484.812879678052, 10203.489825508546, 10464.31981921203, 10791.0, 11002.33985960845, 11034.779304414027], "unit": "score", "name": "jquery.html", "value": 7866.206312984903}, {"lowerIsBetter": false, "replicates": [1338.738945905549, 1447.5874375802896, 1465.0623600895428, 1608.6219738361483, 1759.3314540474619, 6489.123968264289, 7180.71277148914, 7336.669849856756, 7338.3395494405495, 7358.558486490814, 7028.613426261553, 7180.712771489148, 7187.173475050371, 7190.820229494252, 7198.316159964808, 1929.324736342276, 2151.064287035137, 2185.5410363823535, 2199.7250343707037, 2254.966175507369, 2203.6253836847773, 2210.0386331945574, 2211.9004644790944, 2214.070090561968, 2217.4788924602703, 2135.2740068376747, 2188.5951099046647, 2191.22211614876, 2194.550117225973, 2197.165077270635, 2194.2978246960897, 2220.600291947449, 2227.509947811487, 2252.155441709359, 2255.5150642611916, 2181.4873504726374, 2210.767869373725, 2218.3344996500987, 2226.5546890621777, 2235.608768465512, 7461.515001524937, 7513.887291690629, 7521.398288136936, 7535.623218839091, 7553.093628764584, 4330.783460826978, 4431.379606855043, 4432.290833466662, 4434.955650443519, 4448.599626033672, 2826.5336219523756, 2879.84160871152, 2940.6471223453323, 2947.631546056743, 2948.7198716121934, 876.4215617692292, 886.8359353519555, 913.3789023464042, 922.2345453273833, 1736.2534110332551, 10143.695689129338, 10195.49022548877, 10205.489725513695, 10220.948895255551, 10239.18086553074, 3607.3687104756564, 3732.64539868712, 3772.5284339457567, 3774.245150969817, 3873.0898238913833, 7917.327027202752, 7950.4832185907735, 7965.920340796518, 7967.521948683097, 7978.361731061501, 3890.805459727059, 4394.692371533962, 4422.778861056999, 4425.446819147606, 4429.75636339998, 3913.295606790748, 3936.252112098692, 3938.1729836734035, 3942.743721658083, 3993.0, 3243.594550681165, 3316.2538428853795, 3320.037189215149, 3344.3144155448076, 3346.113279980807, 962.9903700963041, 986.6053578568486, 992.3648864726581, 993.895640957689, 996.7009897030862, 1158.6639874436487, 1285.6143157052848, 1287.8583355831038, 1298.2989185839729, 1301.7266374061364, 6971.477139214579, 7001.299870012958, 7019.8596028079155, 7021.29787021304, 7047.68285427157, 434.71526150371557, 453.77764895201113, 456.05823973494626, 456.92917597772396, 458.16613762951107, 5475.917861232085, 5511.3937466878615, 5551.306086739158, 5552.666839989613, 5561.972190139023, 8683.348748843735, 8905.643774248958, 9124.087591240956, 9140.90859091414, 9193.126652967958, 9037.77405564866, 9048.728538143734, 9063.546822658973, 9076.09239076087, 9101.0, 6535.705893234815, 6813.557118787263, 6815.35254150845, 7292.635368231568, 7351.816204594821, 6807.0, 6930.61881596517, 6971.930280697331, 6977.058097157022, 6988.650567471708, 7937.801554961172, 8015.438919275828, 8070.798230044061, 8096.878546821685, 8196.180381961756, 8227.753167404748, 8320.16798320163, 8400.117987611213, 8559.058503564478, 8559.229669329541, 6530.183727034121, 6617.669116544057, 6705.631190284581, 6728.9570116632, 6740.561863478858, 7182.60495672743, 7204.027456293543, 7207.243239459991, 7210.206877243394, 7244.166920803964, 6156.507479401726, 6197.907031394442, 6250.343713910156, 6426.839329016812, 6543.280239173592, 5979.1928089707335, 6303.653299068412, 6410.9038364425505, 6438.581492202992, 6527.0, 6719.025741267586, 6726.630035348103, 6763.188417389944, 6772.627505487246, 6779.389854913082, 6030.7889223876955, 6035.034394496859, 6058.757649694139, 6076.726547305293, 6240.906386404298, 6330.177076979963, 6384.233891932812, 6386.16979792624, 6386.9680651596445, 6394.26465956421], "unit": "score", "name": "mootools.html", "value": 4168.355136021157}, {"lowerIsBetter": false, "replicates": [286.5000573998373, 292.4180880048703, 296.8738286228352, 297.47050250554014, 299.8380874327863, 5803.535717142629, 5929.822105336847, 5934.792282270121, 5943.465088142067, 5999.370066143058, 5786.594938354317, 5818.389069147742, 5839.883202335951, 5847.356790753014, 5922.763089476426, 4219.978900105495, 4273.636740877029, 4387.8025488853, 4388.056567837914, 4395.0, 4378.883384736903, 4389.5390983946545, 4394.780260986954, 4400.537943515917, 4403.119376124771, 4338.392625032482, 4348.434703488542, 4353.73877567347, 4363.978180109111, 4367.148406060819, 4191.55988621195, 4232.703710740249, 4263.936040959357, 4327.415798867144, 4355.651547876162, 3686.1706116123923, 3688.6495782900583, 3694.8891533254045, 3701.2967536168044, 3721.218544105741, 5564.666120032811, 5565.332160140809, 5568.777248910039, 5573.219749235111, 5582.078956972095, 5041.344625198737, 5043.84868453947, 5050.2929589857085, 5050.974745126287, 5057.595392368602, 6187.257529096492, 6194.225721784777, 6198.659073750942, 6200.348963358872, 6201.410865967726, 3997.4603428537357, 4119.114390406047, 4124.8143833527265, 4127.050778320973, 4129.0, 6452.6772011737485, 6505.381988711065, 6532.967335163294, 6537.280899101095, 6547.0, 4133.090720041586, 4136.91726165481, 4138.503379594468, 4140.792960351971, 4141.585841415835, 4153.0, 4161.542230354658, 4166.291730405838, 4169.854055108117, 4189.7695626740215, 4982.10322142018, 4989.3264409305, 4991.201407774739, 4995.875103122378, 4996.325496057985, 6287.245530536365, 6288.496920246369, 6291.874162516816, 6292.685365731695, 6296.811095667137, 1440.7550716378241, 1458.6645071633584, 1488.4269556220934, 1489.3819065088085, 1491.686745783376, 904.8552231642906, 953.3755390219418, 966.9323147379756, 972.1833659725722, 976.6776963601994, 5941.7623295067715, 6088.299845517734, 6093.664848433379, 6095.908561371583, 6109.0, 6496.740130394731, 6502.869942601122, 6520.641364724891, 6570.835729106715, 6576.671166441754, 6073.635581865102, 6076.058210977306, 6078.1186727924205, 6081.939180608226, 6086.1175129606845, 3457.4640930655787, 3489.9302013959577, 3490.7730997485082, 3495.2834668892815, 3495.493153492729, 6644.60132392058, 6842.897356539655, 6879.208890977501, 6907.516473846883, 6915.792526224222, 6607.041978913031, 6633.436157926631, 6643.3391652086975, 6650.73397064112, 6651.0, 6879.862402751917, 6885.139357580302, 6889.104416425833, 6891.310868913069, 6898.0, 6459.547831651739, 6470.288268290578, 6477.546571739933, 6488.545801793829, 6491.221053473613, 6265.185525881789, 6432.45324147434, 6441.0, 6442.645654489048, 6473.417392434703, 6880.036794848826, 6884.552504087218, 6904.758333458506, 6920.861582768417, 6927.272636373108, 4216.620504154641, 4246.915061698687, 4249.575042495726, 4252.149570086057, 4252.574742525722, 6487.286398496256, 6491.350864913471, 6491.837704057436, 6502.284748677736, 6505.642189679613, 6296.464800491826, 6319.46284565817, 6372.58578192416, 6376.808695739135, 6378.712957916812, 6158.398816307703, 6309.085182648399, 6310.810675679737, 6318.08387783778, 6342.270638876588, 6185.195924529782, 6203.4416902479, 6204.565680402328, 6206.162168107247, 6218.844528886814, 6321.620702757849, 6323.430891219812, 6348.0, 6349.238091429058, 6353.523485738496, 5944.881102377842, 6058.848528786815, 6191.690415479298, 6207.81376558704, 6211.472024877936], "unit": "score", "name": "prototype.html", "value": 4634.766236964388}, {"lowerIsBetter": false, "replicates": [714.1822613107992, 755.7317152410894, 760.1448370583093, 762.4738930138208, 800.5636927874308, 13734.244616546086, 14017.649558761035, 14051.086679365846, 14055.648608784786, 14057.718845623094, 14465.78301325481, 14655.706885862302, 14683.853161468409, 14686.853131468682, 14708.043977141479, 679.6771533521562, 817.5871185051556, 821.8191997760483, 825.1294883897516, 825.6449726617552, 803.0483876606211, 823.2179429541959, 826.1119296755982, 826.243986752121, 826.4917075998247, 841.6212704283066, 847.7541512961234, 850.4429598612918, 854.3250831842837, 854.7136709202393, 703.6657587645827, 838.5555655502593, 842.321930845669, 846.3525403066659, 847.5338563789891, 626.0, 626.8777588370269, 627.2567008095422, 627.4509803921569, 627.5638431290255, 14046.087004344685, 14089.577312680534, 14108.858911410856, 14119.78820317696, 14128.293585320693, 12157.209781364183, 12416.875831241663, 12511.436985335682, 12707.110502264844, 12954.80567791484, 9253.953730231373, 9364.110409511086, 9484.573194206278, 9524.14282714552, 9651.034896510362, 3637.7271704621994, 3662.8351724172476, 3686.3733165361955, 3770.170562476278, 3772.2078363543687, 49951.75024124856, 50168.49831501711, 50240.0, 50396.24405633919, 50404.24393634099, 9611.759706007266, 9788.363756355815, 9800.411975281364, 9918.80162396748, 10177.745556361002, 18027.098645067694, 18121.275148994155, 18138.727919081226, 18187.727184092248, 18219.54451138732, 7516.924830751732, 7521.849563008709, 7764.922350776533, 7800.336971357385, 7845.882311765328, 4030.4760381150263, 4072.531658859269, 4110.403991421227, 4155.335146376626, 4199.853005144805, 2859.785516086302, 2869.4548035873117, 2871.425714857037, 2876.8273903565855, 2889.581010753429, 513.9897202056013, 515.5025400488547, 520.9817656382085, 525.9105951988095, 534.0200731657375, 512.5207930584841, 572.7193675099255, 621.6984762390238, 632.908228306893, 650.7104338569292, 7807.414443916729, 7996.0, 8031.277185053374, 8066.838663226703, 8242.381821363422, 466.7129715225112, 549.9752511136928, 615.7198474694003, 639.2329204954074, 653.5229282623711, 3794.962050379461, 3858.8456461741216, 3859.054531639766, 3935.9016024599614, 3985.4221137934837, 55764.44235557593, 55873.1619025715, 55970.16044759332, 56001.71999139978, 58391.416085839446, 47781.28328075082, 47826.28260576094, 48401.51598484041, 48406.0, 48564.75717621389, 43769.78115109404, 43908.38961909017, 43923.121537569066, 44157.0, 44894.77552612216, 7497.887531687138, 7633.923660763321, 7933.801654958672, 7959.801004974922, 8094.069182043905, 32472.53873575742, 33314.33371332511, 33341.499877501374, 33641.327173456884, 33834.8308258467, 39688.80155599319, 39833.60166398299, 42150.36774448447, 43913.12173756571, 44865.77567112144, 9997.300188986992, 10045.347052441568, 10373.429461379697, 10567.365958042543, 10603.584058961622, 10347.172226221734, 10475.633352832614, 10602.575896964036, 11036.944815275872, 11045.889541104487, 10381.273310868166, 10624.150067994387, 10915.945420273165, 10951.233413660968, 10992.340459572451, 9774.706758797247, 9778.364406313567, 9925.619916781789, 10081.647142349982, 10239.846402303823, 10179.0, 10478.580856765644, 10775.191860610328, 10809.027187553158, 10829.025387715143, 9218.677346292847, 9220.354575179674, 9431.481268530297, 9436.969714970184, 9695.0, 8168.305694016075, 8933.687320943736, 9097.317701172306, 9149.542522873697, 9187.402818816756], "unit": "score", "name": "yui.html", "value": 6091.429328847784}], "name": "dromaeo_css", "value": 6545.696013950261}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 106.0, 111.0, 110.0, 110.0, 101.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [153.0, 125.0, 155.0, 167.0, 128.0, 163.0, 156.0, 132.0, 179.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 163.0, 162.0, 161.0, 160.0, 161.0, 163.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 95.0, 94.0, 74.0, 72.0, 71.0, 101.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 153.0, 96.0, 96.0, 96.0, 149.0, 96.0, 95.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 112.3}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.5}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 56.0, 55.0, 56.0, 56.0, 57.0, 58.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 74.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 82.0, 82.0, 82.0, 84.0, 82.0, 83.0, 95.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 123.0, 117.0, 115.0, 119.0, 129.0, 117.0, 121.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.8}, {"lowerIsBetter": true, "replicates": [153.0, 146.0, 152.0, 154.0, 152.0, 143.0, 151.0, 152.0, 161.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.6}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 70.0, 69.0, 69.0, 68.0, 72.0, 69.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1519.9999999999998}]} 17:47:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1520.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6545.70"}}} 17:47:11 INFO - Return code: 0 17:47:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:47:11 INFO - # TBPL SUCCESS # 17:47:11 INFO - Running post-action listener: _resource_record_post_action 17:47:11 INFO - Running post-run listener: _resource_record_post_run 17:47:12 INFO - Total resource usage - Wall time: 1271s; CPU: 13.0%; Read bytes: 0; Write bytes: 551247872; Read time: 0; Write time: 7616984 17:47:12 INFO - install - Wall time: 27s; CPU: 24.0%; Read bytes: 0; Write bytes: 158887936; Read time: 0; Write time: 2240212 17:47:12 INFO - run-tests - Wall time: 1244s; CPU: 13.0%; Read bytes: 0; Write bytes: 386588672; Read time: 0; Write time: 5320572 17:47:12 INFO - Running post-run listener: _upload_blobber_files 17:47:12 INFO - Blob upload gear active. 17:47:12 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:47:12 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 17:47:12 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'] 17:47:12 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 17:47:12 INFO - (blobuploader) - INFO - Open directory for files ... 17:47:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:47:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:47:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:13 INFO - (blobuploader) - INFO - Done attempting. 17:47:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:47:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:47:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:14 INFO - (blobuploader) - INFO - Done attempting. 17:47:14 INFO - (blobuploader) - INFO - Iteration through files over. 17:47:14 INFO - Return code: 0 17:47:14 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:47:14 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:47:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bf4cc234df2396e8a89f90179d4bdd5cf7e8c9d93a7a4dc74a1f38fd5c34ee47cf3f616bc40017b3bdcb969d2c2692ba9e48ed33464a4176d3efbbc3022bfbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c8a4d829688ebcf151c1c6f32477438151d4b6a5d2ed30a12b5d0c5122c258e90c3ea712de8f57c094a5c76d860a44d780cec7621662ac5fe99896de0c9c8e5"} 17:47:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:47:14 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:47:14 INFO - Contents: 17:47:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bf4cc234df2396e8a89f90179d4bdd5cf7e8c9d93a7a4dc74a1f38fd5c34ee47cf3f616bc40017b3bdcb969d2c2692ba9e48ed33464a4176d3efbbc3022bfbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c8a4d829688ebcf151c1c6f32477438151d4b6a5d2ed30a12b5d0c5122c258e90c3ea712de8f57c094a5c76d860a44d780cec7621662ac5fe99896de0c9c8e5"} 17:47:14 INFO - Running post-run listener: copy_logs_to_upload_dir 17:47:14 INFO - Copying logs to upload dir... 17:47:14 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:47:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1311.648513 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2016-02-29 17:47:14.039613) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 17:47:14.043410) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940 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/0bf4cc234df2396e8a89f90179d4bdd5cf7e8c9d93a7a4dc74a1f38fd5c34ee47cf3f616bc40017b3bdcb969d2c2692ba9e48ed33464a4176d3efbbc3022bfbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c8a4d829688ebcf151c1c6f32477438151d4b6a5d2ed30a12b5d0c5122c258e90c3ea712de8f57c094a5c76d860a44d780cec7621662ac5fe99896de0c9c8e5"} build_url:https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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/0bf4cc234df2396e8a89f90179d4bdd5cf7e8c9d93a7a4dc74a1f38fd5c34ee47cf3f616bc40017b3bdcb969d2c2692ba9e48ed33464a4176d3efbbc3022bfbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c8a4d829688ebcf151c1c6f32477438151d4b6a5d2ed30a12b5d0c5122c258e90c3ea712de8f57c094a5c76d860a44d780cec7621662ac5fe99896de0c9c8e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 17:47:14.072267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:47:14.072607) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1456795520.582447-476716940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:47:14.154683) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 17:47:14.155033) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 17:47:14.155403) ========= ========= Total master_lag: 0.32 =========