builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1455951236.44 results: success (0) buildid: 20160219203515 builduid: 7fde895ac17e4448a9e727b525e94035 revision: ba617d51a0fdc41e619302fd750376aeaabf86ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.435896) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.436354) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.436638) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006668 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.460447) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.460779) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.473743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.474079) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.522899) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.523183) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.523547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.523818) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-19 22:53:56-- 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% 88.5M=0s 2016-02-19 22:53:57 (88.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154531 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.690515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.690825) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017942 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.739788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:56.740095) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ba617d51a0fdc41e619302fd750376aeaabf86ad --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 ba617d51a0fdc41e619302fd750376aeaabf86ad --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-19 22:53:57,247 truncating revision to first 12 chars 2016-02-19 22:53:57,247 Setting DEBUG logging. 2016-02-19 22:53:57,247 attempt 1/10 2016-02-19 22:53:57,247 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ba617d51a0fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-19 22:53:57,504 unpacking tar archive at: fx-team-ba617d51a0fd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554397 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:57.310810) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:57.311155) ========= echo ba617d51a0fdc41e619302fd750376aeaabf86ad in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ba617d51a0fdc41e619302fd750376aeaabf86ad'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ba617d51a0fdc41e619302fd750376aeaabf86ad program finished with exit code 0 elapsedTime=0.004016 script_repo_revision: 'ba617d51a0fdc41e619302fd750376aeaabf86ad' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:57.360010) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:57.360331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 22:53:57.370031) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-02-19 22:53:57.370408) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:53:57 INFO - MultiFileLogger online at 20160219 22:53:57 in /builds/slave/test-pgo 22:53:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:53:57 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:53:57 INFO - {'append_to_log': False, 22:53:57 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:53:57 INFO - 'blob_upload_branch': 'Fx-Team', 22:53:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:53:57 INFO - 'branch': 'Fx-Team', 22:53:57 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:57 INFO - 'config_files': ('talos/linux_config.py',), 22:53:57 INFO - 'default_actions': ('clobber', 22:53:57 INFO - 'read-buildbot-config', 22:53:57 INFO - 'download-and-extract', 22:53:57 INFO - 'populate-webroot', 22:53:57 INFO - 'create-virtualenv', 22:53:57 INFO - 'install', 22:53:57 INFO - 'run-tests'), 22:53:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:57 INFO - 'download_minidump_stackwalk': True, 22:53:57 INFO - 'download_symbols': 'ondemand', 22:53:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:57 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:57 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:57 INFO - 'installer_path': 'installer.exe', 22:53:57 INFO - 'log_level': 'info', 22:53:57 INFO - 'log_name': 'talos', 22:53:57 INFO - 'log_to_console': True, 22:53:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:53:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:53:57 INFO - 'opt_config_files': (), 22:53:57 INFO - 'pip_index': False, 22:53:57 INFO - 'sps_profile': False, 22:53:57 INFO - 'sps_profile_interval': 0, 22:53:57 INFO - 'suite': 'dromaeojs-e10s', 22:53:57 INFO - 'system_bits': '32', 22:53:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:57 INFO - 'title': 'talos-linux64-ix-001', 22:53:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:57 INFO - 'use_talos_json': True, 22:53:57 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:53:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:57 INFO - 'work_dir': 'build'} 22:53:57 INFO - ##### 22:53:57 INFO - ##### Running clobber step. 22:53:57 INFO - ##### 22:53:57 INFO - Running pre-action listener: _resource_record_pre_action 22:53:57 INFO - Running main action method: clobber 22:53:57 INFO - rmtree: /builds/slave/test-pgo/build 22:53:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:53:58 INFO - Running post-action listener: _resource_record_post_action 22:53:58 INFO - ##### 22:53:58 INFO - ##### Running read-buildbot-config step. 22:53:58 INFO - ##### 22:53:58 INFO - Running pre-action listener: _resource_record_pre_action 22:53:58 INFO - Running main action method: read_buildbot_config 22:53:58 INFO - Using buildbot properties: 22:53:58 INFO - { 22:53:58 INFO - "project": "", 22:53:58 INFO - "product": "firefox", 22:53:58 INFO - "script_repo_revision": "production", 22:53:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:53:58 INFO - "repository": "", 22:53:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:53:58 INFO - "buildid": "20160219203515", 22:53:58 INFO - "pgo_build": "True", 22:53:58 INFO - "basedir": "/builds/slave/test-pgo", 22:53:58 INFO - "buildnumber": 183, 22:53:58 INFO - "slavename": "talos-linux64-ix-001", 22:53:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:53:58 INFO - "platform": "ubuntu64_hw", 22:53:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:53:58 INFO - "branch": "fx-team", 22:53:58 INFO - "repo_path": "integration/fx-team", 22:53:58 INFO - "revision": "ba617d51a0fdc41e619302fd750376aeaabf86ad", 22:53:58 INFO - "stage_platform": "linux64-pgo", 22:53:58 INFO - "builduid": "7fde895ac17e4448a9e727b525e94035", 22:53:58 INFO - "slavebuilddir": "test" 22:53:58 INFO - } 22:53:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:53:58 INFO - Running post-action listener: _resource_record_post_action 22:53:58 INFO - ##### 22:53:58 INFO - ##### Running download-and-extract step. 22:53:58 INFO - ##### 22:53:58 INFO - Running pre-action listener: _resource_record_pre_action 22:53:58 INFO - Running main action method: download_and_extract 22:53:58 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:58 INFO - https://queue.taskcluster.net/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:53:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/test_packages.json 22:53:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/test_packages.json 22:53:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:53:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:53:59 INFO - Downloaded 1448 bytes. 22:53:59 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:53:59 INFO - Using the following test package requirements: 22:53:59 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:59 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:53:59 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:53:59 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:59 INFO - u'jsshell-linux-x86_64.zip'], 22:53:59 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:53:59 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:59 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:53:59 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:53:59 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:53:59 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:59 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:53:59 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:53:59 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')]} 22:53:59 INFO - https://queue.taskcluster.net/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/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 22:53:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/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 22:54:01 INFO - Downloaded 23349825 bytes. 22:54:01 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'] 22:54:01 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 22:54:02 INFO - Return code: 0 22:54:02 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 22:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:02 INFO - https://queue.taskcluster.net/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:54:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:54:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:54:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/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 22:54:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/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 22:54:10 INFO - Downloaded 23349825 bytes. 22:54:10 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'] 22:54:10 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 22:54:12 INFO - Return code: 0 22:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:12 INFO - https://queue.taskcluster.net/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:54:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/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 22:54:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/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 22:54:13 INFO - Downloaded 10707015 bytes. 22:54:13 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'] 22:54:13 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 22:54:13 INFO - Return code: 0 22:54:13 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')]} 22:54:13 INFO - https://queue.taskcluster.net/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:54:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/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 22:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CmaKQE_LQVuMiZrW3WyF_g/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 22:54:15 INFO - Downloaded 56567054 bytes. 22:54:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:15 INFO - mkdir: /builds/slave/test-pgo/properties 22:54:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:54:15 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:54:15 INFO - Contents: 22:54:15 INFO - build_url:https://queue.taskcluster.net/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:15 INFO - Running post-action listener: _resource_record_post_action 22:54:15 INFO - Running post-action listener: set_extra_try_arguments 22:54:15 INFO - ##### 22:54:15 INFO - ##### Running populate-webroot step. 22:54:15 INFO - ##### 22:54:15 INFO - Running pre-action listener: _resource_record_pre_action 22:54:15 INFO - Running main action method: populate_webroot 22:54:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:54:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:54:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:54:15 INFO - '--tppagecycles', 22:54:15 INFO - '7'], 22:54:15 INFO - 'tests': ['tsvgm']}}, 22:54:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:54:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:54:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:54:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:54:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:54:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:54:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:15 INFO - 'talos_options': ['--e10s'], 22:54:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:15 INFO - 'tests': ['damp', 'tps']}, 22:54:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:15 INFO - 'talos_options': ['--e10s'], 22:54:15 INFO - 'tests': ['damp', 'tps']}, 22:54:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:54:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:54:15 INFO - 'other': {'tests': ['a11yr', 22:54:15 INFO - 'ts_paint', 22:54:15 INFO - 'tpaint', 22:54:15 INFO - 'sessionrestore', 22:54:15 INFO - 'sessionrestore_no_auto_restore']}, 22:54:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:54:15 INFO - 'tests': ['a11yr', 22:54:15 INFO - 'ts_paint', 22:54:15 INFO - 'tpaint', 22:54:15 INFO - 'sessionrestore', 22:54:15 INFO - 'sessionrestore_no_auto_restore']}, 22:54:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:54:15 INFO - 'tests': ['a11yr', 22:54:15 INFO - 'ts_paint', 22:54:15 INFO - 'tpaint', 22:54:15 INFO - 'sessionrestore', 22:54:15 INFO - 'sessionrestore_no_auto_restore']}, 22:54:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:54:15 INFO - 'tests': ['a11yr', 22:54:15 INFO - 'ts_paint', 22:54:15 INFO - 'tpaint', 22:54:15 INFO - 'sessionrestore', 22:54:15 INFO - 'sessionrestore_no_auto_restore']}, 22:54:15 INFO - 'other_l64': {'tests': ['a11yr', 22:54:15 INFO - 'ts_paint', 22:54:15 INFO - 'tpaint', 22:54:15 INFO - 'sessionrestore', 22:54:15 INFO - 'sessionrestore_no_auto_restore']}, 22:54:15 INFO - 'other_nol64': {'tests': ['a11yr', 22:54:15 INFO - 'ts_paint', 22:54:15 INFO - 'tpaint', 22:54:15 INFO - 'sessionrestore', 22:54:15 INFO - 'sessionrestore_no_auto_restore']}, 22:54:15 INFO - 'svgr': {'tests': ['tsvgx', 22:54:15 INFO - 'tsvgr_opacity', 22:54:15 INFO - 'tart', 22:54:15 INFO - 'tscrollx', 22:54:15 INFO - 'cart']}, 22:54:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:54:15 INFO - 'tests': ['tsvgx', 22:54:15 INFO - 'tsvgr_opacity', 22:54:15 INFO - 'tart', 22:54:15 INFO - 'tscrollx', 22:54:15 INFO - 'cart']}, 22:54:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:15 INFO - 'tests': ['tp5o']}, 22:54:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:15 INFO - 'talos_options': ['--e10s'], 22:54:15 INFO - 'tests': ['tp5o']}, 22:54:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:15 INFO - 'talos_options': ['--xperf_path', 22:54:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:15 INFO - 'tests': ['tp5n']}, 22:54:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:15 INFO - 'talos_options': ['--e10s', 22:54:15 INFO - '--xperf_path', 22:54:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:15 INFO - 'tests': ['tp5n']}}, 22:54:15 INFO - 'talos.zip': {'path': '', 22:54:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:54:15 INFO - Running post-action listener: _resource_record_post_action 22:54:15 INFO - ##### 22:54:15 INFO - ##### Running create-virtualenv step. 22:54:15 INFO - ##### 22:54:15 INFO - Running pre-action listener: _resource_record_pre_action 22:54:15 INFO - Running main action method: create_virtualenv 22:54:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:54:15 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 22:54:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:54:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:54:15 INFO - Using real prefix '/usr' 22:54:15 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:54:16 INFO - Installing distribute.............................................................................................................................................................................................done. 22:54:18 INFO - Installing pip.................done. 22:54:18 INFO - Return code: 0 22:54:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:54:18 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')]} 22:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:18 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')]} 22:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:18 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 0x7ff60f5c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19be670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8c0>, '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 0x1a4e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ec50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', '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 22:54:18 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 22:54:18 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 22:54:18 INFO - Using env: {'DISPLAY': ':0', 22:54:18 INFO - 'HOME': '/home/cltbld', 22:54:18 INFO - 'LANG': 'en_US.UTF-8', 22:54:18 INFO - 'LANGUAGE': 'en_US:en', 22:54:18 INFO - 'LOGNAME': 'cltbld', 22:54:18 INFO - 'MAIL': '/var/mail/cltbld', 22:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:18 INFO - 'MOZ_NO_REMOTE': '1', 22:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:18 INFO - 'NO_EM_RESTART': '1', 22:54:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:18 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:18 INFO - 'SHELL': '/bin/bash', 22:54:18 INFO - 'SHLVL': '1', 22:54:18 INFO - 'TERM': 'linux', 22:54:18 INFO - 'TMOUT': '86400', 22:54:18 INFO - 'USER': 'cltbld', 22:54:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', 22:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:18 INFO - '_': '/tools/buildbot/bin/python'} 22:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:18 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 22:54:18 INFO - Cleaning up... 22:54:18 INFO - Return code: 0 22:54:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:54:18 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')]} 22:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:18 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')]} 22:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:18 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 0x7ff60f5c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19be670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8c0>, '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 0x1a4e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ec50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', '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 22:54:18 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 22:54:18 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 22:54:18 INFO - Using env: {'DISPLAY': ':0', 22:54:18 INFO - 'HOME': '/home/cltbld', 22:54:18 INFO - 'LANG': 'en_US.UTF-8', 22:54:18 INFO - 'LANGUAGE': 'en_US:en', 22:54:18 INFO - 'LOGNAME': 'cltbld', 22:54:18 INFO - 'MAIL': '/var/mail/cltbld', 22:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:18 INFO - 'MOZ_NO_REMOTE': '1', 22:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:18 INFO - 'NO_EM_RESTART': '1', 22:54:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:18 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:18 INFO - 'SHELL': '/bin/bash', 22:54:18 INFO - 'SHLVL': '1', 22:54:18 INFO - 'TERM': 'linux', 22:54:18 INFO - 'TMOUT': '86400', 22:54:18 INFO - 'USER': 'cltbld', 22:54:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', 22:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:18 INFO - '_': '/tools/buildbot/bin/python'} 22:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:18 INFO - Downloading/unpacking psutil>=0.7.1 22:54:18 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 22:54:18 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 22:54:18 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 22:54:18 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 22:54:18 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 22:54:18 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 22:54:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:54:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:20 INFO - Installing collected packages: psutil 22:54:20 INFO - Running setup.py install for psutil 22:54:20 INFO - building 'psutil._psutil_linux' extension 22:54:20 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 22:54:21 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 22:54:21 INFO - building 'psutil._psutil_posix' extension 22:54:21 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 22:54:21 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 22:54:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:21 INFO - Successfully installed psutil 22:54:21 INFO - Cleaning up... 22:54:21 INFO - Return code: 0 22:54:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:21 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 0x7ff60f5c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19be670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8c0>, '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 0x1a4e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ec50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', '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 22:54:21 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 22:54:21 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 22:54:21 INFO - Using env: {'DISPLAY': ':0', 22:54:21 INFO - 'HOME': '/home/cltbld', 22:54:21 INFO - 'LANG': 'en_US.UTF-8', 22:54:21 INFO - 'LANGUAGE': 'en_US:en', 22:54:21 INFO - 'LOGNAME': 'cltbld', 22:54:21 INFO - 'MAIL': '/var/mail/cltbld', 22:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:21 INFO - 'MOZ_NO_REMOTE': '1', 22:54:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:21 INFO - 'NO_EM_RESTART': '1', 22:54:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:21 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:21 INFO - 'SHELL': '/bin/bash', 22:54:21 INFO - 'SHLVL': '1', 22:54:21 INFO - 'TERM': 'linux', 22:54:21 INFO - 'TMOUT': '86400', 22:54:21 INFO - 'USER': 'cltbld', 22:54:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', 22:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:21 INFO - '_': '/tools/buildbot/bin/python'} 22:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:54:21 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 22:54:21 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 22:54:21 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 22:54:21 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 22:54:21 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 22:54:21 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 22:54:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:54:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:54:23 INFO - Installing collected packages: mozsystemmonitor 22:54:23 INFO - Running setup.py install for mozsystemmonitor 22:54:23 INFO - Successfully installed mozsystemmonitor 22:54:23 INFO - Cleaning up... 22:54:23 INFO - Return code: 0 22:54:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:54: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')]} 22:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff60f5c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19be670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8c0>, '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 0x1a4e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ec50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', '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 22:54:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:54:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:54:23 INFO - Using env: {'DISPLAY': ':0', 22:54:23 INFO - 'HOME': '/home/cltbld', 22:54:23 INFO - 'LANG': 'en_US.UTF-8', 22:54:23 INFO - 'LANGUAGE': 'en_US:en', 22:54:23 INFO - 'LOGNAME': 'cltbld', 22:54:23 INFO - 'MAIL': '/var/mail/cltbld', 22:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:23 INFO - 'MOZ_NO_REMOTE': '1', 22:54:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:23 INFO - 'NO_EM_RESTART': '1', 22:54:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:23 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:23 INFO - 'SHELL': '/bin/bash', 22:54:23 INFO - 'SHLVL': '1', 22:54:23 INFO - 'TERM': 'linux', 22:54:23 INFO - 'TMOUT': '86400', 22:54:23 INFO - 'USER': 'cltbld', 22:54:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', 22:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:23 INFO - '_': '/tools/buildbot/bin/python'} 22:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:23 INFO - Downloading/unpacking blobuploader==1.2.4 22:54:23 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 22:54:23 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 22:54:23 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 22:54:23 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 22:54:23 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 22:54:23 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 22:54:25 INFO - Downloading blobuploader-1.2.4.tar.gz 22:54:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:54:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:54:25 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 22:54:25 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 22:54:25 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 22:54:25 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 22:54:25 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 22:54:25 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 22:54:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:54:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:54:26 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 22:54:26 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 22:54:26 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 22:54:26 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 22:54:26 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 22:54:26 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 22:54:26 INFO - Downloading docopt-0.6.1.tar.gz 22:54:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:54:26 INFO - Installing collected packages: blobuploader, requests, docopt 22:54:26 INFO - Running setup.py install for blobuploader 22:54:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:54:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:54:26 INFO - Running setup.py install for requests 22:54:26 INFO - Running setup.py install for docopt 22:54:26 INFO - Successfully installed blobuploader requests docopt 22:54:26 INFO - Cleaning up... 22:54:26 INFO - Return code: 0 22:54:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54: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')]} 22:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:26 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 0x7ff60f5c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19be670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8c0>, '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 0x1a4e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ec50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', '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 22:54:26 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 22:54:26 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 22:54:26 INFO - Using env: {'DISPLAY': ':0', 22:54:26 INFO - 'HOME': '/home/cltbld', 22:54:26 INFO - 'LANG': 'en_US.UTF-8', 22:54:26 INFO - 'LANGUAGE': 'en_US:en', 22:54:26 INFO - 'LOGNAME': 'cltbld', 22:54:26 INFO - 'MAIL': '/var/mail/cltbld', 22:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:26 INFO - 'MOZ_NO_REMOTE': '1', 22:54:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:26 INFO - 'NO_EM_RESTART': '1', 22:54:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:26 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:26 INFO - 'SHELL': '/bin/bash', 22:54:26 INFO - 'SHLVL': '1', 22:54:26 INFO - 'TERM': 'linux', 22:54:26 INFO - 'TMOUT': '86400', 22:54:26 INFO - 'USER': 'cltbld', 22:54:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', 22:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:26 INFO - '_': '/tools/buildbot/bin/python'} 22:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:27 INFO - Running setup.py (path:/tmp/pip-ChLqFX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:27 INFO - Running setup.py (path:/tmp/pip-8cPSCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:27 INFO - Running setup.py (path:/tmp/pip-vX6anj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:27 INFO - Running setup.py (path:/tmp/pip-GIz5MW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:27 INFO - Running setup.py (path:/tmp/pip-qNuZvT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:27 INFO - Running setup.py (path:/tmp/pip-Il23D0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:27 INFO - Running setup.py (path:/tmp/pip-06akGt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:27 INFO - Running setup.py (path:/tmp/pip-mMIzNP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:27 INFO - Running setup.py (path:/tmp/pip-KOxT4L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:27 INFO - Running setup.py (path:/tmp/pip-INsh8K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:27 INFO - Running setup.py (path:/tmp/pip-ARv3TF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:27 INFO - Running setup.py (path:/tmp/pip-EilO8m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:27 INFO - Running setup.py (path:/tmp/pip-_u0_Bx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:28 INFO - Running setup.py (path:/tmp/pip-XjtQol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:28 INFO - Running setup.py (path:/tmp/pip-hbNHJc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:28 INFO - Running setup.py (path:/tmp/pip-WuDCZW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:28 INFO - Running setup.py (path:/tmp/pip-LIDKlj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:54:28 INFO - Running setup.py install for manifestparser 22:54:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:54:28 INFO - Running setup.py install for mozcrash 22:54:28 INFO - Running setup.py install for mozdebug 22:54:28 INFO - Running setup.py install for mozdevice 22:54:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:54:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:54:28 INFO - Running setup.py install for mozfile 22:54:28 INFO - Running setup.py install for mozhttpd 22:54:28 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:54:28 INFO - Running setup.py install for mozinfo 22:54:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:54:29 INFO - Running setup.py install for mozInstall 22:54:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:54:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:54:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:54:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:54:29 INFO - Running setup.py install for mozleak 22:54:29 INFO - Running setup.py install for mozlog 22:54:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:54:29 INFO - Running setup.py install for moznetwork 22:54:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:54:29 INFO - Running setup.py install for mozprocess 22:54:29 INFO - Running setup.py install for mozprofile 22:54:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:54:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:54:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:54:29 INFO - Running setup.py install for mozrunner 22:54:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:54:29 INFO - Running setup.py install for mozscreenshot 22:54:29 INFO - Running setup.py install for moztest 22:54:29 INFO - Running setup.py install for mozversion 22:54:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:54:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:54:30 INFO - Cleaning up... 22:54:30 INFO - Return code: 0 22:54:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:30 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 0x7ff60f5c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19be670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8c0>, '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 0x1a4e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ec50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', '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 22:54:30 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 22:54:30 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 22:54:30 INFO - Using env: {'DISPLAY': ':0', 22:54:30 INFO - 'HOME': '/home/cltbld', 22:54:30 INFO - 'LANG': 'en_US.UTF-8', 22:54:30 INFO - 'LANGUAGE': 'en_US:en', 22:54:30 INFO - 'LOGNAME': 'cltbld', 22:54:30 INFO - 'MAIL': '/var/mail/cltbld', 22:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:30 INFO - 'MOZ_NO_REMOTE': '1', 22:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:30 INFO - 'NO_EM_RESTART': '1', 22:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:30 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:30 INFO - 'SHELL': '/bin/bash', 22:54:30 INFO - 'SHLVL': '1', 22:54:30 INFO - 'TERM': 'linux', 22:54:30 INFO - 'TMOUT': '86400', 22:54:30 INFO - 'USER': 'cltbld', 22:54:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', 22:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:30 INFO - '_': '/tools/buildbot/bin/python'} 22:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:30 INFO - Running setup.py (path:/tmp/pip-reAfhG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:30 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)) 22:54:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:30 INFO - Running setup.py (path:/tmp/pip-LfDzDA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:30 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)) 22:54:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:30 INFO - Running setup.py (path:/tmp/pip-R0JiEH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:30 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)) 22:54:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:30 INFO - Running setup.py (path:/tmp/pip-ufH7ca-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:30 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)) 22:54:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:30 INFO - Running setup.py (path:/tmp/pip-Lkck6i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:30 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)) 22:54:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:30 INFO - Running setup.py (path:/tmp/pip-_0qJWX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:30 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)) 22:54:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:30 INFO - Running setup.py (path:/tmp/pip-W7WLUI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:30 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)) 22:54:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:30 INFO - Running setup.py (path:/tmp/pip-R8FsFd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:30 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)) 22:54:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:30 INFO - Running setup.py (path:/tmp/pip-60k_H0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:30 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)) 22:54:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:30 INFO - Running setup.py (path:/tmp/pip-wy7xMF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:31 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)) 22:54:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:31 INFO - Running setup.py (path:/tmp/pip-Ty0VbA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:31 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)) 22:54:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:31 INFO - Running setup.py (path:/tmp/pip-Mj5SR9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:31 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)) 22:54:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:31 INFO - Running setup.py (path:/tmp/pip-sks1nV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:31 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)) 22:54:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:31 INFO - Running setup.py (path:/tmp/pip-SeDtbc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:31 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)) 22:54:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:31 INFO - Running setup.py (path:/tmp/pip-as9cpr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:31 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)) 22:54:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:31 INFO - Running setup.py (path:/tmp/pip-n53WnN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:31 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)) 22:54:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:31 INFO - Running setup.py (path:/tmp/pip-7167rN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:31 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)) 22:54:31 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)) 22:54:31 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)) 22:54:31 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)) 22:54:31 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)) 22:54:31 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)) 22:54:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:33 INFO - Downloading blessings-1.6.tar.gz 22:54:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:54:33 INFO - Installing collected packages: blessings 22:54:33 INFO - Running setup.py install for blessings 22:54:33 INFO - Successfully installed blessings 22:54:33 INFO - Cleaning up... 22:54:33 INFO - Return code: 0 22:54:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:54:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:54:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:54:33 INFO - Reading from file tmpfile_stdout 22:54:33 INFO - Current package versions: 22:54:33 INFO - argparse == 1.2.1 22:54:33 INFO - blessings == 1.6 22:54:33 INFO - blobuploader == 1.2.4 22:54:33 INFO - docopt == 0.6.1 22:54:33 INFO - manifestparser == 1.1 22:54:33 INFO - mozInstall == 1.12 22:54:33 INFO - mozcrash == 0.16 22:54:33 INFO - mozdebug == 0.1 22:54:33 INFO - mozdevice == 0.48 22:54:33 INFO - mozfile == 1.2 22:54:33 INFO - mozhttpd == 0.7 22:54:33 INFO - mozinfo == 0.9 22:54:33 INFO - mozleak == 0.1 22:54:33 INFO - mozlog == 3.1 22:54:33 INFO - moznetwork == 0.27 22:54:33 INFO - mozprocess == 0.22 22:54:33 INFO - mozprofile == 0.28 22:54:33 INFO - mozrunner == 6.11 22:54:33 INFO - mozscreenshot == 0.1 22:54:33 INFO - mozsystemmonitor == 0.0 22:54:33 INFO - moztest == 0.7 22:54:33 INFO - mozversion == 1.4 22:54:33 INFO - psutil == 3.1.1 22:54:33 INFO - requests == 1.2.3 22:54:33 INFO - wsgiref == 0.1.2 22:54:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:33 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 0x7ff60f5c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19be670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8c0>, '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 0x1a4e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ec50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', '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 22:54:33 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 22:54:33 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 22:54:33 INFO - Using env: {'DISPLAY': ':0', 22:54:33 INFO - 'HOME': '/home/cltbld', 22:54:33 INFO - 'LANG': 'en_US.UTF-8', 22:54:33 INFO - 'LANGUAGE': 'en_US:en', 22:54:33 INFO - 'LOGNAME': 'cltbld', 22:54:33 INFO - 'MAIL': '/var/mail/cltbld', 22:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:33 INFO - 'MOZ_NO_REMOTE': '1', 22:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:33 INFO - 'NO_EM_RESTART': '1', 22:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:33 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:33 INFO - 'SHELL': '/bin/bash', 22:54:33 INFO - 'SHLVL': '1', 22:54:33 INFO - 'TERM': 'linux', 22:54:33 INFO - 'TMOUT': '86400', 22:54:33 INFO - 'USER': 'cltbld', 22:54:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', 22:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:33 INFO - '_': '/tools/buildbot/bin/python'} 22:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:34 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)) 22:54:34 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)) 22:54:34 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)) 22:54:34 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)) 22:54:34 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)) 22:54:34 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)) 22:54:34 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)) 22:54:34 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)) 22:54:34 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)) 22:54:34 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)) 22:54:34 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)) 22:54:34 INFO - Cleaning up... 22:54:34 INFO - Return code: 0 22:54:34 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff60f5c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19be670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8c0>, '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 0x1a4e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ec50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', '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 22:54:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:54:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:54:34 INFO - Using env: {'DISPLAY': ':0', 22:54:34 INFO - 'HOME': '/home/cltbld', 22:54:34 INFO - 'LANG': 'en_US.UTF-8', 22:54:34 INFO - 'LANGUAGE': 'en_US:en', 22:54:34 INFO - 'LOGNAME': 'cltbld', 22:54:34 INFO - 'MAIL': '/var/mail/cltbld', 22:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:34 INFO - 'MOZ_NO_REMOTE': '1', 22:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:34 INFO - 'NO_EM_RESTART': '1', 22:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:34 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:34 INFO - 'SHELL': '/bin/bash', 22:54:34 INFO - 'SHLVL': '1', 22:54:34 INFO - 'TERM': 'linux', 22:54:34 INFO - 'TMOUT': '86400', 22:54:34 INFO - 'USER': 'cltbld', 22:54:34 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', 22:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:34 INFO - '_': '/tools/buildbot/bin/python'} 22:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:34 INFO - Downloading/unpacking jsonschema 22:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:54:36 INFO - Downloading/unpacking functools32 (from jsonschema) 22:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:36 INFO - Downloading functools32-3.2.3-2.tar.gz 22:54:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:54:36 INFO - warning: no files found matching '*.txt' 22:54:36 INFO - no previously-included directories found matching 'build' 22:54:36 INFO - no previously-included directories found matching 'dist' 22:54:36 INFO - no previously-included directories found matching '.git*' 22:54:36 INFO - Installing collected packages: jsonschema, functools32 22:54:36 INFO - Running setup.py install for functools32 22:54:36 INFO - warning: no files found matching '*.txt' 22:54:36 INFO - no previously-included directories found matching 'build' 22:54:36 INFO - no previously-included directories found matching 'dist' 22:54:36 INFO - no previously-included directories found matching '.git*' 22:54:36 INFO - Successfully installed jsonschema functools32 22:54:36 INFO - Cleaning up... 22:54:36 INFO - Return code: 0 22:54:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:36 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 0x7ff60f5c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19be670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8c0>, '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 0x1a4e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ec50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', '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 22:54:36 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 22:54:36 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 22:54:36 INFO - Using env: {'DISPLAY': ':0', 22:54:36 INFO - 'HOME': '/home/cltbld', 22:54:36 INFO - 'LANG': 'en_US.UTF-8', 22:54:36 INFO - 'LANGUAGE': 'en_US:en', 22:54:36 INFO - 'LOGNAME': 'cltbld', 22:54:36 INFO - 'MAIL': '/var/mail/cltbld', 22:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:36 INFO - 'MOZ_NO_REMOTE': '1', 22:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:36 INFO - 'NO_EM_RESTART': '1', 22:54:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:36 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:36 INFO - 'SHELL': '/bin/bash', 22:54:36 INFO - 'SHLVL': '1', 22:54:36 INFO - 'TERM': 'linux', 22:54:36 INFO - 'TMOUT': '86400', 22:54:36 INFO - 'USER': 'cltbld', 22:54:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', 22:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:36 INFO - '_': '/tools/buildbot/bin/python'} 22:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:36 INFO - Downloading/unpacking flake8 22:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:54:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:54:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:54:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:39 INFO - no previously-included directories found matching 'docs/_build' 22:54:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:54:39 INFO - Running setup.py install for pep8 22:54:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:39 INFO - no previously-included directories found matching 'docs/_build' 22:54:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:54:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:54:39 INFO - Cleaning up... 22:54:39 INFO - Return code: 0 22:54:39 INFO - Running post-action listener: _resource_record_post_action 22:54:39 INFO - Running post-action listener: _start_resource_monitoring 22:54:39 INFO - Starting resource monitoring. 22:54:39 INFO - ##### 22:54:39 INFO - ##### Running install step. 22:54:39 INFO - ##### 22:54:39 INFO - Running pre-action listener: _resource_record_pre_action 22:54:39 INFO - Running main action method: install 22:54:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:54:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:54:39 INFO - Reading from file tmpfile_stdout 22:54:39 INFO - Detecting whether we're running mozinstall >=1.0... 22:54:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:54:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:54:39 INFO - Reading from file tmpfile_stdout 22:54:39 INFO - Output received: 22:54:39 INFO - Usage: mozinstall [options] installer 22:54:39 INFO - Options: 22:54:39 INFO - -h, --help show this help message and exit 22:54:39 INFO - -d DEST, --destination=DEST 22:54:39 INFO - Directory to install application into. [default: 22:54:39 INFO - "/builds/slave/test-pgo"] 22:54:39 INFO - --app=APP Application being installed. [default: firefox] 22:54:39 INFO - mkdir: /builds/slave/test-pgo/build/application 22:54:39 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'] 22:54:39 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 22:54:56 INFO - Reading from file tmpfile_stdout 22:54:56 INFO - Output received: 22:54:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:54:56 INFO - Running post-action listener: _resource_record_post_action 22:54:56 INFO - ##### 22:54:56 INFO - ##### Running run-tests step. 22:54:56 INFO - ##### 22:54:56 INFO - Running pre-action listener: _resource_record_pre_action 22:54:56 INFO - Running main action method: run_tests 22:54:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:54:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:54:56 INFO - Python 2.7.3 22:54:56 INFO - Return code: 0 22:54:56 INFO - grabbing minidump binary from tooltool 22:54: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')]} 22:54:56 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 0x1a4d8c0>, '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 0x1a4e7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4ec50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:54:56 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 22:54:56 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 22:54:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:54:56 INFO - Return code: 0 22:54:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:54:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:54:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:54:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:54:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:54:57 INFO - Return code: 0 22:54:57 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:54:57 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:54:57 INFO - Using env: {'DISPLAY': ':0', 22:54:57 INFO - 'HOME': '/home/cltbld', 22:54:57 INFO - 'LANG': 'en_US.UTF-8', 22:54:57 INFO - 'LANGUAGE': 'en_US:en', 22:54:57 INFO - 'LOGNAME': 'cltbld', 22:54:57 INFO - 'MAIL': '/var/mail/cltbld', 22:54:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:57 INFO - 'MOZ_NO_REMOTE': '1', 22:54:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:57 INFO - 'NO_EM_RESTART': '1', 22:54:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:54:57 INFO - 'SHELL': '/bin/bash', 22:54:57 INFO - 'SHLVL': '1', 22:54:57 INFO - 'TERM': 'linux', 22:54:57 INFO - 'TMOUT': '86400', 22:54:57 INFO - 'USER': 'cltbld', 22:54:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395', 22:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:57 INFO - '_': '/tools/buildbot/bin/python'} 22:54:57 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:54:57 INFO - mozversion application_buildid: 20160219203515 22:54:57 INFO - mozversion application_changeset: ba617d51a0fdc41e619302fd750376aeaabf86ad 22:54:57 INFO - mozversion application_display_name: Nightly 22:54:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:54:57 INFO - mozversion application_name: Firefox 22:54:57 INFO - mozversion application_remotingname: firefox 22:54:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:54:57 INFO - mozversion application_vendor: Mozilla 22:54:57 INFO - mozversion application_version: 47.0a1 22:54:57 INFO - mozversion platform_buildid: 20160219203515 22:54:57 INFO - mozversion platform_changeset: ba617d51a0fdc41e619302fd750376aeaabf86ad 22:54:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:54:57 INFO - mozversion platform_version: 47.0a1 22:54:57 INFO - using testdate: 1455951297 22:54:57 INFO - actual date: 1455951297 22:54:57 INFO - starting webserver on 'localhost:45347' 22:54:57 INFO - SUITE-START | Running 2 tests 22:54:57 INFO - TEST-START | dromaeo_css 22:54:57 INFO - operating with platform_type : linux_ 22:54:57 INFO - Initialising browser for dromaeo_css test... 22:54:57 INFO - TEST-INFO | started process 9367 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOBgFgA/profile http://localhost:45347/getInfo.html) 22:55:01 INFO - PROCESS | 9367 | 22:55:01 INFO - PROCESS | 9367 | (process:9449): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:55:01 INFO - PROCESS | 9367 | __metrics Screen width/height:1600/1200 22:55:01 INFO - PROCESS | 9367 | colorDepth:24 22:55:01 INFO - PROCESS | 9367 | Browser inner width/height: 1024/697 22:55:01 INFO - PROCESS | 9367 | __metrics 22:55:02 ERROR - PROCESS | 9367 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 22:55:03 INFO - TEST-INFO | 9367: exit 0 22:55:03 INFO - Browser initialized. 22:55:03 INFO - Running cycle 1/1 for dromaeo_css test... 22:55:03 INFO - TEST-INFO | started process 9500 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOBgFgA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:55:04 INFO - PROCESS | 9500 | 22:55:04 INFO - PROCESS | 9500 | (process:9556): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:55:15 INFO - PROCESS | 9500 | RSS: Main: 155213824 22:55:15 INFO - PROCESS | 9500 | 22:56:04 INFO - PROCESS | 9500 | 1455951364936 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] 22:58:13 INFO - PROCESS | 9500 | Cycle 1(1): loaded http://localhost:45347/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45347/tests/dromaeo/cssquery-ext.html) 22:58:14 INFO - PROCESS | 9500 | RSS: Main: 164409344 22:58:14 INFO - PROCESS | 9500 | 23:01:16 INFO - PROCESS | 9500 | Cycle 1(1): loaded http://localhost:45347/tests/dromaeo/cssquery-ext.html (next: http://localhost:45347/tests/dromaeo/cssquery-jquery.html) 23:01:17 INFO - PROCESS | 9500 | RSS: Main: 161226752 23:01:17 INFO - PROCESS | 9500 | 23:04:19 INFO - PROCESS | 9500 | Cycle 1(1): loaded http://localhost:45347/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45347/tests/dromaeo/cssquery-mootools.html) 23:04:19 INFO - PROCESS | 9500 | RSS: Main: 162828288 23:04:19 INFO - PROCESS | 9500 | 23:07:21 INFO - PROCESS | 9500 | Cycle 1(1): loaded http://localhost:45347/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45347/tests/dromaeo/cssquery-prototype.html) 23:07:21 INFO - PROCESS | 9500 | RSS: Main: 160526336 23:07:21 INFO - PROCESS | 9500 | 23:10:24 INFO - PROCESS | 9500 | Cycle 1(1): loaded http://localhost:45347/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45347/tests/dromaeo/cssquery-yui.html) 23:10:24 INFO - PROCESS | 9500 | RSS: Main: 160669696 23:10:24 INFO - PROCESS | 9500 | 23:13:27 INFO - PROCESS | 9500 | Cycle 1(1): loaded http://localhost:45347/tests/dromaeo/cssquery-yui.html (next: http://localhost:45347/tests/dromaeo/cssquery-dojo.html) 23:13:27 INFO - PROCESS | 9500 | RSS: Main: 164061184 23:13:27 INFO - PROCESS | 9500 | 23:13:27 INFO - PROCESS | 9500 | __start_tp_report 23:13:27 INFO - PROCESS | 9500 | _x_x_mozilla_page_load 23:13:27 INFO - PROCESS | 9500 | _x_x_mozilla_page_load_details 23:13:27 INFO - PROCESS | 9500 | |i|pagename|runs| 23:13:27 INFO - PROCESS | 9500 | |0;dojo.html;3186.490161574148;3221.72615327697;3233.110894504013;3259.4621887388575;3262.478003519436;5207.5573576246015;5215.530602245797;5297.761600727967;5307.389650190229;5307.73461326934;5248.396434410034;5260.605454590911;5313.628046036769;5316.627836051478;5329.360476742787;4763.166445871967;4791.811587001875;4818.397700287464;5030.37120359955;5035.320231768719;4864.14877396456;4896.608271338302;4944.060628480595;4949;4972.129877271481;4808.206645903421;4828.2274836026245;4831.637627177975;4863.076015557068;4888.73111978841;4830.058138662962;4863.124637565237;4868.805247790084;4877.951220487821;4923.58149557288;4790.664653474259;4817.349657796222;4831.565159135695;4846.418429788448;4892.926606100911;4965.32968049316;5101.566366858821;5102;5116.513931176532;5158.871028224287;5625.38120806711;5659.490645841853;5672.9432705672825;5673.8297851064535;5676.744546495418;5682.289713785777;5705.486506214461;5706;5779.3642699303045;5792.913106303409;5307.65500242483;5382.757775900094;5401.108817045183;5403.729813509309;5406.864828379283;5765.250517432707;5779.046457334577;5802.24570805801;5821.38875418075;5823.650580965155;5504;5546.029444847136;5588.0779671354585;5591.916121258185;5638.661680299195;5619.7471113799975;5620.831375058755;5624.859378515488;5644.407337229614;5649.830505084772;5489.4236105209175;5611.3266408031295;5618.4662457066515;5639.492445679908;5640.210370548045;5599.776008959678;5626.634268772516;5643.915341269884;5675.120356344773;5715.228444160069;4348.7390756554705;4385.890352741207;4390.846320378771;4396.802143903532;4422.955770442254;3899.083715326896;3925.1757131002237;3946.664533514626;3963.3064213762477;4031.7782521960985;5321.3880403754065;5340.599455040888;5343.225232341289;5351.491608297206;5370.194470829329;5662.37713851476;5664.49019588239;5668.206451096849;5689.431056894277;5716.42835716425;5215.921761173586;5292.788288468495;5417.997670430983;5418.972905135449;5461.754221060062;4869.805207791719;4891.6575839691595;4893.314935908976;4895.730734809548;4912.9508704913205;5824.271966004249;5922.082077278029;5973.283206015306;5976.402359763989;5980.162777211194;5642.7460764266525;5659.179418984307;5705.315362156568;5711.143328500758;5721.022710241949;5835.387284335084;5880.911786323123;5910.202122713378;5917.467427931335;6004.309504406874;5605.719714014202;5637.887242255214;5643.971780141073;5669.092945128759;5675.404082571271;5612.691301978431;5758.3090029196765;5760.366359700513;5763.279590051244;5892.6759028253855;5561.332640083216;5587.944120558743;5589.720513974204;5608.579356548194;5609.523190528687;5572.693501857437;5582.86042848932;5584.497395234448;5594.13290939905;5609.663420194802;5311.654742441729;5461.672299662033;5469.480399362054;5503.477169668875;5529.4470552944385;5521.723913804213;5561.360443549043;5565.638233514808;5572.582056345871;5607.102863541813;5368.060589396762;5393.8921221574565;5471.015217260931;5494.780208791603;5547.750351234124 23:13:27 INFO - PROCESS | 9500 | |1;ext.html;516.3133033066023;518.1424742051905;576.6367188671137;580.7241560258877;583.5360888093968;35803.82098089509;35938.820305898436;35942.64057359425;36103.09742256442;36129.0967725807;39232.80383598085;39916.20167596646;39992.80003599978;40024.79987600058;40220.597794022055;8454.112318206577;8641.179087986631;8643.956780216091;8656.480611163319;8678.566071696421;8557.144285571425;8622.094680058597;8721.12788721129;8918.821623567525;8934.4192627479;8815;8931.151540603632;8948.776280593005;8949.105089491064;8975.057618950013;8834.955825220864;8860.911390886138;8904.777380565472;8924.286057115447;8932.598033088527;8643.222110010129;8781.604827782765;8802.823943521094;8814.338924580617;8816.250618697419;39480.80259598684;39821;39932.20135597272;39988.600683959055;40038.79980600107;3124.390743804959;3199.3921154980712;3245.6429792722784;3251.5935508061493;3794.6584807367194;29993.400131997238;30343.848280758677;30932.536011959837;30934;31517.36965260705;3875.961240387588;4045.4943132108488;4067.1662309226535;4124.546299907008;4125.731827431207;248642;248890;251355.74322128456;252157;254600;41183.79408103;42015.159696806506;42037.57962420398;61146.08280875791;61398.69300653468;40065;40454.1909161821;40474;40594.18811623751;40718.796406017784;14792.334344954503;14807.629809254639;14821.851781482263;14903.850961490463;14944.178070206026;11938.761224775455;11954.641360759191;11960.40197990097;11962.40187990597;11985.820212696817;14063.648408789863;14098.083624564575;14117.152970821784;14167.645808854655;14259;5812.099124635688;5886.440788125121;5886.852828679317;5935.584509084322;5959.731812068468;820.2986446588201;821.34292565947;834.3533761335013;863.8401895649325;869.3827382558454;27230.183094507196;27775;27848;28043.859780701376;28175;901.5041727050096;913.4747520175792;913.963441462334;939.196986576481;962.3744566032135;13665.658358541115;13709.862901371058;13741.106828056145;13868.306584670727;13902.513412030732;362413;365600.71996400075;366208;366912;369344;52792.472075279526;53265.2010219847;53419.19871201935;53463;53690;1337.2444568818587;1356.982263302523;1380.3098450774612;1388.7500249955106;1405.866442687943;25565.3608659785;26496.8675156623;26514.469710606067;26544.8672756635;26795.598066028637;47919.28121078257;48539.27191092066;48561.27158092702;48838.26742598935;48890.26664600105;266491;266697;267418;267557;267934;42122.78938605287;42531.57468425276;42615.10128913493;42853.571464284956;43307.35038974481;45101.77449112733;45411.318830216915;45547.31679024751;45769.313460298785;46098.30852537282;37134;37555.43223393773;38532.614673852906;39252.803735981135;39434.605653943094;38738.532793972765;38992;39372.2125557493;39930.60069399269;40129.39805902856;37411.06472338214;37925.431118533794;38326.80836595799;38357.6164238354;38444;33327.166820829676;34699;35343.29313413769;35665.64334356727;38645.6135438642;24996.500069998863;25223.24330270095;25510.617340740275;25728.228153155436;26011 23:13:27 INFO - PROCESS | 9500 | |2;jquery.html;363.718118458195;367.15920541958917;367.77198137154966;368.8137490567264;370.23176907916064;16929.49211523653;17272.74090888636;17616.911915440436;17957.820421795794;18297.81702182978;13432.865671343283;16723;16859.578510537212;17002.319907203728;17077.487675369728;4852.078105160026;4949.059678661061;4995.225740010286;5022.874428139307;5055.696658200502;4905.4849240829735;5014.69911805291;5030.522100400474;5408.378036525791;5422.376426710939;5190.92213616796;5275.920861187085;5376.677399356032;5383.084875571143;5405.810796622119;5275.129603615418;5279.841604751864;5294.973525132388;5306.97346513265;5325.334333208349;5404.864978354551;5413.458654134555;5417.83746487606;5420.268263784417;5430.891382172374;12501.874981250163;18235.908820455945;19450.610987780165;19570.315038973567;19610.215591376327;2128.5955668423103;2203.5262418580082;2217.3347995601257;2780.374415756459;2786.289496178482;9686.806263874683;11795;12593.496260149583;12819.910307623863;13055.738885222338;1794.9910250448663;1818.08186865632;1839.8776746184817;1854.8608854335978;1872.4382685194523;56968.715156423954;58181.12728309079;58445.41554584442;58931.70534147302;59725.70137149286;10150.796984060426;10453.738656533647;10607.787844243072;10740.087092597061;10792.298500597437;13004.934975325252;13410.865891341156;13507.459701612022;13540.322983850769;13941.442342306194;7372.889406658905;7578.469507134558;7777.533347999138;7838.8432231355055;7901.209879012168;7637.847243055107;7712.845743085107;7720.498167619086;7726.188750181263;7752.147263800977;4370.278903980808;4568.771561421916;4624.260118381043;4641.675082744243;4671.929921051187;1798.415514957618;1864.1797609051973;1869.7943226245102;1908.961820763577;1917.0893825432809;772.6291380137453;818.2022528035118;831.4304701279643;847.737201467547;924.3390975452584;16059.759103613454;16459.094749788877;16557.172141393123;16685.582860428345;16764.32942682279;768.6348984232445;830.2237408023517;830.9086000539936;860.7718954477068;864.9048604653483;9247.76880577991;9571.473568953636;9607.663731769355;9732.659356922615;9758.365706229073;378161.5459613532;381450;385829;388434;390055;64107;66983;67051.66474167598;67828.3217167822;69241.65379173071;1020.7448137965508;1049.9527521261562;1063.2132222155549;1066.9466526673634;1073.7745073534488;15106.622334441727;15118.244087795347;15196.924015379853;15559.45541906028;16168.757468638216;31660.366792664478;33049.669503305624;33237.833810830794;33748.831255843565;33822;35800.46299305461;35862.820685896404;38167.42748858825;38532.42201367038;39377;7576.166621671501;7743.728969486267;7819.960900195462;7849.803754906173;7906.407019473678;10984.231103822975;11678.299302041905;11888.643340699793;12055.397230138282;12285.385730713608;9966.252531060054;10046.598136074475;10152.593896244067;10216.693499195037;10241.18070554339;10064.345817521838;10279.229057820543;10634.84047739269;10800.351978880977;10951.740549836872;10268.743281417725;10434.68695939123;10600.0989915858;10735.302205356627;10781.676549703521;7586.56846835601;7773.883391749241;7807.609619519115;7817.452778305464;7851.882221766564;8671.479711217347;10108.292419530562;10303.587856485656;10346.430946297725;10476.476176191007 23:13:27 INFO - PROCESS | 9500 | |3;mootools.html;1484.450753221308;1499.0780669888018;1647.2916645842283;1753.088394035101;1790.7134858422655;6814.965925170367;7453.105627324715;7952.244536769005;8138.14549472305;8166.877496837552;7928.801779955504;7961.681532738698;8031.237032481905;8048.798780030487;8061.3550915926735;2294.1052989334216;2343.2618725101624;2346.2843832631042;2351.7413084560685;2352.3883790214495;2296.7243930728337;2313.097891822191;2315.837891347598;2316.7683231676865;2323.3030090972725;2276.635738281875;2284.2804516577307;2290.118304452781;2336.5093330400637;2337.333859849943;2322.9651555226687;2355.6584295277175;2361.633946738258;2378.191414918919;2379.2029670060465;2346.7301260355107;2393.8922748476184;2395.2694428199393;2407.3500154958238;2409.0363854458183;8129.268365847102;8154.551499667516;8165.2243036911395;8222.465539739958;8238.134995825472;4602.286645569942;4720.952790472085;4723.173444647173;4725.1022305762135;4748.216544270192;3040.3463255400197;3096.210466331094;3145.2294187923876;3150.6691797361177;3185.394774992744;998.1864780204183;998.3710262534629;1012.4026824173773;1022.156720705421;1052.4264275969615;10829.133669306437;10838.349699018085;10940.015398614083;10972.615958441416;11049.558017679283;3997.540282867449;4116.3619638955415;4126.42230087788;4154.646855017297;4219.746815191037;8533.914660853436;8765.561721913879;8768.342374321952;8787.516686582172;8802.515861627671;4768.809247630056;4768.856934291976;4783.736894470768;4785.210440277316;4789.856304310876;3893.7858417787293;4312.698111132253;4338.349247612883;4372.300431930939;4400.735955842596;3468.809215493172;3490.110021944388;3521.7182625389905;3531.52324436203;3547.467879817996;992.5434300221979;1027.5324727249083;1049.6221360310283;1057.2757661002238;1059.5338051257422;1248.3446190749928;1249.0694432647736;1250.3810613746073;1261.8422697162855;1273.9171953822972;7282.453815963824;7297.233790451926;7401.0748656417945;7442.479026468095;7466.775996720107;447.43176166268654;448.3387004168825;451.3410420785624;457.06986282914113;465.9277811939155;5514.558835293167;5555.916661250085;5561.388247292794;5567.387587365387;5583.581231407661;9653.276004299705;9742.46416447088;10088.69733907984;10092.394456332497;10152.898471015194;9777.315587908779;9878.802423951482;9903.702888913343;9910.851337229948;9946.35348702332;7096.432285417154;7231.855362892713;7253.165885923081;7308.853822923512;7518.360939320219;7486.663100160615;7528.51064680794;7534.698612055457;7552.886706699294;7554.206808285051;8592.183742544448;8802.163794439519;8813.559322034002;8959.104089590988;8966.193042626195;8800.207981281716;8832.91167088321;8847.69033083839;8964.865527017231;8998.14517620825;7011.964940175267;7219;7224.060872086595;7261;7402.6668799903055;7682.7311044113185;7709.151993280847;7752.844943100994;7760.029996250469;7785.844283114193;6843.349881761224;7075.115610548682;7095.751648692271;7180.533265337736;7216.9639151806;6527.967360163168;6575.27671956094;6680.298568650222;6739.93260067393;6848;6911.827204319932;7088.893666594902;7135.750248741269;7163.964180179066;7184.46116541251;6360.968195158995;6373.5857169283845;6374.139491168633;6450.774222902176;6462.612243265419;6438.163038804925;6459.741610335722;6545.280019197789;6581.111549940888;6584 23:13:27 INFO - PROCESS | 9500 | |4;prototype.html;327.1314659578818;334.7271973341726;337.4112174255923;340.0309119010821;342.5598106433232;6209.782657606985;6237.251529816423;6327.335629758878;6345.079963405304;6363.236411630611;6190;6197.977333739927;6236.968815155918;6262.655553944532;6283.277423096345;4780.426348838144;4787.8324258650955;4788.449328327252;4788.640851936101;4791.736454495001;4785.928211076836;4791.952080479203;4793.304970779235;4805.0389922015565;4805.591524720386;4660.37084993525;4729.952700472985;4731.5268473152755;4739.786709598059;4744.620430365562;4663.976680116594;4667.5332466753225;4676.251799712047;4689.2966055091665;4721.244600863845;4049.8785036448953;4080.6939479539155;4095.467589213413;4097.795110244476;4103.610157035077;5918.7928422505;5963.970180149115;5972.313183983854;5981.0729336952845;5987.670678112702;5412.648177868426;5540.030494663458;5541.639793413456;5542.8337149885565;5543.057680194376;6633.734650613969;6634.369734875179;6670.266270710218;6677.165354330708;6686.231083425371;4498.190325741365;4501.437320334958;4540.818367265306;4555.362249285103;4569.246074397721;6766.594004359705;6850.931490685129;6935.965320173367;6938.861222775517;6938.895916561205;4565;4577.29051996941;4584.381108550369;4596.931046034312;4608.723476591415;4646.4888862225125;4647.140279048387;4648.186567350767;4665.790039448233;4671.883202919954;5452.04589196889;5452.182172674131;5452.2094296327605;5452.345718513804;5454.563634909197;6467.838304042342;6668.599884006878;6694.062831203635;6704.4301234395625;6715.865682686416;1607.9839201607833;1615.1439736939442;1647.8846480746233;1649.892756970793;1650.8596769274507;1078.697964569906;1087.2280680716622;1094.261373572835;1099.6536091131268;1103.7626910214342;6145.692715364214;6254.21822272216;6263.3736626337;6288.402601752826;6304.275008374096;6790.490713196431;6790.966045169841;6801.591904485746;6815.965920170466;6816.931830681629;6116.541259405562;6218.9378106219265;6247.531435142382;6248.375162483715;6255.0617407388345;3693.9630603693618;3705.814709264526;3711.3319602471815;3712.1833196696684;3720.627937206312;7096.787096387116;7123.43012558994;7137.750178743719;7141.107361579802;7145.285471452813;6795.2185498667295;6916.688749006306;6941.548799328028;6972.442204623618;6988.126484189476;6988.580685158907;7045.718171273092;7046.6476676165985;7055.800513912647;7091.078159839188;6727.73089076451;6774;6776.390124888587;6797;6808.489363297674;6549.312322206099;6674.933250667431;6746.8650626988165;6746.898796517958;6749.595024298558;7086.114235720535;7165.176004759519;7170.89243661356;7176.21061683204;7181.892271616034;4533.931991020071;4549.135664223787;4562.064776720698;4570.085982803519;4582.289745089383;6736.5958042517605;6748.797536073926;6785.796426107225;6791.456683465212;6951.582905025714;6691.933080669131;6737.494687898329;6753.932460675527;6761.966190169018;6765.188177418741;6738.561993470409;6781.593104413751;6793.116894803841;6814.352636499525;6830.146231721035;6488.610683359014;6547.70535325902;6608.7356505739235;6622.403983641495;6628.403443690091;6720.6975686093265;6733.696983635846;6748.662566871735;6760.966195168992;6787.728490860311;6514.250861150838;6551.082848401133;6583.868322633616;6586.242582102927;6599.8020059398295 23:13:27 INFO - PROCESS | 9500 | |5;yui.html;700.9964950175248;717.998392242821;767.0488594143264;772.8956590860232;775.1357236681099;13175.20948743076;13330.066895317308;13332.466701331936;13393;13422.66443338917;12075.97354224892;12151.453184606691;12159.696007599814;12180.330081845495;12200.511979520808;802.7511471443856;811.9350451963828;819.3608984991716;819.8073452738602;821.7165078048064;813.3371302388564;823.5799742131496;827.5448503323179;838.0781140745192;841.1798496465958;883.3419102768446;884.849575572151;889.0798024045115;891.5319457284912;892.0677891603258;874.8337815815007;883.041899539001;883.337496877342;886.8492356299445;888.0764005434405;646.0922404022356;650.7266947881901;652.92164940207;653.0432915778407;654.5483616304782;13623.455061797516;14013.369398377097;14022.298885055707;14024.088434251844;14031.579052628438;11960.820587691105;12267.631971040882;12399.876001239962;12489.313087780169;12940.741185176337;10478.10936070435;10581.470926453647;10692.144628429707;10694.037536621663;10744;3419.863205471778;3439.1402149462633;3453.015890471204;3563.6080031196548;3581.982090089559;45191.322130168075;46523.76738116288;48976.510234897905;49103.75448122772;49637.50362496365;8986.19124278818;9429.347283509478;9758.902410975941;9819.9018009819;9847.704568862946;16924.661506769797;16960.660786784443;17018.48944531666;17024.48926532206;17025.659486810193;7555.924440755632;7576.052993375828;7654.00497935276;7699.576523291161;7754.3796496280165;4205.285101532747;4297.312430011183;4329.112531930947;4402.339649052604;4543.295789152687;3145.795523290979;3183.793053451518;3185.952210716841;3186.76099292554;3202.503611940153;611.9388061193845;614.8585825260126;616.7317217010615;624.3912185618985;635.7107516080265;454.07822121094233;521.3587287636228;564.6950646650845;564.7035306464139;575.8099827057144;7190.820229494305;7254.709811607582;7621.7782158109685;7656.119546252141;7968.482048666818;466.8412739668529;567.8182981445898;576.8154190659033;611.9143319935213;627.1502114634695;3464.4110501214855;3513.5432393789156;3931.1941052084826;4062.6749860011128;4123.195976784558;53653.195202072;57126;58162;58254;58307.70846145742;50285;50713.74643126761;50849.49150508447;50976.49023509792;51051;45583.77208113938;45819.31271030937;46251;46256.074878502244;47093.76453117713;8018.959905200437;8224.917750822415;8277.668893244203;8642.78393040179;8646.351523635878;30952.69047309498;31835.20411989719;32476.350472990882;33697.66302336945;35440.29119417546;41241.793791030854;43102.35346469868;43118.35322470103;43835.342469863615;45770;10425.791484170122;10477.528511217166;10751.946240268748;10907.29102608328;10914.727131821768;10874.184436167161;10938.12495000414;11178.441077946232;11220.495077721685;11442.199046066695;9623.615055397986;9775.75560610962;9822.21422286201;9873;10145.847812282675;10493;10552.261341706315;10627.574897004033;10817.783644326912;11054.723631909266;9073.909260907307;9538.427694338361;10085.445300508543;10768.3538987661;10803.135749140207;8347.749567512985;8493.957530212308;8560.443571167854;8570.442921210102;8782.868256976279;8289.626966786629;9144.634214631606;9172.174504294646;9358.88097750954;9627.277954153607 23:13:27 INFO - PROCESS | 9500 | __end_tp_report 23:13:27 INFO - PROCESS | 9500 | __start_cc_report 23:13:27 INFO - PROCESS | 9500 | _x_x_mozilla_cycle_collect,322 23:13:27 INFO - PROCESS | 9500 | __end_cc_report 23:13:27 INFO - PROCESS | 9500 | __startTimestamp1455952407714__endTimestamp 23:13:27 INFO - PROCESS | 9500 | 23:13:27 INFO - PROCESS | 9500 | ------- Summary: start ------- 23:13:27 INFO - PROCESS | 9500 | Number of tests: 6 23:13:27 INFO - PROCESS | 9500 | 23:13:27 INFO - PROCESS | 9500 | [#0] dojo.html Cycles:165 Average:5287.69 Median:5494.78 stddev:573.36 (10.4%) stddev-sans-first:550.91 23:13:27 INFO - PROCESS | 9500 | Values: 3186.5 3221.7 3233.1 3259.5 3262.5 5207.6 5215.5 5297.8 5307.4 5307.7 5248.4 5260.6 5313.6 5316.6 5329.4 4763.2 4791.8 4818.4 5030.4 5035.3 4864.1 4896.6 4944.1 4949.0 4972.1 4808.2 4828.2 4831.6 4863.1 4888.7 4830.1 4863.1 4868.8 4878.0 4923.6 4790.7 4817.3 4831.6 4846.4 4892.9 4965.3 5101.6 5102.0 5116.5 5158.9 5625.4 5659.5 5672.9 5673.8 5676.7 5682.3 5705.5 5706.0 5779.4 5792.9 5307.7 5382.8 5401.1 5403.7 5406.9 5765.3 5779.0 5802.2 5821.4 5823.7 5504.0 5546.0 5588.1 5591.9 5638.7 5619.7 5620.8 5624.9 5644.4 5649.8 5489.4 5611.3 5618.5 5639.5 5640.2 5599.8 5626.6 5643.9 5675.1 5715.2 4348.7 4385.9 4390.8 4396.8 4423.0 3899.1 3925.2 3946.7 3963.3 4031.8 5321.4 5340.6 5343.2 5351.5 5370.2 5662.4 5664.5 5668.2 5689.4 5716.4 5215.9 5292.8 5418.0 5419.0 5461.8 4869.8 4891.7 4893.3 4895.7 4913.0 5824.3 5922.1 5973.3 5976.4 5980.2 5642.7 5659.2 5705.3 5711.1 5721.0 5835.4 5880.9 5910.2 5917.5 6004.3 5605.7 5637.9 5644.0 5669.1 5675.4 5612.7 5758.3 5760.4 5763.3 5892.7 5561.3 5587.9 5589.7 5608.6 5609.5 5572.7 5582.9 5584.5 5594.1 5609.7 5311.7 5461.7 5469.5 5503.5 5529.4 5521.7 5561.4 5565.6 5572.6 5607.1 5368.1 5393.9 5471.0 5494.8 5547.8 23:13:27 INFO - PROCESS | 9500 | 23:13:27 INFO - PROCESS | 9500 | [#1] ext.html Cycles:180 Average:46051.41 Median:39650.90 stddev:78380.77 (197.7%) stddev-sans-first:78526.08 23:13:27 INFO - PROCESS | 9500 | Values: 516.3 518.1 576.6 580.7 583.5 35803.8 35938.8 35942.6 36103.1 36129.1 39232.8 39916.2 39992.8 40024.8 40220.6 8454.1 8641.2 8644.0 8656.5 8678.6 8557.1 8622.1 8721.1 8918.8 8934.4 8815.0 8931.2 8948.8 8949.1 8975.1 8835.0 8860.9 8904.8 8924.3 8932.6 8643.2 8781.6 8802.8 8814.3 8816.3 39480.8 39821.0 39932.2 39988.6 40038.8 3124.4 3199.4 3245.6 3251.6 3794.7 29993.4 30343.8 30932.5 30934.0 31517.4 3876.0 4045.5 4067.2 4124.5 4125.7 248642.0 248890.0 251355.7 252157.0 254600.0 41183.8 42015.2 42037.6 61146.1 61398.7 40065.0 40454.2 40474.0 40594.2 40718.8 14792.3 14807.6 14821.9 14903.9 14944.2 11938.8 11954.6 11960.4 11962.4 11985.8 14063.6 14098.1 14117.2 14167.6 14259.0 5812.1 5886.4 5886.9 5935.6 5959.7 820.3 821.3 834.4 863.8 869.4 27230.2 27775.0 27848.0 28043.9 28175.0 901.5 913.5 914.0 939.2 962.4 13665.7 13709.9 13741.1 13868.3 13902.5 362413.0 365600.7 366208.0 366912.0 369344.0 52792.5 53265.2 53419.2 53463.0 53690.0 1337.2 1357.0 1380.3 1388.8 1405.9 25565.4 26496.9 26514.5 26544.9 26795.6 47919.3 48539.3 48561.3 48838.3 48890.3 266491.0 266697.0 267418.0 267557.0 267934.0 42122.8 42531.6 42615.1 42853.6 43307.4 45101.8 45411.3 45547.3 45769.3 46098.3 37134.0 37555.4 38532.6 39252.8 39434.6 38738.5 38992.0 39372.2 39930.6 40129.4 37411.1 37925.4 38326.8 38357.6 38444.0 33327.2 34699.0 35343.3 35665.6 38645.6 24996.5 25223.2 25510.6 25728.2 26011.0 23:13:27 INFO - PROCESS | 9500 | 23:13:27 INFO - PROCESS | 9500 | [#2] jquery.html Cycles:180 Average:23169.24 Median:367.47 stddev:63001.88 (17145.0%) stddev-sans-first:63155.35 23:13:27 INFO - PROCESS | 9500 | Values: 363.7 367.2 367.8 368.8 370.2 16929.5 17272.7 17616.9 17957.8 18297.8 13432.9 16723.0 16859.6 17002.3 17077.5 4852.1 4949.1 4995.2 5022.9 5055.7 4905.5 5014.7 5030.5 5408.4 5422.4 5190.9 5275.9 5376.7 5383.1 5405.8 5275.1 5279.8 5295.0 5307.0 5325.3 5404.9 5413.5 5417.8 5420.3 5430.9 12501.9 18235.9 19450.6 19570.3 19610.2 2128.6 2203.5 2217.3 2780.4 2786.3 9686.8 11795.0 12593.5 12819.9 13055.7 1795.0 1818.1 1839.9 1854.9 1872.4 56968.7 58181.1 58445.4 58931.7 59725.7 10150.8 10453.7 10607.8 10740.1 10792.3 13004.9 13410.9 13507.5 13540.3 13941.4 7372.9 7578.5 7777.5 7838.8 7901.2 7637.8 7712.8 7720.5 7726.2 7752.1 4370.3 4568.8 4624.3 4641.7 4671.9 1798.4 1864.2 1869.8 1909.0 1917.1 772.6 818.2 831.4 847.7 924.3 16059.8 16459.1 16557.2 16685.6 16764.3 768.6 830.2 830.9 860.8 864.9 9247.8 9571.5 9607.7 9732.7 9758.4 378161.5 381450.0 385829.0 388434.0 390055.0 64107.0 66983.0 67051.7 67828.3 69241.7 1020.7 1050.0 1063.2 1066.9 1073.8 15106.6 15118.2 15196.9 15559.5 16168.8 31660.4 33049.7 33237.8 33748.8 33822.0 35800.5 35862.8 38167.4 38532.4 39377.0 7576.2 7743.7 7820.0 7849.8 7906.4 10984.2 11678.3 11888.6 12055.4 12285.4 9966.3 10046.6 10152.6 10216.7 10241.2 10064.3 10279.2 10634.8 10800.4 10951.7 10268.7 10434.7 10600.1 10735.3 10781.7 7586.6 7773.9 7807.6 7817.5 7851.9 8671.5 10108.3 10303.6 10346.4 10476.5 23:13:27 INFO - PROCESS | 9500 | 23:13:27 INFO - PROCESS | 9500 | [#3] mootools.html Cycles:180 Average:5533.21 Median:6367.28 stddev:2941.82 (46.2%) stddev-sans-first:2934.34 23:13:27 INFO - PROCESS | 9500 | Values: 1484.5 1499.1 1647.3 1753.1 1790.7 6815.0 7453.1 7952.2 8138.1 8166.9 7928.8 7961.7 8031.2 8048.8 8061.4 2294.1 2343.3 2346.3 2351.7 2352.4 2296.7 2313.1 2315.8 2316.8 2323.3 2276.6 2284.3 2290.1 2336.5 2337.3 2323.0 2355.7 2361.6 2378.2 2379.2 2346.7 2393.9 2395.3 2407.4 2409.0 8129.3 8154.6 8165.2 8222.5 8238.1 4602.3 4721.0 4723.2 4725.1 4748.2 3040.3 3096.2 3145.2 3150.7 3185.4 998.2 998.4 1012.4 1022.2 1052.4 10829.1 10838.3 10940.0 10972.6 11049.6 3997.5 4116.4 4126.4 4154.6 4219.7 8533.9 8765.6 8768.3 8787.5 8802.5 4768.8 4768.9 4783.7 4785.2 4789.9 3893.8 4312.7 4338.3 4372.3 4400.7 3468.8 3490.1 3521.7 3531.5 3547.5 992.5 1027.5 1049.6 1057.3 1059.5 1248.3 1249.1 1250.4 1261.8 1273.9 7282.5 7297.2 7401.1 7442.5 7466.8 447.4 448.3 451.3 457.1 465.9 5514.6 5555.9 5561.4 5567.4 5583.6 9653.3 9742.5 10088.7 10092.4 10152.9 9777.3 9878.8 9903.7 9910.9 9946.4 7096.4 7231.9 7253.2 7308.9 7518.4 7486.7 7528.5 7534.7 7552.9 7554.2 8592.2 8802.2 8813.6 8959.1 8966.2 8800.2 8832.9 8847.7 8964.9 8998.1 7012.0 7219.0 7224.1 7261.0 7402.7 7682.7 7709.2 7752.8 7760.0 7785.8 6843.3 7075.1 7095.8 7180.5 7217.0 6528.0 6575.3 6680.3 6739.9 6848.0 6911.8 7088.9 7135.8 7164.0 7184.5 6361.0 6373.6 6374.1 6450.8 6462.6 6438.2 6459.7 6545.3 6581.1 6584.0 23:13:27 INFO - PROCESS | 9500 | 23:13:27 INFO - PROCESS | 9500 | [#4] prototype.html Cycles:180 Average:5529.74 Median:6254.64 stddev:1690.48 (27.0%) stddev-sans-first:1649.51 23:13:27 INFO - PROCESS | 9500 | Values: 327.1 334.7 337.4 340.0 342.6 6209.8 6237.3 6327.3 6345.1 6363.2 6190.0 6198.0 6237.0 6262.7 6283.3 4780.4 4787.8 4788.4 4788.6 4791.7 4785.9 4792.0 4793.3 4805.0 4805.6 4660.4 4730.0 4731.5 4739.8 4744.6 4664.0 4667.5 4676.3 4689.3 4721.2 4049.9 4080.7 4095.5 4097.8 4103.6 5918.8 5964.0 5972.3 5981.1 5987.7 5412.6 5540.0 5541.6 5542.8 5543.1 6633.7 6634.4 6670.3 6677.2 6686.2 4498.2 4501.4 4540.8 4555.4 4569.2 6766.6 6850.9 6936.0 6938.9 6938.9 4565.0 4577.3 4584.4 4596.9 4608.7 4646.5 4647.1 4648.2 4665.8 4671.9 5452.0 5452.2 5452.2 5452.3 5454.6 6467.8 6668.6 6694.1 6704.4 6715.9 1608.0 1615.1 1647.9 1649.9 1650.9 1078.7 1087.2 1094.3 1099.7 1103.8 6145.7 6254.2 6263.4 6288.4 6304.3 6790.5 6791.0 6801.6 6816.0 6816.9 6116.5 6218.9 6247.5 6248.4 6255.1 3694.0 3705.8 3711.3 3712.2 3720.6 7096.8 7123.4 7137.8 7141.1 7145.3 6795.2 6916.7 6941.5 6972.4 6988.1 6988.6 7045.7 7046.6 7055.8 7091.1 6727.7 6774.0 6776.4 6797.0 6808.5 6549.3 6674.9 6746.9 6746.9 6749.6 7086.1 7165.2 7170.9 7176.2 7181.9 4533.9 4549.1 4562.1 4570.1 4582.3 6736.6 6748.8 6785.8 6791.5 6951.6 6691.9 6737.5 6753.9 6762.0 6765.2 6738.6 6781.6 6793.1 6814.4 6830.1 6488.6 6547.7 6608.7 6622.4 6628.4 6720.7 6733.7 6748.7 6761.0 6787.7 6514.3 6551.1 6583.9 6586.2 6599.8 23:13:27 INFO - PROCESS | 9500 | 23:13:27 INFO - PROCESS | 9500 | [#5] yui.html Cycles:180 Average:13398.22 Median:49961.25 stddev:15769.48 (31.6%) stddev-sans-first:15784.89 23:13:27 INFO - PROCESS | 9500 | Values: 701.0 718.0 767.0 772.9 775.1 13175.2 13330.1 13332.5 13393.0 13422.7 12076.0 12151.5 12159.7 12180.3 12200.5 802.8 811.9 819.4 819.8 821.7 813.3 823.6 827.5 838.1 841.2 883.3 884.8 889.1 891.5 892.1 874.8 883.0 883.3 886.8 888.1 646.1 650.7 652.9 653.0 654.5 13623.5 14013.4 14022.3 14024.1 14031.6 11960.8 12267.6 12399.9 12489.3 12940.7 10478.1 10581.5 10692.1 10694.0 10744.0 3419.9 3439.1 3453.0 3563.6 3582.0 45191.3 46523.8 48976.5 49103.8 49637.5 8986.2 9429.3 9758.9 9819.9 9847.7 16924.7 16960.7 17018.5 17024.5 17025.7 7555.9 7576.1 7654.0 7699.6 7754.4 4205.3 4297.3 4329.1 4402.3 4543.3 3145.8 3183.8 3186.0 3186.8 3202.5 611.9 614.9 616.7 624.4 635.7 454.1 521.4 564.7 564.7 575.8 7190.8 7254.7 7621.8 7656.1 7968.5 466.8 567.8 576.8 611.9 627.2 3464.4 3513.5 3931.2 4062.7 4123.2 53653.2 57126.0 58162.0 58254.0 58307.7 50285.0 50713.7 50849.5 50976.5 51051.0 45583.8 45819.3 46251.0 46256.1 47093.8 8019.0 8224.9 8277.7 8642.8 8646.4 30952.7 31835.2 32476.4 33697.7 35440.3 41241.8 43102.4 43118.4 43835.3 45770.0 10425.8 10477.5 10751.9 10907.3 10914.7 10874.2 10938.1 11178.4 11220.5 11442.2 9623.6 9775.8 9822.2 9873.0 10145.8 10493.0 10552.3 10627.6 10817.8 11054.7 9073.9 9538.4 10085.4 10768.4 10803.1 8347.7 8494.0 8560.4 8570.4 8782.9 8289.6 9144.6 9172.2 9358.9 9627.3 23:13:27 INFO - PROCESS | 9500 | -------- Summary: end -------- 23:13:27 INFO - PROCESS | 9500 | 23:13:28 INFO - TEST-INFO | 9500: exit 0 23:13:28 INFO - TEST-OK | dromaeo_css | took 1110977ms 23:13:28 INFO - TEST-START | kraken 23:13:28 INFO - operating with platform_type : linux_ 23:13:28 INFO - Initialising browser for kraken test... 23:13:28 INFO - TEST-INFO | started process 9733 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkNgTN4/profile http://localhost:45347/getInfo.html) 23:13:31 INFO - PROCESS | 9733 | 23:13:31 INFO - PROCESS | 9733 | (process:9803): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:13:32 INFO - PROCESS | 9733 | __metrics Screen width/height:1600/1200 23:13:32 INFO - PROCESS | 9733 | colorDepth:24 23:13:32 INFO - PROCESS | 9733 | Browser inner width/height: 1024/697 23:13:32 INFO - PROCESS | 9733 | __metrics 23:13:33 ERROR - PROCESS | 9733 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 23:13:34 INFO - TEST-INFO | 9733: exit 0 23:13:34 INFO - Browser initialized. 23:13:34 INFO - Running cycle 1/1 for kraken test... 23:13:34 INFO - TEST-INFO | started process 9854 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkNgTN4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:35 INFO - PROCESS | 9854 | 23:13:35 INFO - PROCESS | 9854 | (process:9912): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:13:45 INFO - PROCESS | 9854 | RSS: Main: 155586560 23:13:45 INFO - PROCESS | 9854 | 23:13:48 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45347/tests/kraken/driver.html?testName=audio-beat-detection) 23:13:49 INFO - PROCESS | 9854 | RSS: Main: 162701312 23:13:49 INFO - PROCESS | 9854 | 23:13:51 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45347/tests/kraken/driver.html?testName=audio-dft) 23:13:52 INFO - PROCESS | 9854 | RSS: Main: 164343808 23:13:52 INFO - PROCESS | 9854 | 23:13:55 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45347/tests/kraken/driver.html?testName=audio-fft) 23:13:55 INFO - PROCESS | 9854 | RSS: Main: 158638080 23:13:55 INFO - PROCESS | 9854 | 23:13:57 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45347/tests/kraken/driver.html?testName=audio-oscillator) 23:13:58 INFO - PROCESS | 9854 | RSS: Main: 159670272 23:13:58 INFO - PROCESS | 9854 | 23:14:00 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45347/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:14:01 INFO - PROCESS | 9854 | RSS: Main: 158273536 23:14:01 INFO - PROCESS | 9854 | 23:14:04 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45347/tests/kraken/driver.html?testName=imaging-darkroom) 23:14:05 INFO - PROCESS | 9854 | RSS: Main: 161517568 23:14:05 INFO - PROCESS | 9854 | 23:14:08 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45347/tests/kraken/driver.html?testName=imaging-desaturate) 23:14:09 INFO - PROCESS | 9854 | RSS: Main: 159997952 23:14:09 INFO - PROCESS | 9854 | 23:14:11 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45347/tests/kraken/driver.html?testName=json-parse-financial) 23:14:12 INFO - PROCESS | 9854 | RSS: Main: 161329152 23:14:12 INFO - PROCESS | 9854 | 23:14:14 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45347/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:14:14 INFO - PROCESS | 9854 | RSS: Main: 160735232 23:14:14 INFO - PROCESS | 9854 | 23:14:16 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45347/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:14:17 INFO - PROCESS | 9854 | RSS: Main: 160243712 23:14:17 INFO - PROCESS | 9854 | 23:14:19 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45347/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:14:19 INFO - PROCESS | 9854 | RSS: Main: 160899072 23:14:19 INFO - PROCESS | 9854 | 23:14:22 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:14:22 INFO - PROCESS | 9854 | RSS: Main: 160440320 23:14:22 INFO - PROCESS | 9854 | 23:14:25 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:14:25 INFO - PROCESS | 9854 | RSS: Main: 162148352 23:14:25 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | Cycle 1(1): loaded http://localhost:45347/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45347/tests/kraken/driver.html?testName=ai-astar) 23:14:27 INFO - PROCESS | 9854 | RSS: Main: 161738752 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | __start_tp_report 23:14:27 INFO - PROCESS | 9854 | _x_x_mozilla_page_load 23:14:27 INFO - PROCESS | 9854 | _x_x_mozilla_page_load_details 23:14:27 INFO - PROCESS | 9854 | |i|pagename|runs| 23:14:27 INFO - PROCESS | 9854 | |0;ai-astar;112;107;115;112;114;123;112;111;112;112 23:14:27 INFO - PROCESS | 9854 | |1;audio-beat-detection;158;126;153;157;127;153;156;134;163;126 23:14:27 INFO - PROCESS | 9854 | |2;audio-dft;172;167;162;165;162;163;162;165;172;163 23:14:27 INFO - PROCESS | 9854 | |3;audio-fft;73;74;74;156;74;73;76;74;155;75 23:14:27 INFO - PROCESS | 9854 | |4;audio-oscillator;98;98;147;97;98;97;148;96;97;151 23:14:27 INFO - PROCESS | 9854 | |5;imaging-gaussian-blur;120;116;118;116;115;116;116;115;115;115 23:14:27 INFO - PROCESS | 9854 | |6;imaging-darkroom;148;146;147;148;148;147;148;147;147;147 23:14:27 INFO - PROCESS | 9854 | |7;imaging-desaturate;97;97;97;97;97;98;96;96;98;97 23:14:27 INFO - PROCESS | 9854 | |8;json-parse-financial;60;61;59;59;61;60;58;66;61;56 23:14:27 INFO - PROCESS | 9854 | |9;json-stringify-tinderbox;67;68;68;68;68;68;68;67;68;68 23:14:27 INFO - PROCESS | 9854 | |10;stanford-crypto-aes;83;91;83;85;85;83;84;84;85;83 23:14:27 INFO - PROCESS | 9854 | |11;stanford-crypto-ccm;125;120;122;117;117;125;127;120;120;127 23:14:27 INFO - PROCESS | 9854 | |12;stanford-crypto-pbkdf2;144;152;154;151;153;143;152;173;157;166 23:14:27 INFO - PROCESS | 9854 | |13;stanford-crypto-sha256-iterative;69;72;73;69;71;77;70;82;71;74 23:14:27 INFO - PROCESS | 9854 | __end_tp_report 23:14:27 INFO - PROCESS | 9854 | __start_cc_report 23:14:27 INFO - PROCESS | 9854 | _x_x_mozilla_cycle_collect,749 23:14:27 INFO - PROCESS | 9854 | __end_cc_report 23:14:27 INFO - PROCESS | 9854 | __startTimestamp1455952467975__endTimestamp 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | ------- Summary: start ------- 23:14:27 INFO - PROCESS | 9854 | Number of tests: 14 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#0] ai-astar Cycles:10 Average:113.00 Median:112.00 stddev:4.08 (3.6%) stddev-sans-first:4.31 23:14:27 INFO - PROCESS | 9854 | Values: 112.0 107.0 115.0 112.0 114.0 123.0 112.0 111.0 112.0 112.0 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:154.50 stddev:15.10 (9.8%) stddev-sans-first:15.30 23:14:27 INFO - PROCESS | 9854 | Values: 158.0 126.0 153.0 157.0 127.0 153.0 156.0 134.0 163.0 126.0 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:3.89 (2.4%) stddev-sans-first:3.28 23:14:27 INFO - PROCESS | 9854 | Values: 172.0 167.0 162.0 165.0 162.0 163.0 162.0 165.0 172.0 163.0 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#3] audio-fft Cycles:10 Average:90.40 Median:74.00 stddev:34.32 (46.4%) stddev-sans-first:35.82 23:14:27 INFO - PROCESS | 9854 | Values: 73.0 74.0 74.0 156.0 74.0 73.0 76.0 74.0 155.0 75.0 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#4] audio-oscillator Cycles:10 Average:112.70 Median:97.00 stddev:24.85 (25.6%) stddev-sans-first:25.78 23:14:27 INFO - PROCESS | 9854 | Values: 98.0 98.0 147.0 97.0 98.0 97.0 148.0 96.0 97.0 151.0 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:116.00 stddev:1.62 (1.4%) stddev-sans-first:0.97 23:14:27 INFO - PROCESS | 9854 | Values: 120.0 116.0 118.0 116.0 115.0 116.0 116.0 115.0 115.0 115.0 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 23:14:27 INFO - PROCESS | 9854 | Values: 148.0 146.0 147.0 148.0 148.0 147.0 148.0 147.0 147.0 147.0 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 23:14:27 INFO - PROCESS | 9854 | Values: 97.0 97.0 97.0 97.0 97.0 98.0 96.0 96.0 98.0 97.0 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:60.50 stddev:2.60 (4.3%) stddev-sans-first:2.76 23:14:27 INFO - PROCESS | 9854 | Values: 60.0 61.0 59.0 59.0 61.0 60.0 58.0 66.0 61.0 56.0 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 23:14:27 INFO - PROCESS | 9854 | Values: 67.0 68.0 68.0 68.0 68.0 68.0 68.0 67.0 68.0 68.0 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:2.41 (2.9%) stddev-sans-first:2.49 23:14:27 INFO - PROCESS | 9854 | Values: 83.0 91.0 83.0 85.0 85.0 83.0 84.0 84.0 85.0 83.0 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:123.50 stddev:3.80 (3.1%) stddev-sans-first:3.87 23:14:27 INFO - PROCESS | 9854 | Values: 125.0 120.0 122.0 117.0 117.0 125.0 127.0 120.0 120.0 127.0 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:153.50 stddev:9.13 (5.9%) stddev-sans-first:8.86 23:14:27 INFO - PROCESS | 9854 | Values: 144.0 152.0 154.0 151.0 153.0 143.0 152.0 173.0 157.0 166.0 23:14:27 INFO - PROCESS | 9854 | 23:14:27 INFO - PROCESS | 9854 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:72.50 stddev:4.05 (5.6%) stddev-sans-first:4.06 23:14:27 INFO - PROCESS | 9854 | Values: 69.0 72.0 73.0 69.0 71.0 77.0 70.0 82.0 71.0 74.0 23:14:27 INFO - PROCESS | 9854 | -------- Summary: end -------- 23:14:27 INFO - PROCESS | 9854 | 23:14:28 INFO - TEST-INFO | 9854: exit 0 23:14:28 INFO - TEST-OK | kraken | took 60549ms 23:14:28 INFO - SUITE-END | took 1171s 23:14:29 INFO - Completed test suite (00:19:31) 23:14:29 INFO - Working with test: dromaeo_css 23:14:29 INFO - Generating results file: dromaeo_css 23:14:29 INFO - Working with test: kraken 23:14:29 INFO - Generating results file: kraken 23:14:29 INFO - javascript benchmark 23:14:29 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:14:29 INFO - process_Request line: dromaeo_css 6858.81 graph.html#tests=[[72,64,43]] 23:14:29 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:29 INFO - process_Request line: kraken 1549.00 graph.html#tests=[[232,64,43]] 23:14:29 INFO - RETURN: dromaeo_css: 6858.81 23:14:29 INFO - RETURN: kraken: 1549.00 23:14:29 INFO - javascript benchmark 23:14:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3186.490161574148, 3221.72615327697, 3233.110894504013, 3259.4621887388575, 3262.478003519436, 5207.5573576246015, 5215.530602245797, 5297.761600727967, 5307.389650190229, 5307.73461326934, 5248.396434410034, 5260.605454590911, 5313.628046036769, 5316.627836051478, 5329.360476742787, 4763.166445871967, 4791.811587001875, 4818.397700287464, 5030.37120359955, 5035.320231768719, 4864.14877396456, 4896.608271338302, 4944.060628480595, 4949.0, 4972.129877271481, 4808.206645903421, 4828.2274836026245, 4831.637627177975, 4863.076015557068, 4888.73111978841, 4830.058138662962, 4863.124637565237, 4868.805247790084, 4877.951220487821, 4923.58149557288, 4790.664653474259, 4817.349657796222, 4831.565159135695, 4846.418429788448, 4892.926606100911, 4965.32968049316, 5101.566366858821, 5102.0, 5116.513931176532, 5158.871028224287, 5625.38120806711, 5659.490645841853, 5672.9432705672825, 5673.8297851064535, 5676.744546495418, 5682.289713785777, 5705.486506214461, 5706.0, 5779.3642699303045, 5792.913106303409, 5307.65500242483, 5382.757775900094, 5401.108817045183, 5403.729813509309, 5406.864828379283, 5765.250517432707, 5779.046457334577, 5802.24570805801, 5821.38875418075, 5823.650580965155, 5504.0, 5546.029444847136, 5588.0779671354585, 5591.916121258185, 5638.661680299195, 5619.7471113799975, 5620.831375058755, 5624.859378515488, 5644.407337229614, 5649.830505084772, 5489.4236105209175, 5611.3266408031295, 5618.4662457066515, 5639.492445679908, 5640.210370548045, 5599.776008959678, 5626.634268772516, 5643.915341269884, 5675.120356344773, 5715.228444160069, 4348.7390756554705, 4385.890352741207, 4390.846320378771, 4396.802143903532, 4422.955770442254, 3899.083715326896, 3925.1757131002237, 3946.664533514626, 3963.3064213762477, 4031.7782521960985, 5321.3880403754065, 5340.599455040888, 5343.225232341289, 5351.491608297206, 5370.194470829329, 5662.37713851476, 5664.49019588239, 5668.206451096849, 5689.431056894277, 5716.42835716425, 5215.921761173586, 5292.788288468495, 5417.997670430983, 5418.972905135449, 5461.754221060062, 4869.805207791719, 4891.6575839691595, 4893.314935908976, 4895.730734809548, 4912.9508704913205, 5824.271966004249, 5922.082077278029, 5973.283206015306, 5976.402359763989, 5980.162777211194, 5642.7460764266525, 5659.179418984307, 5705.315362156568, 5711.143328500758, 5721.022710241949, 5835.387284335084, 5880.911786323123, 5910.202122713378, 5917.467427931335, 6004.309504406874, 5605.719714014202, 5637.887242255214, 5643.971780141073, 5669.092945128759, 5675.404082571271, 5612.691301978431, 5758.3090029196765, 5760.366359700513, 5763.279590051244, 5892.6759028253855, 5561.332640083216, 5587.944120558743, 5589.720513974204, 5608.579356548194, 5609.523190528687, 5572.693501857437, 5582.86042848932, 5584.497395234448, 5594.13290939905, 5609.663420194802, 5311.654742441729, 5461.672299662033, 5469.480399362054, 5503.477169668875, 5529.4470552944385, 5521.723913804213, 5561.360443549043, 5565.638233514808, 5572.582056345871, 5607.102863541813, 5368.060589396762, 5393.8921221574565, 5471.015217260931, 5494.780208791603, 5547.750351234124], "unit": "score", "name": "dojo.html", "value": 5251.584830584287}, {"lowerIsBetter": false, "replicates": [516.3133033066023, 518.1424742051905, 576.6367188671137, 580.7241560258877, 583.5360888093968, 35803.82098089509, 35938.820305898436, 35942.64057359425, 36103.09742256442, 36129.0967725807, 39232.80383598085, 39916.20167596646, 39992.80003599978, 40024.79987600058, 40220.597794022055, 8454.112318206577, 8641.179087986631, 8643.956780216091, 8656.480611163319, 8678.566071696421, 8557.144285571425, 8622.094680058597, 8721.12788721129, 8918.821623567525, 8934.4192627479, 8815.0, 8931.151540603632, 8948.776280593005, 8949.105089491064, 8975.057618950013, 8834.955825220864, 8860.911390886138, 8904.777380565472, 8924.286057115447, 8932.598033088527, 8643.222110010129, 8781.604827782765, 8802.823943521094, 8814.338924580617, 8816.250618697419, 39480.80259598684, 39821.0, 39932.20135597272, 39988.600683959055, 40038.79980600107, 3124.390743804959, 3199.3921154980712, 3245.6429792722784, 3251.5935508061493, 3794.6584807367194, 29993.400131997238, 30343.848280758677, 30932.536011959837, 30934.0, 31517.36965260705, 3875.961240387588, 4045.4943132108488, 4067.1662309226535, 4124.546299907008, 4125.731827431207, 248642.0, 248890.0, 251355.74322128456, 252157.0, 254600.0, 41183.79408103, 42015.159696806506, 42037.57962420398, 61146.08280875791, 61398.69300653468, 40065.0, 40454.1909161821, 40474.0, 40594.18811623751, 40718.796406017784, 14792.334344954503, 14807.629809254639, 14821.851781482263, 14903.850961490463, 14944.178070206026, 11938.761224775455, 11954.641360759191, 11960.40197990097, 11962.40187990597, 11985.820212696817, 14063.648408789863, 14098.083624564575, 14117.152970821784, 14167.645808854655, 14259.0, 5812.099124635688, 5886.440788125121, 5886.852828679317, 5935.584509084322, 5959.731812068468, 820.2986446588201, 821.34292565947, 834.3533761335013, 863.8401895649325, 869.3827382558454, 27230.183094507196, 27775.0, 27848.0, 28043.859780701376, 28175.0, 901.5041727050096, 913.4747520175792, 913.963441462334, 939.196986576481, 962.3744566032135, 13665.658358541115, 13709.862901371058, 13741.106828056145, 13868.306584670727, 13902.513412030732, 362413.0, 365600.71996400075, 366208.0, 366912.0, 369344.0, 52792.472075279526, 53265.2010219847, 53419.19871201935, 53463.0, 53690.0, 1337.2444568818587, 1356.982263302523, 1380.3098450774612, 1388.7500249955106, 1405.866442687943, 25565.3608659785, 26496.8675156623, 26514.469710606067, 26544.8672756635, 26795.598066028637, 47919.28121078257, 48539.27191092066, 48561.27158092702, 48838.26742598935, 48890.26664600105, 266491.0, 266697.0, 267418.0, 267557.0, 267934.0, 42122.78938605287, 42531.57468425276, 42615.10128913493, 42853.571464284956, 43307.35038974481, 45101.77449112733, 45411.318830216915, 45547.31679024751, 45769.313460298785, 46098.30852537282, 37134.0, 37555.43223393773, 38532.614673852906, 39252.803735981135, 39434.605653943094, 38738.532793972765, 38992.0, 39372.2125557493, 39930.60069399269, 40129.39805902856, 37411.06472338214, 37925.431118533794, 38326.80836595799, 38357.6164238354, 38444.0, 33327.166820829676, 34699.0, 35343.29313413769, 35665.64334356727, 38645.6135438642, 24996.500069998863, 25223.24330270095, 25510.617340740275, 25728.228153155436, 26011.0], "unit": "score", "name": "ext.html", "value": 17963.489718073182}, {"lowerIsBetter": false, "replicates": [363.718118458195, 367.15920541958917, 367.77198137154966, 368.8137490567264, 370.23176907916064, 16929.49211523653, 17272.74090888636, 17616.911915440436, 17957.820421795794, 18297.81702182978, 13432.865671343283, 16723.0, 16859.578510537212, 17002.319907203728, 17077.487675369728, 4852.078105160026, 4949.059678661061, 4995.225740010286, 5022.874428139307, 5055.696658200502, 4905.4849240829735, 5014.69911805291, 5030.522100400474, 5408.378036525791, 5422.376426710939, 5190.92213616796, 5275.920861187085, 5376.677399356032, 5383.084875571143, 5405.810796622119, 5275.129603615418, 5279.841604751864, 5294.973525132388, 5306.97346513265, 5325.334333208349, 5404.864978354551, 5413.458654134555, 5417.83746487606, 5420.268263784417, 5430.891382172374, 12501.874981250163, 18235.908820455945, 19450.610987780165, 19570.315038973567, 19610.215591376327, 2128.5955668423103, 2203.5262418580082, 2217.3347995601257, 2780.374415756459, 2786.289496178482, 9686.806263874683, 11795.0, 12593.496260149583, 12819.910307623863, 13055.738885222338, 1794.9910250448663, 1818.08186865632, 1839.8776746184817, 1854.8608854335978, 1872.4382685194523, 56968.715156423954, 58181.12728309079, 58445.41554584442, 58931.70534147302, 59725.70137149286, 10150.796984060426, 10453.738656533647, 10607.787844243072, 10740.087092597061, 10792.298500597437, 13004.934975325252, 13410.865891341156, 13507.459701612022, 13540.322983850769, 13941.442342306194, 7372.889406658905, 7578.469507134558, 7777.533347999138, 7838.8432231355055, 7901.209879012168, 7637.847243055107, 7712.845743085107, 7720.498167619086, 7726.188750181263, 7752.147263800977, 4370.278903980808, 4568.771561421916, 4624.260118381043, 4641.675082744243, 4671.929921051187, 1798.415514957618, 1864.1797609051973, 1869.7943226245102, 1908.961820763577, 1917.0893825432809, 772.6291380137453, 818.2022528035118, 831.4304701279643, 847.737201467547, 924.3390975452584, 16059.759103613454, 16459.094749788877, 16557.172141393123, 16685.582860428345, 16764.32942682279, 768.6348984232445, 830.2237408023517, 830.9086000539936, 860.7718954477068, 864.9048604653483, 9247.76880577991, 9571.473568953636, 9607.663731769355, 9732.659356922615, 9758.365706229073, 378161.5459613532, 381450.0, 385829.0, 388434.0, 390055.0, 64107.0, 66983.0, 67051.66474167598, 67828.3217167822, 69241.65379173071, 1020.7448137965508, 1049.9527521261562, 1063.2132222155549, 1066.9466526673634, 1073.7745073534488, 15106.622334441727, 15118.244087795347, 15196.924015379853, 15559.45541906028, 16168.757468638216, 31660.366792664478, 33049.669503305624, 33237.833810830794, 33748.831255843565, 33822.0, 35800.46299305461, 35862.820685896404, 38167.42748858825, 38532.42201367038, 39377.0, 7576.166621671501, 7743.728969486267, 7819.960900195462, 7849.803754906173, 7906.407019473678, 10984.231103822975, 11678.299302041905, 11888.643340699793, 12055.397230138282, 12285.385730713608, 9966.252531060054, 10046.598136074475, 10152.593896244067, 10216.693499195037, 10241.18070554339, 10064.345817521838, 10279.229057820543, 10634.84047739269, 10800.351978880977, 10951.740549836872, 10268.743281417725, 10434.68695939123, 10600.0989915858, 10735.302205356627, 10781.676549703521, 7586.56846835601, 7773.883391749241, 7807.609619519115, 7817.452778305464, 7851.882221766564, 8671.479711217347, 10108.292419530562, 10303.587856485656, 10346.430946297725, 10476.476176191007], "unit": "score", "name": "jquery.html", "value": 8194.070847897858}, {"lowerIsBetter": false, "replicates": [1484.450753221308, 1499.0780669888018, 1647.2916645842283, 1753.088394035101, 1790.7134858422655, 6814.965925170367, 7453.105627324715, 7952.244536769005, 8138.14549472305, 8166.877496837552, 7928.801779955504, 7961.681532738698, 8031.237032481905, 8048.798780030487, 8061.3550915926735, 2294.1052989334216, 2343.2618725101624, 2346.2843832631042, 2351.7413084560685, 2352.3883790214495, 2296.7243930728337, 2313.097891822191, 2315.837891347598, 2316.7683231676865, 2323.3030090972725, 2276.635738281875, 2284.2804516577307, 2290.118304452781, 2336.5093330400637, 2337.333859849943, 2322.9651555226687, 2355.6584295277175, 2361.633946738258, 2378.191414918919, 2379.2029670060465, 2346.7301260355107, 2393.8922748476184, 2395.2694428199393, 2407.3500154958238, 2409.0363854458183, 8129.268365847102, 8154.551499667516, 8165.2243036911395, 8222.465539739958, 8238.134995825472, 4602.286645569942, 4720.952790472085, 4723.173444647173, 4725.1022305762135, 4748.216544270192, 3040.3463255400197, 3096.210466331094, 3145.2294187923876, 3150.6691797361177, 3185.394774992744, 998.1864780204183, 998.3710262534629, 1012.4026824173773, 1022.156720705421, 1052.4264275969615, 10829.133669306437, 10838.349699018085, 10940.015398614083, 10972.615958441416, 11049.558017679283, 3997.540282867449, 4116.3619638955415, 4126.42230087788, 4154.646855017297, 4219.746815191037, 8533.914660853436, 8765.561721913879, 8768.342374321952, 8787.516686582172, 8802.515861627671, 4768.809247630056, 4768.856934291976, 4783.736894470768, 4785.210440277316, 4789.856304310876, 3893.7858417787293, 4312.698111132253, 4338.349247612883, 4372.300431930939, 4400.735955842596, 3468.809215493172, 3490.110021944388, 3521.7182625389905, 3531.52324436203, 3547.467879817996, 992.5434300221979, 1027.5324727249083, 1049.6221360310283, 1057.2757661002238, 1059.5338051257422, 1248.3446190749928, 1249.0694432647736, 1250.3810613746073, 1261.8422697162855, 1273.9171953822972, 7282.453815963824, 7297.233790451926, 7401.0748656417945, 7442.479026468095, 7466.775996720107, 447.43176166268654, 448.3387004168825, 451.3410420785624, 457.06986282914113, 465.9277811939155, 5514.558835293167, 5555.916661250085, 5561.388247292794, 5567.387587365387, 5583.581231407661, 9653.276004299705, 9742.46416447088, 10088.69733907984, 10092.394456332497, 10152.898471015194, 9777.315587908779, 9878.802423951482, 9903.702888913343, 9910.851337229948, 9946.35348702332, 7096.432285417154, 7231.855362892713, 7253.165885923081, 7308.853822923512, 7518.360939320219, 7486.663100160615, 7528.51064680794, 7534.698612055457, 7552.886706699294, 7554.206808285051, 8592.183742544448, 8802.163794439519, 8813.559322034002, 8959.104089590988, 8966.193042626195, 8800.207981281716, 8832.91167088321, 8847.69033083839, 8964.865527017231, 8998.14517620825, 7011.964940175267, 7219.0, 7224.060872086595, 7261.0, 7402.6668799903055, 7682.7311044113185, 7709.151993280847, 7752.844943100994, 7760.029996250469, 7785.844283114193, 6843.349881761224, 7075.115610548682, 7095.751648692271, 7180.533265337736, 7216.9639151806, 6527.967360163168, 6575.27671956094, 6680.298568650222, 6739.93260067393, 6848.0, 6911.827204319932, 7088.893666594902, 7135.750248741269, 7163.964180179066, 7184.46116541251, 6360.968195158995, 6373.5857169283845, 6374.139491168633, 6450.774222902176, 6462.612243265419, 6438.163038804925, 6459.741610335722, 6545.280019197789, 6581.111549940888, 6584.0], "unit": "score", "name": "mootools.html", "value": 4436.65628895198}, {"lowerIsBetter": false, "replicates": [327.1314659578818, 334.7271973341726, 337.4112174255923, 340.0309119010821, 342.5598106433232, 6209.782657606985, 6237.251529816423, 6327.335629758878, 6345.079963405304, 6363.236411630611, 6190.0, 6197.977333739927, 6236.968815155918, 6262.655553944532, 6283.277423096345, 4780.426348838144, 4787.8324258650955, 4788.449328327252, 4788.640851936101, 4791.736454495001, 4785.928211076836, 4791.952080479203, 4793.304970779235, 4805.0389922015565, 4805.591524720386, 4660.37084993525, 4729.952700472985, 4731.5268473152755, 4739.786709598059, 4744.620430365562, 4663.976680116594, 4667.5332466753225, 4676.251799712047, 4689.2966055091665, 4721.244600863845, 4049.8785036448953, 4080.6939479539155, 4095.467589213413, 4097.795110244476, 4103.610157035077, 5918.7928422505, 5963.970180149115, 5972.313183983854, 5981.0729336952845, 5987.670678112702, 5412.648177868426, 5540.030494663458, 5541.639793413456, 5542.8337149885565, 5543.057680194376, 6633.734650613969, 6634.369734875179, 6670.266270710218, 6677.165354330708, 6686.231083425371, 4498.190325741365, 4501.437320334958, 4540.818367265306, 4555.362249285103, 4569.246074397721, 6766.594004359705, 6850.931490685129, 6935.965320173367, 6938.861222775517, 6938.895916561205, 4565.0, 4577.29051996941, 4584.381108550369, 4596.931046034312, 4608.723476591415, 4646.4888862225125, 4647.140279048387, 4648.186567350767, 4665.790039448233, 4671.883202919954, 5452.04589196889, 5452.182172674131, 5452.2094296327605, 5452.345718513804, 5454.563634909197, 6467.838304042342, 6668.599884006878, 6694.062831203635, 6704.4301234395625, 6715.865682686416, 1607.9839201607833, 1615.1439736939442, 1647.8846480746233, 1649.892756970793, 1650.8596769274507, 1078.697964569906, 1087.2280680716622, 1094.261373572835, 1099.6536091131268, 1103.7626910214342, 6145.692715364214, 6254.21822272216, 6263.3736626337, 6288.402601752826, 6304.275008374096, 6790.490713196431, 6790.966045169841, 6801.591904485746, 6815.965920170466, 6816.931830681629, 6116.541259405562, 6218.9378106219265, 6247.531435142382, 6248.375162483715, 6255.0617407388345, 3693.9630603693618, 3705.814709264526, 3711.3319602471815, 3712.1833196696684, 3720.627937206312, 7096.787096387116, 7123.43012558994, 7137.750178743719, 7141.107361579802, 7145.285471452813, 6795.2185498667295, 6916.688749006306, 6941.548799328028, 6972.442204623618, 6988.126484189476, 6988.580685158907, 7045.718171273092, 7046.6476676165985, 7055.800513912647, 7091.078159839188, 6727.73089076451, 6774.0, 6776.390124888587, 6797.0, 6808.489363297674, 6549.312322206099, 6674.933250667431, 6746.8650626988165, 6746.898796517958, 6749.595024298558, 7086.114235720535, 7165.176004759519, 7170.89243661356, 7176.21061683204, 7181.892271616034, 4533.931991020071, 4549.135664223787, 4562.064776720698, 4570.085982803519, 4582.289745089383, 6736.5958042517605, 6748.797536073926, 6785.796426107225, 6791.456683465212, 6951.582905025714, 6691.933080669131, 6737.494687898329, 6753.932460675527, 6761.966190169018, 6765.188177418741, 6738.561993470409, 6781.593104413751, 6793.116894803841, 6814.352636499525, 6830.146231721035, 6488.610683359014, 6547.70535325902, 6608.7356505739235, 6622.403983641495, 6628.403443690091, 6720.6975686093265, 6733.696983635846, 6748.662566871735, 6760.966195168992, 6787.728490860311, 6514.250861150838, 6551.082848401133, 6583.868322633616, 6586.242582102927, 6599.8020059398295], "unit": "score", "name": "prototype.html", "value": 4972.307722931175}, {"lowerIsBetter": false, "replicates": [700.9964950175248, 717.998392242821, 767.0488594143264, 772.8956590860232, 775.1357236681099, 13175.20948743076, 13330.066895317308, 13332.466701331936, 13393.0, 13422.66443338917, 12075.97354224892, 12151.453184606691, 12159.696007599814, 12180.330081845495, 12200.511979520808, 802.7511471443856, 811.9350451963828, 819.3608984991716, 819.8073452738602, 821.7165078048064, 813.3371302388564, 823.5799742131496, 827.5448503323179, 838.0781140745192, 841.1798496465958, 883.3419102768446, 884.849575572151, 889.0798024045115, 891.5319457284912, 892.0677891603258, 874.8337815815007, 883.041899539001, 883.337496877342, 886.8492356299445, 888.0764005434405, 646.0922404022356, 650.7266947881901, 652.92164940207, 653.0432915778407, 654.5483616304782, 13623.455061797516, 14013.369398377097, 14022.298885055707, 14024.088434251844, 14031.579052628438, 11960.820587691105, 12267.631971040882, 12399.876001239962, 12489.313087780169, 12940.741185176337, 10478.10936070435, 10581.470926453647, 10692.144628429707, 10694.037536621663, 10744.0, 3419.863205471778, 3439.1402149462633, 3453.015890471204, 3563.6080031196548, 3581.982090089559, 45191.322130168075, 46523.76738116288, 48976.510234897905, 49103.75448122772, 49637.50362496365, 8986.19124278818, 9429.347283509478, 9758.902410975941, 9819.9018009819, 9847.704568862946, 16924.661506769797, 16960.660786784443, 17018.48944531666, 17024.48926532206, 17025.659486810193, 7555.924440755632, 7576.052993375828, 7654.00497935276, 7699.576523291161, 7754.3796496280165, 4205.285101532747, 4297.312430011183, 4329.112531930947, 4402.339649052604, 4543.295789152687, 3145.795523290979, 3183.793053451518, 3185.952210716841, 3186.76099292554, 3202.503611940153, 611.9388061193845, 614.8585825260126, 616.7317217010615, 624.3912185618985, 635.7107516080265, 454.07822121094233, 521.3587287636228, 564.6950646650845, 564.7035306464139, 575.8099827057144, 7190.820229494305, 7254.709811607582, 7621.7782158109685, 7656.119546252141, 7968.482048666818, 466.8412739668529, 567.8182981445898, 576.8154190659033, 611.9143319935213, 627.1502114634695, 3464.4110501214855, 3513.5432393789156, 3931.1941052084826, 4062.6749860011128, 4123.195976784558, 53653.195202072, 57126.0, 58162.0, 58254.0, 58307.70846145742, 50285.0, 50713.74643126761, 50849.49150508447, 50976.49023509792, 51051.0, 45583.77208113938, 45819.31271030937, 46251.0, 46256.074878502244, 47093.76453117713, 8018.959905200437, 8224.917750822415, 8277.668893244203, 8642.78393040179, 8646.351523635878, 30952.69047309498, 31835.20411989719, 32476.350472990882, 33697.66302336945, 35440.29119417546, 41241.793791030854, 43102.35346469868, 43118.35322470103, 43835.342469863615, 45770.0, 10425.791484170122, 10477.528511217166, 10751.946240268748, 10907.29102608328, 10914.727131821768, 10874.184436167161, 10938.12495000414, 11178.441077946232, 11220.495077721685, 11442.199046066695, 9623.615055397986, 9775.75560610962, 9822.21422286201, 9873.0, 10145.847812282675, 10493.0, 10552.261341706315, 10627.574897004033, 10817.783644326912, 11054.723631909266, 9073.909260907307, 9538.427694338361, 10085.445300508543, 10768.3538987661, 10803.135749140207, 8347.749567512985, 8493.957530212308, 8560.443571167854, 8570.442921210102, 8782.868256976279, 8289.626966786629, 9144.634214631606, 9172.174504294646, 9358.88097750954, 9627.277954153607], "unit": "score", "name": "yui.html", "value": 6104.678237613825}], "name": "dromaeo_css", "value": 6858.812787037204}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 115.0, 112.0, 114.0, 123.0, 112.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [158.0, 126.0, 153.0, 157.0, 127.0, 153.0, 156.0, 134.0, 163.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [172.0, 167.0, 162.0, 165.0, 162.0, 163.0, 162.0, 165.0, 172.0, 163.0], "unit": "score", "name": "audio-dft", "value": 165.3}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 74.0, 156.0, 74.0, 73.0, 76.0, 74.0, 155.0, 75.0], "unit": "score", "name": "audio-fft", "value": 90.4}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 147.0, 97.0, 98.0, 97.0, 148.0, 96.0, 97.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 112.7}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 118.0, 116.0, 115.0, 116.0, 116.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.2}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 97.0, 98.0, 96.0, 96.0, 98.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 59.0, 59.0, 61.0, 60.0, 58.0, 66.0, 61.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 83.0, 85.0, 85.0, 83.0, 84.0, 84.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [125.0, 120.0, 122.0, 117.0, 117.0, 125.0, 127.0, 120.0, 120.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [144.0, 152.0, 154.0, 151.0, 153.0, 143.0, 152.0, 173.0, 157.0, 166.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.5}, {"lowerIsBetter": true, "replicates": [69.0, 72.0, 73.0, 69.0, 71.0, 77.0, 70.0, 82.0, 71.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.8}], "name": "kraken", "value": 1548.9999999999998}]} 23:14:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1549.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6858.81"}}} 23:14:29 INFO - Return code: 0 23:14:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:14:29 ERROR - # TBPL SUCCESS # 23:14:29 INFO - Running post-action listener: _resource_record_post_action 23:14:29 INFO - Running post-run listener: _resource_record_post_run 23:14:30 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 538968064; Read time: 0; Write time: 402472 23:14:30 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240553984; Read time: 0; Write time: 212100 23:14:30 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 298414080; Read time: 0; Write time: 190372 23:14:30 INFO - Running post-run listener: _upload_blobber_files 23:14:30 INFO - Blob upload gear active. 23:14:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:14:30 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 23:14:30 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'] 23:14:30 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 23:14:30 INFO - (blobuploader) - INFO - Open directory for files ... 23:14:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:14:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:14:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:31 INFO - (blobuploader) - INFO - Done attempting. 23:14:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:14:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:14:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:32 INFO - (blobuploader) - INFO - Done attempting. 23:14:32 INFO - (blobuploader) - INFO - Iteration through files over. 23:14:32 INFO - Return code: 0 23:14:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:14:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:14:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edce40af7b8ac497b2d36256768fbb711657c8880240254f9553a5bb9c77885f8443369a3d9c0575c31de05c5516b1cd0918435355d7d16d455b6ed0524a605c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ac46c57ed3acd9eed2bcce9df3148894f08b0541ecaf8f5047f91cb0b80d77bb6fb1bb2134427df7f4c3161224e248b3ad1cdd15629ed8d7786442830547993"} 23:14:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:14:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:14:32 INFO - Contents: 23:14:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edce40af7b8ac497b2d36256768fbb711657c8880240254f9553a5bb9c77885f8443369a3d9c0575c31de05c5516b1cd0918435355d7d16d455b6ed0524a605c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ac46c57ed3acd9eed2bcce9df3148894f08b0541ecaf8f5047f91cb0b80d77bb6fb1bb2134427df7f4c3161224e248b3ad1cdd15629ed8d7786442830547993"} 23:14:32 INFO - Running post-run listener: copy_logs_to_upload_dir 23:14:32 INFO - Copying logs to upload dir... 23:14:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:14:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.725816 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-02-19 23:14:32.112808) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 23:14:32.116765) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edce40af7b8ac497b2d36256768fbb711657c8880240254f9553a5bb9c77885f8443369a3d9c0575c31de05c5516b1cd0918435355d7d16d455b6ed0524a605c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ac46c57ed3acd9eed2bcce9df3148894f08b0541ecaf8f5047f91cb0b80d77bb6fb1bb2134427df7f4c3161224e248b3ad1cdd15629ed8d7786442830547993"} build_url:https://queue.taskcluster.net/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/CmaKQE_LQVuMiZrW3WyF_g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edce40af7b8ac497b2d36256768fbb711657c8880240254f9553a5bb9c77885f8443369a3d9c0575c31de05c5516b1cd0918435355d7d16d455b6ed0524a605c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ac46c57ed3acd9eed2bcce9df3148894f08b0541ecaf8f5047f91cb0b80d77bb6fb1bb2134427df7f4c3161224e248b3ad1cdd15629ed8d7786442830547993"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 23:14:32.142112) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 23:14:32.142471) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1455950086.805809-1582394395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 23:14:32.225180) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 23:14:32.225497) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 23:14:32.225778) ========= ========= Total master_lag: 0.27 =========