builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1460613493.76 results: success (0) buildid: 20160413203320 builduid: 81d3cbbf98474814b13fbd2df61402dd revision: 52ebea10c080da799bc43150e261e043ba824f5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:13.759102) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:13.759943) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:13.760331) ========= 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-1460612528.810122-2029278502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006381 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:13.789415) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:13.789734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:13.828702) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:13.829003) ========= 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-1460612528.810122-2029278502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:13.881108) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:13.881434) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:13.881853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:13.882191) ========= 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-1460612528.810122-2029278502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 22:58:14-- 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% 94.6M=0s 2016-04-13 22:58:14 (94.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174464 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:14.071585) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:14.071951) ========= 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-1460612528.810122-2029278502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015396 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:14.122623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:14.123041) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 52ebea10c080da799bc43150e261e043ba824f5b --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 52ebea10c080da799bc43150e261e043ba824f5b --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-1460612528.810122-2029278502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 22:58:14,291 truncating revision to first 12 chars 2016-04-13 22:58:14,291 Setting DEBUG logging. 2016-04-13 22:58:14,291 attempt 1/10 2016-04-13 22:58:14,291 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/52ebea10c080?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 22:58:14,730 unpacking tar archive at: fx-team-52ebea10c080/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720561 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:14.861993) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:14.862430) ========= echo 52ebea10c080da799bc43150e261e043ba824f5b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'52ebea10c080da799bc43150e261e043ba824f5b'] 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-1460612528.810122-2029278502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 52ebea10c080da799bc43150e261e043ba824f5b program finished with exit code 0 elapsedTime=0.004726 script_repo_revision: '52ebea10c080da799bc43150e261e043ba824f5b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:14.915268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:14.915624) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 22:58:14.926200) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-13 22:58:14.926518) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1460612528.810122-2029278502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:58:15 INFO - MultiFileLogger online at 20160413 22:58:15 in /builds/slave/test-pgo 22:58:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:58:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:58:15 INFO - {'append_to_log': False, 22:58:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:58:15 INFO - 'blob_upload_branch': 'Fx-Team', 22:58:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:58:15 INFO - 'branch': 'Fx-Team', 22:58:15 INFO - 'buildbot_json_path': 'buildprops.json', 22:58:15 INFO - 'config_files': ('talos/linux_config.py',), 22:58:15 INFO - 'default_actions': ('clobber', 22:58:15 INFO - 'read-buildbot-config', 22:58:15 INFO - 'download-and-extract', 22:58:15 INFO - 'populate-webroot', 22:58:15 INFO - 'create-virtualenv', 22:58:15 INFO - 'install', 22:58:15 INFO - 'run-tests'), 22:58:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:58:15 INFO - 'download_minidump_stackwalk': True, 22:58:15 INFO - 'download_symbols': 'ondemand', 22:58:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:58:15 INFO - 'tooltool.py': '/tools/tooltool.py', 22:58:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:58:15 INFO - '/tools/misc-python/virtualenv.py')}, 22:58:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:58:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:58:15 INFO - 'installer_path': 'installer.exe', 22:58:15 INFO - 'log_level': 'info', 22:58:15 INFO - 'log_name': 'talos', 22:58:15 INFO - 'log_to_console': True, 22:58:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:58:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:58:15 INFO - 'opt_config_files': (), 22:58:15 INFO - 'pip_index': False, 22:58:15 INFO - 'sps_profile': False, 22:58:15 INFO - 'sps_profile_interval': 0, 22:58:15 INFO - 'suite': 'dromaeojs', 22:58:15 INFO - 'system_bits': '32', 22:58:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:58:15 INFO - 'title': 'talos-linux64-ix-001', 22:58:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:58:15 INFO - 'use_talos_json': True, 22:58:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:58:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:58:15 INFO - 'work_dir': 'build'} 22:58:15 INFO - ##### 22:58:15 INFO - ##### Running clobber step. 22:58:15 INFO - ##### 22:58:15 INFO - Running pre-action listener: _resource_record_pre_action 22:58:15 INFO - Running main action method: clobber 22:58:15 INFO - rmtree: /builds/slave/test-pgo/build 22:58:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:58:16 INFO - Running post-action listener: _resource_record_post_action 22:58:16 INFO - ##### 22:58:16 INFO - ##### Running read-buildbot-config step. 22:58:16 INFO - ##### 22:58:16 INFO - Running pre-action listener: _resource_record_pre_action 22:58:16 INFO - Running main action method: read_buildbot_config 22:58:16 INFO - Using buildbot properties: 22:58:16 INFO - { 22:58:16 INFO - "project": "", 22:58:16 INFO - "product": "firefox", 22:58:16 INFO - "script_repo_revision": "production", 22:58:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:58:16 INFO - "repository": "", 22:58:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:58:16 INFO - "buildid": "20160413203320", 22:58:16 INFO - "pgo_build": "True", 22:58:16 INFO - "basedir": "/builds/slave/test-pgo", 22:58:16 INFO - "buildnumber": 1096, 22:58:16 INFO - "slavename": "talos-linux64-ix-001", 22:58:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:58:16 INFO - "platform": "ubuntu64_hw", 22:58:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:58:16 INFO - "branch": "fx-team", 22:58:16 INFO - "repo_path": "integration/fx-team", 22:58:16 INFO - "revision": "52ebea10c080da799bc43150e261e043ba824f5b", 22:58:16 INFO - "stage_platform": "linux64-pgo", 22:58:16 INFO - "builduid": "81d3cbbf98474814b13fbd2df61402dd", 22:58:16 INFO - "slavebuilddir": "test" 22:58:16 INFO - } 22:58:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:58:16 INFO - Running post-action listener: _resource_record_post_action 22:58:16 INFO - ##### 22:58:16 INFO - ##### Running download-and-extract step. 22:58:16 INFO - ##### 22:58:16 INFO - Running pre-action listener: _resource_record_pre_action 22:58:16 INFO - Running main action method: download_and_extract 22:58:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:16 INFO - https://queue.taskcluster.net/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:58:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:58:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:58:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:58:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:58:19 INFO - Downloaded 1361 bytes. 22:58:19 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:58:19 INFO - Using the following test package requirements: 22:58:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:58:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:58:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:19 INFO - u'jsshell-linux-x86_64.zip'], 22:58:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:58:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:58:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:58:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:58:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:58:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:58:19 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:58:19 INFO - https://queue.taskcluster.net/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:58:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:58:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:58:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:58:20 INFO - Downloaded 23774585 bytes. 22:58:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:58:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:58:21 INFO - Return code: 0 22:58:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:58: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:58:21 INFO - https://queue.taskcluster.net/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:58:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:58:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:58:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:58:24 INFO - Downloaded 23774585 bytes. 22:58:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:58:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:58:25 INFO - Return code: 0 22:58:25 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:58:25 INFO - https://queue.taskcluster.net/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:58:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:58:26 INFO - Downloaded 10841076 bytes. 22:58:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:58:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:58:26 INFO - Return code: 0 22:58: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:58:26 INFO - https://queue.taskcluster.net/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:58:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:58:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:58:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:58:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:58:29 INFO - Downloaded 57903428 bytes. 22:58:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:58:29 INFO - mkdir: /builds/slave/test-pgo/properties 22:58:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:58:29 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:58:29 INFO - Contents: 22:58:29 INFO - build_url:https://queue.taskcluster.net/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:58:29 INFO - Running post-action listener: _resource_record_post_action 22:58:29 INFO - Running post-action listener: set_extra_try_arguments 22:58:29 INFO - ##### 22:58:29 INFO - ##### Running populate-webroot step. 22:58:29 INFO - ##### 22:58:29 INFO - Running pre-action listener: _resource_record_pre_action 22:58:29 INFO - Running main action method: populate_webroot 22:58:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:58:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:58:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:58:29 INFO - '--tppagecycles', 22:58:29 INFO - '7'], 22:58:29 INFO - 'tests': ['tsvgm']}}, 22:58:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:58:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:58:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:58:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:58:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:58:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:58:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:29 INFO - 'talos_options': ['--disable-e10s'], 22:58:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:29 INFO - 'talos_options': ['--disable-e10s'], 22:58:29 INFO - 'tests': ['damp', 'tps']}, 22:58:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:29 INFO - 'tests': ['damp', 'tps']}, 22:58:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:58:29 INFO - 'tests': ['dromaeo_dom']}, 22:58:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:58:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:58:29 INFO - 'tests': ['a11yr', 22:58:29 INFO - 'ts_paint', 22:58:29 INFO - 'tpaint', 22:58:29 INFO - 'sessionrestore', 22:58:29 INFO - 'sessionrestore_no_auto_restore', 22:58:29 INFO - 'tabpaint']}, 22:58:29 INFO - 'other-e10s': {'tests': ['a11yr', 22:58:29 INFO - 'ts_paint', 22:58:29 INFO - 'tpaint', 22:58:29 INFO - 'sessionrestore', 22:58:29 INFO - 'sessionrestore_no_auto_restore', 22:58:29 INFO - 'tabpaint']}, 22:58:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:58:29 INFO - 'ts_paint', 22:58:29 INFO - 'tpaint', 22:58:29 INFO - 'sessionrestore', 22:58:29 INFO - 'sessionrestore_no_auto_restore', 22:58:29 INFO - 'tabpaint']}, 22:58:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:58:29 INFO - 'ts_paint', 22:58:29 INFO - 'tpaint', 22:58:29 INFO - 'sessionrestore', 22:58:29 INFO - 'sessionrestore_no_auto_restore', 22:58:29 INFO - 'tabpaint']}, 22:58:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:58:29 INFO - 'tests': ['a11yr', 22:58:29 INFO - 'ts_paint', 22:58:29 INFO - 'tpaint', 22:58:29 INFO - 'sessionrestore', 22:58:29 INFO - 'sessionrestore_no_auto_restore', 22:58:29 INFO - 'tabpaint']}, 22:58:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:58:29 INFO - 'tests': ['a11yr', 22:58:29 INFO - 'ts_paint', 22:58:29 INFO - 'tpaint', 22:58:29 INFO - 'sessionrestore', 22:58:29 INFO - 'sessionrestore_no_auto_restore', 22:58:29 INFO - 'tabpaint']}, 22:58:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:58:29 INFO - 'tests': ['tsvgx', 22:58:29 INFO - 'tsvgr_opacity', 22:58:29 INFO - 'tart', 22:58:29 INFO - 'tscrollx', 22:58:29 INFO - 'cart']}, 22:58:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:58:29 INFO - 'tsvgr_opacity', 22:58:29 INFO - 'tart', 22:58:29 INFO - 'tscrollx', 22:58:29 INFO - 'cart']}, 22:58:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:29 INFO - 'talos_options': ['--disable-e10s'], 22:58:29 INFO - 'tests': ['tp5o']}, 22:58:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:29 INFO - 'tests': ['tp5o']}, 22:58:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:29 INFO - 'talos_options': ['--disable-e10s', 22:58:29 INFO - '--xperf_path', 22:58:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:29 INFO - 'tests': ['tp5n']}, 22:58:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:29 INFO - 'talos_options': ['--xperf_path', 22:58:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:29 INFO - 'tests': ['tp5n']}}, 22:58:29 INFO - 'talos.zip': {'path': '', 22:58:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:58:29 INFO - Running post-action listener: _resource_record_post_action 22:58:29 INFO - ##### 22:58:29 INFO - ##### Running create-virtualenv step. 22:58:29 INFO - ##### 22:58:29 INFO - Running pre-action listener: _resource_record_pre_action 22:58:29 INFO - Running main action method: create_virtualenv 22:58:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:58:29 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:58:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:58:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:58:29 INFO - Using real prefix '/usr' 22:58:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:58:30 INFO - Installing distribute.............................................................................................................................................................................................done. 22:58:32 INFO - Installing pip.................done. 22:58:32 INFO - Return code: 0 22:58:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:32 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 0x7f499f613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e41d0>, '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 0x20e7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e7be0>, '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-1460612528.810122-2029278502', '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:58:32 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:58:32 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:58:32 INFO - Using env: {'DISPLAY': ':0', 22:58:32 INFO - 'HOME': '/home/cltbld', 22:58:32 INFO - 'LANG': 'en_US.UTF-8', 22:58:32 INFO - 'LANGUAGE': 'en_US:en', 22:58:32 INFO - 'LOGNAME': 'cltbld', 22:58:32 INFO - 'MAIL': '/var/mail/cltbld', 22:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:32 INFO - 'MOZ_NO_REMOTE': '1', 22:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:32 INFO - 'NO_EM_RESTART': '1', 22:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:32 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:32 INFO - 'SHELL': '/bin/bash', 22:58:32 INFO - 'SHLVL': '1', 22:58:32 INFO - 'TERM': 'linux', 22:58:32 INFO - 'TMOUT': '86400', 22:58:32 INFO - 'USER': 'cltbld', 22:58:32 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460612528.810122-2029278502', 22:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:32 INFO - '_': '/tools/buildbot/bin/python'} 22:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:32 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:58:32 INFO - Cleaning up... 22:58:32 INFO - Return code: 0 22:58:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:32 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 0x7f499f613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e41d0>, '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 0x20e7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e7be0>, '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-1460612528.810122-2029278502', '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:58:32 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:58:32 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:58:32 INFO - Using env: {'DISPLAY': ':0', 22:58:32 INFO - 'HOME': '/home/cltbld', 22:58:32 INFO - 'LANG': 'en_US.UTF-8', 22:58:32 INFO - 'LANGUAGE': 'en_US:en', 22:58:32 INFO - 'LOGNAME': 'cltbld', 22:58:32 INFO - 'MAIL': '/var/mail/cltbld', 22:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:32 INFO - 'MOZ_NO_REMOTE': '1', 22:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:32 INFO - 'NO_EM_RESTART': '1', 22:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:32 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:32 INFO - 'SHELL': '/bin/bash', 22:58:32 INFO - 'SHLVL': '1', 22:58:32 INFO - 'TERM': 'linux', 22:58:32 INFO - 'TMOUT': '86400', 22:58:32 INFO - 'USER': 'cltbld', 22:58:32 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460612528.810122-2029278502', 22:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:32 INFO - '_': '/tools/buildbot/bin/python'} 22:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:32 INFO - Downloading/unpacking psutil>=0.7.1 22:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:58:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:58:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:58:34 INFO - Installing collected packages: psutil 22:58:34 INFO - Running setup.py install for psutil 22:58:34 INFO - building 'psutil._psutil_linux' extension 22:58:34 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:58:35 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:58:35 INFO - building 'psutil._psutil_posix' extension 22:58:35 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:58:35 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:58:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:58:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:58:35 INFO - Successfully installed psutil 22:58:35 INFO - Cleaning up... 22:58:35 INFO - Return code: 0 22:58:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:58:35 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:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:35 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:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:35 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 0x7f499f613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e41d0>, '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 0x20e7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e7be0>, '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-1460612528.810122-2029278502', '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:58:35 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:58:35 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:58:35 INFO - Using env: {'DISPLAY': ':0', 22:58:35 INFO - 'HOME': '/home/cltbld', 22:58:35 INFO - 'LANG': 'en_US.UTF-8', 22:58:35 INFO - 'LANGUAGE': 'en_US:en', 22:58:35 INFO - 'LOGNAME': 'cltbld', 22:58:35 INFO - 'MAIL': '/var/mail/cltbld', 22:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:35 INFO - 'MOZ_NO_REMOTE': '1', 22:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:35 INFO - 'NO_EM_RESTART': '1', 22:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:35 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:35 INFO - 'SHELL': '/bin/bash', 22:58:35 INFO - 'SHLVL': '1', 22:58:35 INFO - 'TERM': 'linux', 22:58:35 INFO - 'TMOUT': '86400', 22:58:35 INFO - 'USER': 'cltbld', 22:58:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460612528.810122-2029278502', 22:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:35 INFO - '_': '/tools/buildbot/bin/python'} 22:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:58:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:58:37 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:58:37 INFO - Installing collected packages: mozsystemmonitor 22:58:37 INFO - Running setup.py install for mozsystemmonitor 22:58:37 INFO - Successfully installed mozsystemmonitor 22:58:37 INFO - Cleaning up... 22:58:37 INFO - Return code: 0 22:58:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:58:37 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:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:37 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:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:37 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 0x7f499f613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e41d0>, '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 0x20e7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e7be0>, '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-1460612528.810122-2029278502', '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:58:37 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:58:37 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:58:37 INFO - Using env: {'DISPLAY': ':0', 22:58:37 INFO - 'HOME': '/home/cltbld', 22:58:37 INFO - 'LANG': 'en_US.UTF-8', 22:58:37 INFO - 'LANGUAGE': 'en_US:en', 22:58:37 INFO - 'LOGNAME': 'cltbld', 22:58:37 INFO - 'MAIL': '/var/mail/cltbld', 22:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:37 INFO - 'MOZ_NO_REMOTE': '1', 22:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:37 INFO - 'NO_EM_RESTART': '1', 22:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:37 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:37 INFO - 'SHELL': '/bin/bash', 22:58:37 INFO - 'SHLVL': '1', 22:58:37 INFO - 'TERM': 'linux', 22:58:37 INFO - 'TMOUT': '86400', 22:58:37 INFO - 'USER': 'cltbld', 22:58:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460612528.810122-2029278502', 22:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:37 INFO - '_': '/tools/buildbot/bin/python'} 22:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:38 INFO - Downloading/unpacking blobuploader==1.2.4 22:58: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:58: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:58: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:58: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:58: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:58: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:58:39 INFO - Downloading blobuploader-1.2.4.tar.gz 22:58:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:58:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:58:39 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:58:39 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:58:39 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:58:39 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:58:39 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:58:39 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:58:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:58:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:40 INFO - Downloading docopt-0.6.1.tar.gz 22:58:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:58:40 INFO - Installing collected packages: blobuploader, requests, docopt 22:58:40 INFO - Running setup.py install for blobuploader 22:58:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:58:40 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:58:40 INFO - Running setup.py install for requests 22:58:41 INFO - Running setup.py install for docopt 22:58:41 INFO - Successfully installed blobuploader requests docopt 22:58:41 INFO - Cleaning up... 22:58:41 INFO - Return code: 0 22:58:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:41 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 0x7f499f613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e41d0>, '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 0x20e7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e7be0>, '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-1460612528.810122-2029278502', '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:58:41 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:58:41 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:58:41 INFO - Using env: {'DISPLAY': ':0', 22:58:41 INFO - 'HOME': '/home/cltbld', 22:58:41 INFO - 'LANG': 'en_US.UTF-8', 22:58:41 INFO - 'LANGUAGE': 'en_US:en', 22:58:41 INFO - 'LOGNAME': 'cltbld', 22:58:41 INFO - 'MAIL': '/var/mail/cltbld', 22:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:41 INFO - 'MOZ_NO_REMOTE': '1', 22:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:41 INFO - 'NO_EM_RESTART': '1', 22:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:41 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:41 INFO - 'SHELL': '/bin/bash', 22:58:41 INFO - 'SHLVL': '1', 22:58:41 INFO - 'TERM': 'linux', 22:58:41 INFO - 'TMOUT': '86400', 22:58:41 INFO - 'USER': 'cltbld', 22:58:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460612528.810122-2029278502', 22:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:41 INFO - '_': '/tools/buildbot/bin/python'} 22:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:58:41 INFO - Running setup.py (path:/tmp/pip-R5BxIR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:58:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:58:41 INFO - Running setup.py (path:/tmp/pip-zCEXdo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:58:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:58:41 INFO - Running setup.py (path:/tmp/pip-slprAj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:58:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:58:41 INFO - Running setup.py (path:/tmp/pip-WZbgrY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:58:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:58:41 INFO - Running setup.py (path:/tmp/pip-Eeu_jd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:58:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:58:41 INFO - Running setup.py (path:/tmp/pip-GMKS8d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:58:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:58:41 INFO - Running setup.py (path:/tmp/pip-_1KN21-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:58:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:58:41 INFO - Running setup.py (path:/tmp/pip-u1tPCi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:58:42 INFO - Running setup.py (path:/tmp/pip-lERP3R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:58:42 INFO - Running setup.py (path:/tmp/pip-uCY_7_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:58:42 INFO - Running setup.py (path:/tmp/pip-MhKlFu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:58:42 INFO - Running setup.py (path:/tmp/pip-PvJbT7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:58:42 INFO - Running setup.py (path:/tmp/pip-21ZueM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:58:42 INFO - Running setup.py (path:/tmp/pip-VypHng-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:58:42 INFO - Running setup.py (path:/tmp/pip-zwyz53-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:58:42 INFO - Running setup.py (path:/tmp/pip-rKK22u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:58:42 INFO - Running setup.py (path:/tmp/pip-EcGeQo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:58:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:58:42 INFO - Running setup.py install for manifestparser 22:58:42 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:58:42 INFO - Running setup.py install for mozcrash 22:58:42 INFO - Running setup.py install for mozdebug 22:58:42 INFO - Running setup.py install for mozdevice 22:58:43 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:58:43 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:58:43 INFO - Running setup.py install for mozfile 22:58:43 INFO - Running setup.py install for mozhttpd 22:58:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:58:43 INFO - Running setup.py install for mozinfo 22:58:43 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:58:43 INFO - Running setup.py install for mozInstall 22:58:43 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:58:43 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:58:43 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:58:43 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:58:43 INFO - Running setup.py install for mozleak 22:58:43 INFO - Running setup.py install for mozlog 22:58:43 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:58:43 INFO - Running setup.py install for moznetwork 22:58:43 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:58:43 INFO - Running setup.py install for mozprocess 22:58:43 INFO - Running setup.py install for mozprofile 22:58:44 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:58:44 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:58:44 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:58:44 INFO - Running setup.py install for mozrunner 22:58:44 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:58:44 INFO - Running setup.py install for mozscreenshot 22:58:44 INFO - Running setup.py install for moztest 22:58:44 INFO - Running setup.py install for mozversion 22:58:44 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:58:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:58:44 INFO - Cleaning up... 22:58:44 INFO - Return code: 0 22:58:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:44 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 0x7f499f613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e41d0>, '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 0x20e7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e7be0>, '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-1460612528.810122-2029278502', '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:58:44 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:58:44 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:58:44 INFO - Using env: {'DISPLAY': ':0', 22:58:44 INFO - 'HOME': '/home/cltbld', 22:58:44 INFO - 'LANG': 'en_US.UTF-8', 22:58:44 INFO - 'LANGUAGE': 'en_US:en', 22:58:44 INFO - 'LOGNAME': 'cltbld', 22:58:44 INFO - 'MAIL': '/var/mail/cltbld', 22:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:44 INFO - 'MOZ_NO_REMOTE': '1', 22:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:44 INFO - 'NO_EM_RESTART': '1', 22:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:44 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:44 INFO - 'SHELL': '/bin/bash', 22:58:44 INFO - 'SHLVL': '1', 22:58:44 INFO - 'TERM': 'linux', 22:58:44 INFO - 'TMOUT': '86400', 22:58:44 INFO - 'USER': 'cltbld', 22:58:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460612528.810122-2029278502', 22:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:44 INFO - '_': '/tools/buildbot/bin/python'} 22:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:58:44 INFO - Running setup.py (path:/tmp/pip-IrIaUv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:58:44 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:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:58:44 INFO - Running setup.py (path:/tmp/pip-0qIzQ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:58:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:58:44 INFO - Running setup.py (path:/tmp/pip-SJGdMs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:58:44 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:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:58:44 INFO - Running setup.py (path:/tmp/pip-l7sbvu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:58:44 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:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:58:45 INFO - Running setup.py (path:/tmp/pip-Q41eur-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:58:45 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:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:58:45 INFO - Running setup.py (path:/tmp/pip-pB3Kme-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:58:45 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:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:58:45 INFO - Running setup.py (path:/tmp/pip-AU1FDS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:58:45 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:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:58:45 INFO - Running setup.py (path:/tmp/pip-h69Xdt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:58:45 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:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:58:45 INFO - Running setup.py (path:/tmp/pip-H7my2z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:58:45 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:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:58:45 INFO - Running setup.py (path:/tmp/pip-gdNYVJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:58:45 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:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:58:45 INFO - Running setup.py (path:/tmp/pip-fonqFe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:58:45 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:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:58:45 INFO - Running setup.py (path:/tmp/pip-5jo3ZF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:58:45 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:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:58:45 INFO - Running setup.py (path:/tmp/pip-ytTI_Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:58:45 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:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:58:45 INFO - Running setup.py (path:/tmp/pip-c06aoH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:58:45 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:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:58:45 INFO - Running setup.py (path:/tmp/pip-MDSBbj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:58:45 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:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:58:45 INFO - Running setup.py (path:/tmp/pip-oBpRhz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:58:45 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:58:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:58:45 INFO - Running setup.py (path:/tmp/pip-8kwft9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:58:45 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:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:58:45 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:58:45 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:58:45 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:58:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:47 INFO - Downloading blessings-1.6.tar.gz 22:58:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:58:47 INFO - Installing collected packages: blessings 22:58:47 INFO - Running setup.py install for blessings 22:58:48 INFO - Successfully installed blessings 22:58:48 INFO - Cleaning up... 22:58:48 INFO - Return code: 0 22:58:48 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:58:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:58:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:58:48 INFO - Reading from file tmpfile_stdout 22:58:48 INFO - Current package versions: 22:58:48 INFO - argparse == 1.2.1 22:58:48 INFO - blessings == 1.6 22:58:48 INFO - blobuploader == 1.2.4 22:58:48 INFO - docopt == 0.6.1 22:58:48 INFO - manifestparser == 1.1 22:58:48 INFO - mozInstall == 1.12 22:58:48 INFO - mozcrash == 0.17 22:58:48 INFO - mozdebug == 0.1 22:58:48 INFO - mozdevice == 0.48 22:58:48 INFO - mozfile == 1.2 22:58:48 INFO - mozhttpd == 0.7 22:58:48 INFO - mozinfo == 0.9 22:58:48 INFO - mozleak == 0.1 22:58:48 INFO - mozlog == 3.1 22:58:48 INFO - moznetwork == 0.27 22:58:48 INFO - mozprocess == 0.22 22:58:48 INFO - mozprofile == 0.28 22:58:48 INFO - mozrunner == 6.11 22:58:48 INFO - mozscreenshot == 0.1 22:58:48 INFO - mozsystemmonitor == 0.0 22:58:48 INFO - moztest == 0.7 22:58:48 INFO - mozversion == 1.4 22:58:48 INFO - psutil == 3.1.1 22:58:48 INFO - requests == 1.2.3 22:58:48 INFO - wsgiref == 0.1.2 22:58:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:58:48 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:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:48 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:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:48 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 0x7f499f613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e41d0>, '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 0x20e7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e7be0>, '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-1460612528.810122-2029278502', '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:58:48 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:58:48 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:58:48 INFO - Using env: {'DISPLAY': ':0', 22:58:48 INFO - 'HOME': '/home/cltbld', 22:58:48 INFO - 'LANG': 'en_US.UTF-8', 22:58:48 INFO - 'LANGUAGE': 'en_US:en', 22:58:48 INFO - 'LOGNAME': 'cltbld', 22:58:48 INFO - 'MAIL': '/var/mail/cltbld', 22:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:48 INFO - 'MOZ_NO_REMOTE': '1', 22:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:48 INFO - 'NO_EM_RESTART': '1', 22:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:48 INFO - 'SHELL': '/bin/bash', 22:58:48 INFO - 'SHLVL': '1', 22:58:48 INFO - 'TERM': 'linux', 22:58:48 INFO - 'TMOUT': '86400', 22:58:48 INFO - 'USER': 'cltbld', 22:58:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460612528.810122-2029278502', 22:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:48 INFO - '_': '/tools/buildbot/bin/python'} 22:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:48 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:58:48 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:58:48 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:58:48 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:58:48 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:58:48 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:58:48 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:58:48 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:58:48 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:58:48 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:58:48 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:58:48 INFO - Cleaning up... 22:58:48 INFO - Return code: 0 22:58:48 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:58:48 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:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:48 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:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:48 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 0x7f499f613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e41d0>, '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 0x20e7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e7be0>, '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-1460612528.810122-2029278502', '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:58:48 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:58:48 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:58:48 INFO - Using env: {'DISPLAY': ':0', 22:58:48 INFO - 'HOME': '/home/cltbld', 22:58:48 INFO - 'LANG': 'en_US.UTF-8', 22:58:48 INFO - 'LANGUAGE': 'en_US:en', 22:58:48 INFO - 'LOGNAME': 'cltbld', 22:58:48 INFO - 'MAIL': '/var/mail/cltbld', 22:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:48 INFO - 'MOZ_NO_REMOTE': '1', 22:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:48 INFO - 'NO_EM_RESTART': '1', 22:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:48 INFO - 'SHELL': '/bin/bash', 22:58:48 INFO - 'SHLVL': '1', 22:58:48 INFO - 'TERM': 'linux', 22:58:48 INFO - 'TMOUT': '86400', 22:58:48 INFO - 'USER': 'cltbld', 22:58:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460612528.810122-2029278502', 22:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:48 INFO - '_': '/tools/buildbot/bin/python'} 22:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:48 INFO - Downloading/unpacking jsonschema 22:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:58:50 INFO - Downloading/unpacking functools32 (from jsonschema) 22:58:50 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:58:50 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:58:50 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:58:50 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:58:50 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:58:50 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:58:50 INFO - Downloading functools32-3.2.3-2.tar.gz 22:58:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:58:50 INFO - warning: no files found matching '*.txt' 22:58:50 INFO - no previously-included directories found matching 'build' 22:58:50 INFO - no previously-included directories found matching 'dist' 22:58:50 INFO - no previously-included directories found matching '.git*' 22:58:50 INFO - Installing collected packages: jsonschema, functools32 22:58:51 INFO - Running setup.py install for functools32 22:58:51 INFO - warning: no files found matching '*.txt' 22:58:51 INFO - no previously-included directories found matching 'build' 22:58:51 INFO - no previously-included directories found matching 'dist' 22:58:51 INFO - no previously-included directories found matching '.git*' 22:58:51 INFO - Successfully installed jsonschema functools32 22:58:51 INFO - Cleaning up... 22:58:51 INFO - Return code: 0 22:58:51 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:58:51 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:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:51 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:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:51 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 0x7f499f613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e41d0>, '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 0x20e7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e7be0>, '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-1460612528.810122-2029278502', '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:58:51 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:58:51 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:58:51 INFO - Using env: {'DISPLAY': ':0', 22:58:51 INFO - 'HOME': '/home/cltbld', 22:58:51 INFO - 'LANG': 'en_US.UTF-8', 22:58:51 INFO - 'LANGUAGE': 'en_US:en', 22:58:51 INFO - 'LOGNAME': 'cltbld', 22:58:51 INFO - 'MAIL': '/var/mail/cltbld', 22:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:51 INFO - 'MOZ_NO_REMOTE': '1', 22:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:51 INFO - 'NO_EM_RESTART': '1', 22:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:51 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:51 INFO - 'SHELL': '/bin/bash', 22:58:51 INFO - 'SHLVL': '1', 22:58:51 INFO - 'TERM': 'linux', 22:58:51 INFO - 'TMOUT': '86400', 22:58:51 INFO - 'USER': 'cltbld', 22:58:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460612528.810122-2029278502', 22:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:51 INFO - '_': '/tools/buildbot/bin/python'} 22:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:51 INFO - Downloading/unpacking flake8 22:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:58:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:58:53 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:58:53 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:58:53 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:58:53 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:58:53 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:58:53 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:58:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:58:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:58:53 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:58:53 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:58:53 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:58:53 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:58:53 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:58:53 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:58:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:58:53 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:58:53 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:58:53 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:58:53 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:58:53 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:58:53 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:58:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:58:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:58:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:58:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:58:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:58:53 INFO - no previously-included directories found matching 'docs/_build' 22:58:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:58:54 INFO - Running setup.py install for pep8 22:58:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:58:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:58:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:58:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:58:54 INFO - no previously-included directories found matching 'docs/_build' 22:58:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:58:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:58:54 INFO - Cleaning up... 22:58:54 INFO - Return code: 0 22:58:54 INFO - Running post-action listener: _resource_record_post_action 22:58:54 INFO - Running post-action listener: _start_resource_monitoring 22:58:54 INFO - Starting resource monitoring. 22:58:54 INFO - ##### 22:58:54 INFO - ##### Running install step. 22:58:54 INFO - ##### 22:58:54 INFO - Running pre-action listener: _resource_record_pre_action 22:58:54 INFO - Running main action method: install 22:58:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:58:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:58:54 INFO - Reading from file tmpfile_stdout 22:58:54 INFO - Detecting whether we're running mozinstall >=1.0... 22:58:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:58:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:58:54 INFO - Reading from file tmpfile_stdout 22:58:54 INFO - Output received: 22:58:54 INFO - Usage: mozinstall [options] installer 22:58:54 INFO - Options: 22:58:54 INFO - -h, --help show this help message and exit 22:58:54 INFO - -d DEST, --destination=DEST 22:58:54 INFO - Directory to install application into. [default: 22:58:54 INFO - "/builds/slave/test-pgo"] 22:58:54 INFO - --app=APP Application being installed. [default: firefox] 22:58:54 INFO - mkdir: /builds/slave/test-pgo/build/application 22:58:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:58:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:59:10 INFO - Reading from file tmpfile_stdout 22:59:10 INFO - Output received: 22:59:10 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:59:10 INFO - Running post-action listener: _resource_record_post_action 22:59:10 INFO - ##### 22:59:10 INFO - ##### Running run-tests step. 22:59:10 INFO - ##### 22:59:10 INFO - Running pre-action listener: _resource_record_pre_action 22:59:10 INFO - Running main action method: run_tests 22:59:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:59:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:59:10 INFO - Python 2.7.3 22:59:10 INFO - Return code: 0 22:59:10 INFO - grabbing minidump binary from tooltool 22:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:11 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 0x20e41d0>, '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 0x20e7750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e7be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:59:11 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:59:11 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:59:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:59:11 INFO - Return code: 0 22:59:11 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:59:11 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:59:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:59:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:59:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:59:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:59:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:59:12 INFO - Return code: 0 22:59:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:59:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:59:12 INFO - Using env: {'DISPLAY': ':0', 22:59:12 INFO - 'HOME': '/home/cltbld', 22:59:12 INFO - 'LANG': 'en_US.UTF-8', 22:59:12 INFO - 'LANGUAGE': 'en_US:en', 22:59:12 INFO - 'LOGNAME': 'cltbld', 22:59:12 INFO - 'MAIL': '/var/mail/cltbld', 22:59:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:59:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:12 INFO - 'MOZ_NO_REMOTE': '1', 22:59:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:12 INFO - 'NO_EM_RESTART': '1', 22:59:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:12 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:59:12 INFO - 'SHELL': '/bin/bash', 22:59:12 INFO - 'SHLVL': '1', 22:59:12 INFO - 'TERM': 'linux', 22:59:12 INFO - 'TMOUT': '86400', 22:59:12 INFO - 'USER': 'cltbld', 22:59:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460612528.810122-2029278502', 22:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:12 INFO - '_': '/tools/buildbot/bin/python'} 22:59:12 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:59:12 INFO - mozversion application_buildid: 20160413203320 22:59:12 INFO - mozversion application_changeset: 52ebea10c080da799bc43150e261e043ba824f5b 22:59:12 INFO - mozversion application_display_name: Nightly 22:59:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:59:12 INFO - mozversion application_name: Firefox 22:59:12 INFO - mozversion application_remotingname: firefox 22:59:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:59:12 INFO - mozversion application_vendor: Mozilla 22:59:12 INFO - mozversion application_version: 48.0a1 22:59:12 INFO - mozversion platform_buildid: 20160413203320 22:59:12 INFO - mozversion platform_changeset: 52ebea10c080da799bc43150e261e043ba824f5b 22:59:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:59:12 INFO - mozversion platform_version: 48.0a1 22:59:12 INFO - using testdate: 1460613552 22:59:12 INFO - actual date: 1460613552 22:59:12 INFO - starting webserver on 'localhost:39068' 22:59:12 INFO - SUITE-START | Running 2 tests 22:59:12 INFO - TEST-START | dromaeo_css 22:59:12 INFO - operating with platform_type : linux_ 22:59:12 INFO - Initialising browser for dromaeo_css test... 22:59:12 INFO - TEST-INFO | started process 3733 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAn91xo/profile http://localhost:39068/getInfo.html) 22:59:16 INFO - PROCESS | 3733 | __metrics Screen width/height:1600/1200 22:59:16 INFO - PROCESS | 3733 | colorDepth:24 22:59:16 INFO - PROCESS | 3733 | Browser inner width/height: 1024/697 22:59:16 INFO - PROCESS | 3733 | __metrics 22:59:17 ERROR - PROCESS | 3733 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:59:18 INFO - TEST-INFO | 3733: exit 0 22:59:18 INFO - Browser initialized. 22:59:18 INFO - Running cycle 1/1 for dromaeo_css test... 22:59:18 INFO - TEST-INFO | started process 3818 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAn91xo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:59:30 INFO - PROCESS | 3818 | RSS: Main: 152838144 22:59:30 INFO - PROCESS | 3818 | 23:00:20 INFO - PROCESS | 3818 | 1460613620983 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] 23:02:28 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:39068/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39068/tests/dromaeo/cssquery-ext.html) 23:02:29 INFO - PROCESS | 3818 | RSS: Main: 252477440 23:02:29 INFO - PROCESS | 3818 | 23:05:31 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:39068/tests/dromaeo/cssquery-ext.html (next: http://localhost:39068/tests/dromaeo/cssquery-jquery.html) 23:05:31 INFO - PROCESS | 3818 | RSS: Main: 242872320 23:05:31 INFO - PROCESS | 3818 | 23:08:33 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:39068/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39068/tests/dromaeo/cssquery-mootools.html) 23:08:34 INFO - PROCESS | 3818 | RSS: Main: 241659904 23:08:34 INFO - PROCESS | 3818 | 23:11:36 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:39068/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39068/tests/dromaeo/cssquery-prototype.html) 23:11:36 INFO - PROCESS | 3818 | RSS: Main: 232046592 23:11:36 INFO - PROCESS | 3818 | 23:14:39 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:39068/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39068/tests/dromaeo/cssquery-yui.html) 23:14:39 INFO - PROCESS | 3818 | RSS: Main: 224325632 23:14:39 INFO - PROCESS | 3818 | 23:17:42 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:39068/tests/dromaeo/cssquery-yui.html (next: http://localhost:39068/tests/dromaeo/cssquery-dojo.html) 23:17:42 INFO - PROCESS | 3818 | RSS: Main: 267657216 23:17:42 INFO - PROCESS | 3818 | 23:17:42 INFO - PROCESS | 3818 | __start_tp_report 23:17:42 INFO - PROCESS | 3818 | _x_x_mozilla_page_load 23:17:42 INFO - PROCESS | 3818 | _x_x_mozilla_page_load_details 23:17:42 INFO - PROCESS | 3818 | |i|pagename|runs| 23:17:42 INFO - PROCESS | 3818 | |0;dojo.html;3072.354805490847;3131.0606817954636;3171.0803866878623;3172.8889488867894;3193.3134376109138;5225.137852254374;5262.368515778107;5285.682859028451;5286.550643195333;5307.840764777058;5186.740662966846;5252.789888404459;5263.236830659552;5277.287566178565;5278.287431196787;4734.928976065362;4790.23356262998;4825.638077144211;4867.196912509432;4880.389951256093;4807.134715751164;4842.152623290927;4844.5882100021545;4893.975530122362;4935.555799978001;4717.669763116583;4824.155772739774;4876.756162191876;4879.316895634614;4901.53435423636;4766.666333356667;4767.69010014348;4768.950830817214;4776.188048031843;4811.687240329367;4641.11818754439;4724;4759.571638552512;4784.354112194844;4796.424429068499;5211.973940130275;5223.37319521656;5227.11139106349;5228.973855130738;5268.578513718893;5603.439656034405;5614.747336369873;5632.295963004624;5633.943660563424;5638.069718496443;5388.137897936312;5584.972075139639;5657.745401456944;5673.177389278573;5673.290838645169;5265.605079619044;5267.657602255841;5287.154055351164;5290.153575427913;5290.68255904647;5709.74306156224;5752.539796816244;5761.337446193741;5765.279340082489;5769.538436925036;5358.624896257303;5446.972765136228;5484.149956756709;5503.477169668875;5505.944940550543;5543.1408131739645;5555.30558680165;5558.77764889408;5560;5560.916586251209;5536.584756143306;5536.889262214733;5537.141743029837;5538.972305138448;5590.133529302964;5465.371482279589;5599.132134519156;5624.578156638268;5635.464630860061;5674.716264186774;4185.183889141649;4185.769782661982;4190.266703326966;4190.371444283321;4220.78896055196;3708.8331025103935;3764.792936388525;3767.3783825669007;3808.295465338921;3817.4846395736777;5221.921671174935;5245.26566280721;5277.208418737144;5283.418823929442;5289.18017707256;5585.245991791056;5622.32532096151;5631.7747290108755;5633.943660563424;5639.63342382752;5079.492050794891;5270.262163297141;5271;5279.208118782137;5323.015242180131;4854.732989685601;4865.537773911473;4871.391076115486;4899.461059283476;4908.779104940286;5788.9710551447815;5790.942090579125;5792.913106303409;5802.245708057925;5816.069428891442;5343.7060961647485;5585.497305242548;5608.887822243614;5609.607327487037;5653.3781284057895;5841.32824725162;5856.502197313106;5862.472377486047;5867.442592953663;5897.174395584536;5563;5581.190727344593;5585.720713964204;5585.804496842754;5593.8321850344555;5534.972325138348;5645.096784514458;5654.406287339934;5669.234653321749;5717.142428635738;5336.226247194058;5340.49265319794;5340.599455040965;5341.572674185978;5393.40672526014;5344.064788662046;5346.385165705994;5349.384820745664;5352.785888564414;5400.83797486076;5178.948210517998;5227.18978558324;5303.496167864047;5359.678419294854;5364.597655175956;5390.541803946709;5401.3248343957;5403.972980135231;5411.080116380146;5413.10683737179;5278.5249327560705;5281.392639846466;5284.709340986283;5298.70857102863;5331.920021199608 23:17:42 INFO - PROCESS | 3818 | |1;ext.html;601.7081715368048;641.2625480697197;652.6801867085123;660.0725979998101;663.1909070933463;29790.553141702865;30522.38955220897;30574.388512229743;30600.54099188514;37621.81189094051;40290.395644065364;41131.85851768529;41208.38187427191;41208.58791412085;41294.58705412945;8567.400281980248;8787.604557794883;8788.42875213109;8791.252743516809;8792.60433280504;8633.740987770378;8746.737597872043;8750.649974001033;8757.956210218972;8765.298776097929;8766.386352955296;8829.33779966505;8837.734867953972;8841.248493878029;9058.501782401965;8950.686725964593;9026.864597031017;9029.909700903005;9032.412893161923;9046.954765226197;8830.42602230853;8965.103489651048;8973.371863969525;8977.102289771035;8985.326100542485;40535.594644053475;40674.593254067375;40932;40992.1801563967;41007.38488922668;3349.698527132545;3394.4229480988292;3406.7615266931325;3810.580836108026;4071.796410179479;31345.8432707835;31706.682933170836;31711.20721981946;31924.840375797972;32171.6782832171;4282.657387409;4395.362672412514;4396.384506169139;4452.332150177467;4457.6433885289425;206679;207042;207213;207929;208074;45197;45253.321200181366;45287;45440.3183952241;45483.31775023377;58754.706226468596;58837.70581147067;58903.705481472316;58971.70514147402;59019.70490147522;15987.920060399856;16161.353545858034;16167.35330586787;16202.594935126715;16216.918915405584;11397.658070257905;11421.257618254953;11475.196736228383;11496.827547586792;11505.539778408769;14426.927865360605;16353.754693679604;16495.422660206834;16553.337866485446;16658.833411665728;5160.819371322061;6040.758369665252;6256.74973001084;6308.653024083719;6399.328070552618;868.9217970382696;881.3698205782896;894.7226359828474;903.4534106865383;1094.8467214589964;31704.682953170635;32871.3425731484;33163.3367332652;33533.329333413196;33692.49461258083;1077.7359546911057;1126.814075677504;1213.8846809553079;1217.0993464835958;1267.5563552756462;16273.430429934895;16327.755083673754;16356.509304720877;16477.83522164763;16509.91745041267;410368;415726;416087;417257;417620;57661.711691441276;58133.709331453916;58145.709271454216;58218.41781582215;58326.41673583295;1230.8522977242787;1274.936253187337;1370.0820450298324;1390.8331000280032;1436.0163288147862;29901.401971960004;30532.168069915875;30748;30752;30948.535771962986;42016;42383;42460.36309455299;42492.5750742501;42532.36201456919;199847;202688;203872;203891;204347;35699.28601427905;36453.63546364503;41102.58897411107;41633.37549936693;42532.1493570133;35798.28403431969;36000.81999589985;36045.63954360423;36442.453363200104;36530;33983.320333593685;36000;37039.44440833336;37223;37467.62532374641;36093.63906360903;36153.81923090473;36194.45708314325;36239.45640815337;36724.265514689025;40312;40639.593604064765;41464.1707165861;41494.17011659689;41626.167476649694;33136;34833.24720753671;35586.82206589054;35729.64270357263;36269.27461450809;27670.584941225494;27773.305667358476;28017.719822802326;28029.859850700617;28139.71860281371 23:17:42 INFO - PROCESS | 3818 | |2;jquery.html;377.69218087258884;385.166115360245;402.88517772434864;403.65487508180524;406.3599830267328;18076.819231807676;18678.813211867877;18741;18746;19513.60972780547;17440.215190316434;17724.645507089852;18168.54578635535;19418.22327106914;19500.51248718783;5180.792768289264;5479;5665.23519324892;5818.0400233961345;5844.941550584504;5408.945910540883;5431.076716958127;5442.700651464168;5461.890762184754;5462.180672899057;5445.319335083114;5449.100898351767;5561.221428999943;5977.850553736148;5988.281406231258;5913.970430147843;6042.214512113397;6044.3955604439425;6059.36376680451;6110.633361998272;5319.148936170232;5380.273663055476;5449.6730196188355;5450.836474905759;5453.672779633195;12607.243565386107;12649.683757906034;12665.936670316682;16968.49094527166;20836.791632083787;2174.5868285025954;2203.6804663323887;2257.4694946687678;2268.875211863347;2277.453411181321;9307.76730581734;9416.717498475056;9416.952915235448;9511.381760185566;9752.658656946973;1887.509247595635;1920;1965.6756635155182;1980.5939782344728;1999.9400017999337;77539;78339.6083019587;78872.60563697202;78902.21097789006;79000;9947.651832185838;10338.793224135476;10359.792804143875;10846.186536009673;11036.503357348938;13573.728525429633;13700.931495342658;13709.794353084511;13722.078908952755;13747.587572372844;7607.08714954198;7670.8082297943;7776.144624091346;7776.65005074773;7852.921470785219;7551.924480755232;7687.846243075107;7731.884021739678;7838.921610783819;7839.960800196077;4290.742555446684;4298.398224248608;4304.569543045733;4369.519352871182;4421.248387774086;1936.0765244480936;1942.1357495914183;1944.826760816222;1952.580195257998;2016.1229865008768;907.7503686486269;997.3517213811081;1007.1942446043137;1008.7931973945324;1041.3335465302212;18824.717629235573;18858.811411885705;18905.14926828296;19024.752475247526;19176.71234931477;946.4983558713893;991.8413053911339;1023.9795204096025;1031.4687935713114;1045.153425725165;10064.446455444875;10668.519916603771;10721.83917241242;10749.677509674722;10762.139028877828;339218;339656.2240643131;340349;341654;344608.15438842186;65715;78074;80712.19287807046;87077.56461217653;96661.51669241609;958.4824194934657;958.8705524754068;961.8268711631973;981.8723565936383;1005.4369553050316;15699.843001569838;15710.135942523271;15729.764053539435;15898.364065437252;15983.280752366403;36371.63628363683;38265.426018609185;38633.80683096567;39041;39161.804190978866;52023.47976520186;53178.46821531735;53262.46737532575;54470;54634.45365546294;7785.9610701948395;7855.8036049096945;8037.879431808411;8103.108658047492;8120.066192387715;11215.495302711235;11707.531698731955;11881.5841445549;12806.935965320114;13574;10725.249232553646;11117;11234.382108984084;11500.94249528747;11869.5845645402;10989;11213.495392707511;11286;11618.186726929034;11641.88358116408;6594.637294948824;10865;11149.498272577592;11895.524179032742;12039.63881083569;7926.682932682858;7974.322182614543;8102.189781021851;8135.471194372347;8182.509049457051;9958.502074896081;11567.363794991355;11787.882121178678;11943.940280298542;12151.331676757864 23:17:42 INFO - PROCESS | 3818 | |3;mootools.html;1301.169955347121;1444.3428240150733;1459.226609896755;1483.6513419346452;1510.8791296696263;6927.480438967079;7867.173946735589;8085.555294458817;8091.635876385562;8093.676252949882;7770.4172187085915;7959.522428654271;7967.282944534991;7970.96014519928;7974.122846486882;1874.0723341945757;2098.674705420662;2134.2210093315985;2168.3820111268215;2173.608750424923;2162.5999190149796;2183.4977955070344;2185.06042401768;2187.453136715821;2189.091527016294;2147.291393840037;2188.2997440818945;2196.7473740519804;2203.0857194264363;2205.7683943185975;1845.4555906007693;2117.947051323714;2186.158329043322;2186.3222401055564;2190;2084.697718830761;2106.283863486422;2117.8411619128474;2120.3638908327594;2153.0418963561224;7901.446898717092;7964.203579642048;7966.203379662045;7966.840663186704;7974.202579742037;4655.185342565072;4837.201861692816;4843.9031219375765;4864.975675121602;4873.805047798084;3013.773966952487;3029.424409362236;3070.2477892916377;3111.6577176510564;3132.79636823608;1023.7696518283401;1024.7950409918046;1025.1137906252532;1052.69998050556;1055.6516349604613;9904.90095099047;10062.748431289203;10263.384196948207;10270.1783857292;10827.891721082768;3995.6603688686787;4019.9397009044887;4142.275101857163;4173.478315210598;4206.074663574009;8775.517346545874;8786.077461866413;8793.648254069894;8798.604062817189;8803.339749518811;4115.36211887158;4832.202686556749;4852.223644216979;4867.9269810952865;4883.3651625288485;4377.934330985037;4422.3808666786035;4424.646028317727;4462.687611867138;4467.7319360838455;3478.1652403423504;3525.9118522036642;3587.7488575799443;3611.566612006576;3657.7256705747177;1010.7927874785652;1085.1210519479248;1088.5319312695617;1090.5910283643634;1097.3525619884306;961.4904100826573;985.1527686189871;990.1880458024351;996.6810620601483;1010.282699283517;5556.6943818089585;5716.7994721109035;5750;5812.9709351452975;5932.911006334908;967.3760424526141;994.8010397920444;1004;1016.5323950982483;1031.0617338222182;4008.8596899108393;4160.854370097092;4182.351735481006;4185.602367775056;4197.916041679149;9696.418214907128;10040.447775372424;10146.898531014744;10203.234757393077;10223.284370094021;10032.749181270381;10049.24630652704;10052.497375131214;10067.647632332833;10094.545745441474;7212.783616491513;7521.4734968551675;7525.887111693329;7528.811779705551;7664.961675191588;5599.60802743804;5822.912656310074;5879.764809407576;5903.380145084704;5980.252468441445;9112.635494580407;9185.219256363283;9251.722448326562;9275.30435217348;9287.860682089638;9402.247820174507;9408.482533460725;9423.29325300619;9426.387284826464;9540.666076687283;7058.6470676467;7129.7861064168155;7140.857182856417;7160.677769500281;7161.283871613005;7588.962055189689;7613.0483689538805;7614.581198034161;7650.1584825668015;7690.846183076419;6907.723691052302;6949.4440444765305;7141.143062832493;7196.640167991475;7223.783286501413;7029.753958611424;7087.893681594884;7104.502684812013;7155.356017958408;7174.928250717426;6523.575967562093;6596.175478065242;6598.1422415085735;6599.60402375859;6604.768833090819;4913.091078150554;5009.248612707977;5022.4977502249485;5060.898782024413;5087.084324821568;5029.673071250357;5091.872703182302;5113.846584602468;5256.789728410974;5262.868428289324 23:17:42 INFO - PROCESS | 3818 | |4;prototype.html;301.57779109247065;312.55773081090257;312.93271946531496;314.4089112468559;315.19467759873527;5450.591205659572;5547.140193270049;5649.915251271229;5697.458741419564;5739.368669446363;5614.410486898878;5627.521660658849;5660.688662123582;5673.631213971089;5677.460641239086;4286.828526858922;4296.935545966813;4301.118270754503;4313.611774940255;4316.56834316569;4161.916761664765;4277.165952639237;4310.051788606502;4313.2451820931365;4326.653867690593;4241.893952651193;4242.957570424287;4249.830006799724;4253.766042867641;4270.957290427087;4242.172776308621;4254.149170165979;4260.957390426087;4262.616364527192;4263.978680106579;3534.5228394166716;3673.8897833065053;3701.148735790783;3703.4444833274956;3704.49989251453;5445.455454454563;5446.782128714846;5461.508464238238;5478.753456094485;5502.889942201174;4893.535114164184;4899.240617704261;4900.068986892479;4913.508649135094;4924;5557.249771280906;5910.763569457216;5911.93585154672;5928.407159284037;5946.699581732137;4037.9596204037875;4057.1885622875543;4064.4512990746166;4075.5313138988804;4076.510818701745;6122.540809439265;6193.1639228704;6195.31851496335;6209.2548894133;6210.658413787285;4045.9190816183514;4127.628513433805;4148.56440073794;4151.813168407429;4154.335306350969;4136.875893723193;4165.291900376943;4168.6039826216465;4171.83312667496;4173.31140361843;4839.612830973514;4858.805647774049;4860.586850117779;4866.46468888422;4871;5559.527440167631;5762.4525670061275;5897.262842144732;5944.554158438048;5956.16613674086;1435.4617018618019;1446.522647526314;1447.920364379948;1455.6724736934104;1458.752766384747;931.3713243560569;950.7100334397936;962.3600305796567;970.7427531704104;976.4043933200742;5654.773809047592;5703.686297253691;5713.657180569179;5727.140928860621;5728.656280623176;6088.512918966472;6102.72537735803;6115.239127936287;6127.693615319216;6132.325444201134;5505.476979686923;5669.489745922887;5677.716114194273;5683.658980461103;5693.146028095736;3245.789023713451;3257.250832308535;3260.3316320154313;3260.5598244236726;3265.6571060038827;6093.908591371133;6295.685215739195;6302.684865756693;6314.494840412756;6324.272708638566;6207.937920620826;6211.720472578745;6217.564770466024;6219.253689557282;6234.604603754342;6257.5932564383165;6292.968535157295;6301.243850737941;6316.526260530479;6334.3032266450655;5818.0981947798155;6181.690915454299;6195.132681424694;6207;6214.658193799384;6107.236595425394;6110.358412366638;6115.602485838406;6124.938750612437;6153.538484613582;6271.3728627136925;6379.74481020754;6382.266039405342;6417.7753778617525;6419.743210271724;4073.9592604073578;4092.897677558085;4110.807865719027;4112;4114.753114813121;5912.46787789101;5912.645241285537;6195.380461953769;6209.099680546386;6216.595921265103;5936.317323507852;5944.613600115978;5973.372795856372;5980.730867111078;5992.550558708202;5953.791617293374;5963.552733545088;5989.8203053908455;6011.248593925759;6014.127951447103;5670;5881.882362352814;5912.231409916855;5913.58604897653;5919.348871624204;5989.2812862456785;6030.668313242813;6059.606125601822;6065.484433823174;6075.149479072845;5735.598508104393;5912.793052243151;5919.319278283053;5929.6145750526075;5932.436418540232 23:17:42 INFO - PROCESS | 3818 | |5;yui.html;830.5764060329233;852.0457088061376;860.2988564320075;861.3668953319309;867.8047439326152;13616.114952528078;13766.17402955822;13775.793363099561;13925.164490130599;13944.163350198995;12143.878561214386;12247.448864801083;12279.754404911897;12289.938550307259;12301;516.7726200471781;796.6932730898617;821.2731732416825;821.4250024982537;824.7690646618956;819.1808191808192;824.1922915542772;824.7113510271387;825.0223485170063;827.3339961331126;871.1288711288711;871.424859592669;872.9912700873006;873.4759144513305;873.6112429968666;703.802935178151;846.3313981954249;870.1820288928387;874.6588830356167;874.7944233105216;636.3064259956669;637.6301744987942;638.4605008767584;638.4796390941368;638.683851493509;12912.806307905388;12948.093633445662;12986.350682465933;13000.154989925624;13002.674933126653;13387.799183012263;13576;13590.32048397586;13630;13681;10833.512491937881;10910.454477276184;10937.507812148473;10950.726231844188;11123.221374503788;3753.0598305938156;3803.448499967517;3884.7086468514976;3920.8235629396745;3967.74209676373;52525.47474525244;52551.47448525504;52716.47283527154;52916.470835291926;54205.72897135528;10172.847407288897;10317.896821031844;10376.066154046172;10399.168066554657;10609.89390106089;17125.22936467862;17134.571635709206;17380.304787808345;17401;17459.38892138769;7922.762317130495;7975.322097621651;7975.561344126013;8076.919230807616;8131.186881311822;4638.026014536985;4709.882252943704;4733.5503127202865;4776.2119250324;4860.270959356125;3207.951880721791;3301.8018918864946;3302.488114342281;3304.6530114337647;3415.487676848493;572.1389309089793;616.737886398279;622.6357580815273;629.5026928726346;638.6232123047424;667.1560475997867;701.225146213437;735.2610626320513;736.3814395907357;794.082834326354;9022.909770902339;9035.593398297093;9279.884925431312;9487.430754154773;9692.612295508241;717.6089031477753;721.3868212019742;735.3896266099125;747.0624366420108;753.3972821742584;4467.218236808546;4496.280595104768;4511.5262897395305;4517.11916176349;4558.475775285819;61413;61975.38024619786;63012.05481917775;63287.050694239624;63347.6832615834;55440.72279638576;55490;56146.438535614936;56565;57405;50480;51199;51220.97558048818;51681.74159129256;52087.739561301954;8396.202360775716;8503.489790612583;8655.264302534355;8754.737357879274;8804.647814087364;28956.710432896245;29139.12582622525;29219;29620.703792961795;29905.551416729202;38752.930942250656;38840.41739373855;39720.205595888496;40728.59271407248;41138.38292425556;10600.257981941499;11026.779464410827;11146.219764616399;11332.660020199408;11496.88503114958;12795.232286062866;13000.544980925622;13059;13555.59333220005;13669.521566745514;9872.210223182272;11367.715807104889;11884.405779711153;12327.815082773586;12754.42605082792;12338.691532711755;12509.249445033327;12524.37378131108;12537.686557836127;12653.746925061263;11425;11581.942090289494;11688.590899318484;11906.226095303777;11933.4033298333;10050.69847904564;10141.543630536791;10574.15406767472;10641.521131548943;10668.573257069631;9879.456629885426;10096.596136154472;10101.797964040825;10132.645357412455;10309 23:17:42 INFO - PROCESS | 3818 | __end_tp_report 23:17:42 INFO - PROCESS | 3818 | __start_cc_report 23:17:42 INFO - PROCESS | 3818 | _x_x_mozilla_cycle_collect,804 23:17:42 INFO - PROCESS | 3818 | __end_cc_report 23:17:42 INFO - PROCESS | 3818 | __startTimestamp1460614662727__endTimestamp 23:17:42 INFO - PROCESS | 3818 | 23:17:42 INFO - PROCESS | 3818 | ------- Summary: start ------- 23:17:42 INFO - PROCESS | 3818 | Number of tests: 6 23:17:42 INFO - PROCESS | 3818 | 23:17:42 INFO - PROCESS | 3818 | [#0] dojo.html Cycles:165 Average:5196.57 Median:5331.92 stddev:576.47 (10.8%) stddev-sans-first:553.63 23:17:42 INFO - PROCESS | 3818 | Values: 3072.4 3131.1 3171.1 3172.9 3193.3 5225.1 5262.4 5285.7 5286.6 5307.8 5186.7 5252.8 5263.2 5277.3 5278.3 4734.9 4790.2 4825.6 4867.2 4880.4 4807.1 4842.2 4844.6 4894.0 4935.6 4717.7 4824.2 4876.8 4879.3 4901.5 4766.7 4767.7 4769.0 4776.2 4811.7 4641.1 4724.0 4759.6 4784.4 4796.4 5212.0 5223.4 5227.1 5229.0 5268.6 5603.4 5614.7 5632.3 5633.9 5638.1 5388.1 5585.0 5657.7 5673.2 5673.3 5265.6 5267.7 5287.2 5290.2 5290.7 5709.7 5752.5 5761.3 5765.3 5769.5 5358.6 5447.0 5484.1 5503.5 5505.9 5543.1 5555.3 5558.8 5560.0 5560.9 5536.6 5536.9 5537.1 5539.0 5590.1 5465.4 5599.1 5624.6 5635.5 5674.7 4185.2 4185.8 4190.3 4190.4 4220.8 3708.8 3764.8 3767.4 3808.3 3817.5 5221.9 5245.3 5277.2 5283.4 5289.2 5585.2 5622.3 5631.8 5633.9 5639.6 5079.5 5270.3 5271.0 5279.2 5323.0 4854.7 4865.5 4871.4 4899.5 4908.8 5789.0 5790.9 5792.9 5802.2 5816.1 5343.7 5585.5 5608.9 5609.6 5653.4 5841.3 5856.5 5862.5 5867.4 5897.2 5563.0 5581.2 5585.7 5585.8 5593.8 5535.0 5645.1 5654.4 5669.2 5717.1 5336.2 5340.5 5340.6 5341.6 5393.4 5344.1 5346.4 5349.4 5352.8 5400.8 5178.9 5227.2 5303.5 5359.7 5364.6 5390.5 5401.3 5404.0 5411.1 5413.1 5278.5 5281.4 5284.7 5298.7 5331.9 23:17:42 INFO - PROCESS | 3818 | 23:17:42 INFO - PROCESS | 3818 | [#1] ext.html Cycles:180 Average:44844.35 Median:20716.20 stddev:77147.89 (372.4%) stddev-sans-first:77292.79 23:17:42 INFO - PROCESS | 3818 | Values: 601.7 641.3 652.7 660.1 663.2 29790.6 30522.4 30574.4 30600.5 37621.8 40290.4 41131.9 41208.4 41208.6 41294.6 8567.4 8787.6 8788.4 8791.3 8792.6 8633.7 8746.7 8750.6 8758.0 8765.3 8766.4 8829.3 8837.7 8841.2 9058.5 8950.7 9026.9 9029.9 9032.4 9047.0 8830.4 8965.1 8973.4 8977.1 8985.3 40535.6 40674.6 40932.0 40992.2 41007.4 3349.7 3394.4 3406.8 3810.6 4071.8 31345.8 31706.7 31711.2 31924.8 32171.7 4282.7 4395.4 4396.4 4452.3 4457.6 206679.0 207042.0 207213.0 207929.0 208074.0 45197.0 45253.3 45287.0 45440.3 45483.3 58754.7 58837.7 58903.7 58971.7 59019.7 15987.9 16161.4 16167.4 16202.6 16216.9 11397.7 11421.3 11475.2 11496.8 11505.5 14426.9 16353.8 16495.4 16553.3 16658.8 5160.8 6040.8 6256.7 6308.7 6399.3 868.9 881.4 894.7 903.5 1094.8 31704.7 32871.3 33163.3 33533.3 33692.5 1077.7 1126.8 1213.9 1217.1 1267.6 16273.4 16327.8 16356.5 16477.8 16509.9 410368.0 415726.0 416087.0 417257.0 417620.0 57661.7 58133.7 58145.7 58218.4 58326.4 1230.9 1274.9 1370.1 1390.8 1436.0 29901.4 30532.2 30748.0 30752.0 30948.5 42016.0 42383.0 42460.4 42492.6 42532.4 199847.0 202688.0 203872.0 203891.0 204347.0 35699.3 36453.6 41102.6 41633.4 42532.1 35798.3 36000.8 36045.6 36442.5 36530.0 33983.3 36000.0 37039.4 37223.0 37467.6 36093.6 36153.8 36194.5 36239.5 36724.3 40312.0 40639.6 41464.2 41494.2 41626.2 33136.0 34833.2 35586.8 35729.6 36269.3 27670.6 27773.3 28017.7 28029.9 28139.7 23:17:42 INFO - PROCESS | 3818 | 23:17:42 INFO - PROCESS | 3818 | [#2] jquery.html Cycles:180 Average:23746.19 Median:19321.56 stddev:57035.75 (295.2%) stddev-sans-first:57168.76 23:17:42 INFO - PROCESS | 3818 | Values: 377.7 385.2 402.9 403.7 406.4 18076.8 18678.8 18741.0 18746.0 19513.6 17440.2 17724.6 18168.5 19418.2 19500.5 5180.8 5479.0 5665.2 5818.0 5844.9 5408.9 5431.1 5442.7 5461.9 5462.2 5445.3 5449.1 5561.2 5977.9 5988.3 5914.0 6042.2 6044.4 6059.4 6110.6 5319.1 5380.3 5449.7 5450.8 5453.7 12607.2 12649.7 12665.9 16968.5 20836.8 2174.6 2203.7 2257.5 2268.9 2277.5 9307.8 9416.7 9417.0 9511.4 9752.7 1887.5 1920.0 1965.7 1980.6 1999.9 77539.0 78339.6 78872.6 78902.2 79000.0 9947.7 10338.8 10359.8 10846.2 11036.5 13573.7 13700.9 13709.8 13722.1 13747.6 7607.1 7670.8 7776.1 7776.7 7852.9 7551.9 7687.8 7731.9 7838.9 7840.0 4290.7 4298.4 4304.6 4369.5 4421.2 1936.1 1942.1 1944.8 1952.6 2016.1 907.8 997.4 1007.2 1008.8 1041.3 18824.7 18858.8 18905.1 19024.8 19176.7 946.5 991.8 1024.0 1031.5 1045.2 10064.4 10668.5 10721.8 10749.7 10762.1 339218.0 339656.2 340349.0 341654.0 344608.2 65715.0 78074.0 80712.2 87077.6 96661.5 958.5 958.9 961.8 981.9 1005.4 15699.8 15710.1 15729.8 15898.4 15983.3 36371.6 38265.4 38633.8 39041.0 39161.8 52023.5 53178.5 53262.5 54470.0 54634.5 7786.0 7855.8 8037.9 8103.1 8120.1 11215.5 11707.5 11881.6 12806.9 13574.0 10725.2 11117.0 11234.4 11500.9 11869.6 10989.0 11213.5 11286.0 11618.2 11641.9 6594.6 10865.0 11149.5 11895.5 12039.6 7926.7 7974.3 8102.2 8135.5 8182.5 9958.5 11567.4 11787.9 11943.9 12151.3 23:17:42 INFO - PROCESS | 3818 | 23:17:42 INFO - PROCESS | 3818 | [#3] mootools.html Cycles:180 Average:5316.88 Median:4878.59 stddev:2932.84 (60.1%) stddev-sans-first:2925.54 23:17:42 INFO - PROCESS | 3818 | Values: 1301.2 1444.3 1459.2 1483.7 1510.9 6927.5 7867.2 8085.6 8091.6 8093.7 7770.4 7959.5 7967.3 7971.0 7974.1 1874.1 2098.7 2134.2 2168.4 2173.6 2162.6 2183.5 2185.1 2187.5 2189.1 2147.3 2188.3 2196.7 2203.1 2205.8 1845.5 2117.9 2186.2 2186.3 2190.0 2084.7 2106.3 2117.8 2120.4 2153.0 7901.4 7964.2 7966.2 7966.8 7974.2 4655.2 4837.2 4843.9 4865.0 4873.8 3013.8 3029.4 3070.2 3111.7 3132.8 1023.8 1024.8 1025.1 1052.7 1055.7 9904.9 10062.7 10263.4 10270.2 10827.9 3995.7 4019.9 4142.3 4173.5 4206.1 8775.5 8786.1 8793.6 8798.6 8803.3 4115.4 4832.2 4852.2 4867.9 4883.4 4377.9 4422.4 4424.6 4462.7 4467.7 3478.2 3525.9 3587.7 3611.6 3657.7 1010.8 1085.1 1088.5 1090.6 1097.4 961.5 985.2 990.2 996.7 1010.3 5556.7 5716.8 5750.0 5813.0 5932.9 967.4 994.8 1004.0 1016.5 1031.1 4008.9 4160.9 4182.4 4185.6 4197.9 9696.4 10040.4 10146.9 10203.2 10223.3 10032.7 10049.2 10052.5 10067.6 10094.5 7212.8 7521.5 7525.9 7528.8 7665.0 5599.6 5822.9 5879.8 5903.4 5980.3 9112.6 9185.2 9251.7 9275.3 9287.9 9402.2 9408.5 9423.3 9426.4 9540.7 7058.6 7129.8 7140.9 7160.7 7161.3 7589.0 7613.0 7614.6 7650.2 7690.8 6907.7 6949.4 7141.1 7196.6 7223.8 7029.8 7087.9 7104.5 7155.4 7174.9 6523.6 6596.2 6598.1 6599.6 6604.8 4913.1 5009.2 5022.5 5060.9 5087.1 5029.7 5091.9 5113.8 5256.8 5262.9 23:17:42 INFO - PROCESS | 3818 | 23:17:42 INFO - PROCESS | 3818 | [#4] prototype.html Cycles:180 Average:4951.19 Median:5688.40 stddev:1513.37 (26.6%) stddev-sans-first:1476.83 23:17:42 INFO - PROCESS | 3818 | Values: 301.6 312.6 312.9 314.4 315.2 5450.6 5547.1 5649.9 5697.5 5739.4 5614.4 5627.5 5660.7 5673.6 5677.5 4286.8 4296.9 4301.1 4313.6 4316.6 4161.9 4277.2 4310.1 4313.2 4326.7 4241.9 4243.0 4249.8 4253.8 4271.0 4242.2 4254.1 4261.0 4262.6 4264.0 3534.5 3673.9 3701.1 3703.4 3704.5 5445.5 5446.8 5461.5 5478.8 5502.9 4893.5 4899.2 4900.1 4913.5 4924.0 5557.2 5910.8 5911.9 5928.4 5946.7 4038.0 4057.2 4064.5 4075.5 4076.5 6122.5 6193.2 6195.3 6209.3 6210.7 4045.9 4127.6 4148.6 4151.8 4154.3 4136.9 4165.3 4168.6 4171.8 4173.3 4839.6 4858.8 4860.6 4866.5 4871.0 5559.5 5762.5 5897.3 5944.6 5956.2 1435.5 1446.5 1447.9 1455.7 1458.8 931.4 950.7 962.4 970.7 976.4 5654.8 5703.7 5713.7 5727.1 5728.7 6088.5 6102.7 6115.2 6127.7 6132.3 5505.5 5669.5 5677.7 5683.7 5693.1 3245.8 3257.3 3260.3 3260.6 3265.7 6093.9 6295.7 6302.7 6314.5 6324.3 6207.9 6211.7 6217.6 6219.3 6234.6 6257.6 6293.0 6301.2 6316.5 6334.3 5818.1 6181.7 6195.1 6207.0 6214.7 6107.2 6110.4 6115.6 6124.9 6153.5 6271.4 6379.7 6382.3 6417.8 6419.7 4074.0 4092.9 4110.8 4112.0 4114.8 5912.5 5912.6 6195.4 6209.1 6216.6 5936.3 5944.6 5973.4 5980.7 5992.6 5953.8 5963.6 5989.8 6011.2 6014.1 5670.0 5881.9 5912.2 5913.6 5919.3 5989.3 6030.7 6059.6 6065.5 6075.1 5735.6 5912.8 5919.3 5929.6 5932.4 23:17:42 INFO - PROCESS | 3818 | 23:17:42 INFO - PROCESS | 3818 | [#5] yui.html Cycles:180 Average:14264.10 Median:4514.32 stddev:16803.06 (372.2%) stddev-sans-first:16819.91 23:17:42 INFO - PROCESS | 3818 | Values: 830.6 852.0 860.3 861.4 867.8 13616.1 13766.2 13775.8 13925.2 13944.2 12143.9 12247.4 12279.8 12289.9 12301.0 516.8 796.7 821.3 821.4 824.8 819.2 824.2 824.7 825.0 827.3 871.1 871.4 873.0 873.5 873.6 703.8 846.3 870.2 874.7 874.8 636.3 637.6 638.5 638.5 638.7 12912.8 12948.1 12986.4 13000.2 13002.7 13387.8 13576.0 13590.3 13630.0 13681.0 10833.5 10910.5 10937.5 10950.7 11123.2 3753.1 3803.4 3884.7 3920.8 3967.7 52525.5 52551.5 52716.5 52916.5 54205.7 10172.8 10317.9 10376.1 10399.2 10609.9 17125.2 17134.6 17380.3 17401.0 17459.4 7922.8 7975.3 7975.6 8076.9 8131.2 4638.0 4709.9 4733.6 4776.2 4860.3 3208.0 3301.8 3302.5 3304.7 3415.5 572.1 616.7 622.6 629.5 638.6 667.2 701.2 735.3 736.4 794.1 9022.9 9035.6 9279.9 9487.4 9692.6 717.6 721.4 735.4 747.1 753.4 4467.2 4496.3 4511.5 4517.1 4558.5 61413.0 61975.4 63012.1 63287.1 63347.7 55440.7 55490.0 56146.4 56565.0 57405.0 50480.0 51199.0 51221.0 51681.7 52087.7 8396.2 8503.5 8655.3 8754.7 8804.6 28956.7 29139.1 29219.0 29620.7 29905.6 38752.9 38840.4 39720.2 40728.6 41138.4 10600.3 11026.8 11146.2 11332.7 11496.9 12795.2 13000.5 13059.0 13555.6 13669.5 9872.2 11367.7 11884.4 12327.8 12754.4 12338.7 12509.2 12524.4 12537.7 12653.7 11425.0 11581.9 11688.6 11906.2 11933.4 10050.7 10141.5 10574.2 10641.5 10668.6 9879.5 10096.6 10101.8 10132.6 10309.0 23:17:42 INFO - PROCESS | 3818 | -------- Summary: end -------- 23:17:42 INFO - PROCESS | 3818 | 23:17:43 INFO - TEST-INFO | 3818: exit 0 23:17:43 INFO - TEST-OK | dromaeo_css | took 1111178ms 23:17:43 INFO - TEST-START | kraken 23:17:43 INFO - operating with platform_type : linux_ 23:17:43 INFO - Initialising browser for kraken test... 23:17:43 INFO - TEST-INFO | started process 4004 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0MAYpW/profile http://localhost:39068/getInfo.html) 23:17:47 INFO - PROCESS | 4004 | __metrics Screen width/height:1600/1200 23:17:47 INFO - PROCESS | 4004 | colorDepth:24 23:17:47 INFO - PROCESS | 4004 | Browser inner width/height: 1024/697 23:17:47 INFO - PROCESS | 4004 | __metrics 23:17:48 ERROR - PROCESS | 4004 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:17:49 INFO - TEST-INFO | 4004: exit 0 23:17:49 INFO - Browser initialized. 23:17:49 INFO - Running cycle 1/1 for kraken test... 23:17:49 INFO - TEST-INFO | started process 4087 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0MAYpW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:18:01 INFO - PROCESS | 4087 | RSS: Main: 152612864 23:18:01 INFO - PROCESS | 4087 | 23:18:03 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39068/tests/kraken/driver.html?testName=audio-beat-detection) 23:18:04 INFO - PROCESS | 4087 | RSS: Main: 208379904 23:18:04 INFO - PROCESS | 4087 | 23:18:07 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39068/tests/kraken/driver.html?testName=audio-dft) 23:18:07 INFO - PROCESS | 4087 | RSS: Main: 193110016 23:18:07 INFO - PROCESS | 4087 | 23:18:10 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39068/tests/kraken/driver.html?testName=audio-fft) 23:18:11 INFO - PROCESS | 4087 | RSS: Main: 263073792 23:18:11 INFO - PROCESS | 4087 | 23:18:13 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39068/tests/kraken/driver.html?testName=audio-oscillator) 23:18:13 INFO - PROCESS | 4087 | RSS: Main: 172859392 23:18:13 INFO - PROCESS | 4087 | 23:18:16 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39068/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:18:16 INFO - PROCESS | 4087 | RSS: Main: 176959488 23:18:16 INFO - PROCESS | 4087 | 23:18:19 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39068/tests/kraken/driver.html?testName=imaging-darkroom) 23:18:20 INFO - PROCESS | 4087 | RSS: Main: 212996096 23:18:20 INFO - PROCESS | 4087 | 23:18:23 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39068/tests/kraken/driver.html?testName=imaging-desaturate) 23:18:24 INFO - PROCESS | 4087 | RSS: Main: 213725184 23:18:24 INFO - PROCESS | 4087 | 23:18:26 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39068/tests/kraken/driver.html?testName=json-parse-financial) 23:18:27 INFO - PROCESS | 4087 | RSS: Main: 213770240 23:18:27 INFO - PROCESS | 4087 | 23:18:29 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39068/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:18:29 INFO - PROCESS | 4087 | RSS: Main: 199499776 23:18:29 INFO - PROCESS | 4087 | 23:18:31 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39068/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:18:32 INFO - PROCESS | 4087 | RSS: Main: 203284480 23:18:32 INFO - PROCESS | 4087 | 23:18:34 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39068/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:18:34 INFO - PROCESS | 4087 | RSS: Main: 218030080 23:18:34 INFO - PROCESS | 4087 | 23:18:37 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:18:38 INFO - PROCESS | 4087 | RSS: Main: 219398144 23:18:38 INFO - PROCESS | 4087 | 23:18:40 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:18:41 INFO - PROCESS | 4087 | RSS: Main: 216985600 23:18:41 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:39068/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39068/tests/kraken/driver.html?testName=ai-astar) 23:18:43 INFO - PROCESS | 4087 | RSS: Main: 280510464 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | __start_tp_report 23:18:43 INFO - PROCESS | 4087 | _x_x_mozilla_page_load 23:18:43 INFO - PROCESS | 4087 | _x_x_mozilla_page_load_details 23:18:43 INFO - PROCESS | 4087 | |i|pagename|runs| 23:18:43 INFO - PROCESS | 4087 | |0;ai-astar;110;112;107;112;112;111;100;110;111;111 23:18:43 INFO - PROCESS | 4087 | |1;audio-beat-detection;155;126;152;175;128;151;156;127;177;125 23:18:43 INFO - PROCESS | 4087 | |2;audio-dft;160;161;160;161;162;160;162;162;161;161 23:18:43 INFO - PROCESS | 4087 | |3;audio-fft;75;76;106;117;74;76;73;117;101;73 23:18:43 INFO - PROCESS | 4087 | |4;audio-oscillator;93;93;149;93;93;94;145;95;92;147 23:18:43 INFO - PROCESS | 4087 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;117;117 23:18:43 INFO - PROCESS | 4087 | |6;imaging-darkroom;146;146;145;146;145;146;145;146;146;146 23:18:43 INFO - PROCESS | 4087 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;96 23:18:43 INFO - PROCESS | 4087 | |8;json-parse-financial;57;57;58;57;57;56;58;73;56;55 23:18:43 INFO - PROCESS | 4087 | |9;json-stringify-tinderbox;62;63;62;63;62;62;63;61;62;62 23:18:43 INFO - PROCESS | 4087 | |10;stanford-crypto-aes;80;80;80;78;81;81;80;80;88;82 23:18:43 INFO - PROCESS | 4087 | |11;stanford-crypto-ccm;127;127;130;126;125;130;128;129;214;127 23:18:43 INFO - PROCESS | 4087 | |12;stanford-crypto-pbkdf2;164;165;163;164;163;163;165;163;160;166 23:18:43 INFO - PROCESS | 4087 | |13;stanford-crypto-sha256-iterative;67;67;67;67;67;66;67;69;67;78 23:18:43 INFO - PROCESS | 4087 | __end_tp_report 23:18:43 INFO - PROCESS | 4087 | __start_cc_report 23:18:43 INFO - PROCESS | 4087 | _x_x_mozilla_cycle_collect,1594 23:18:43 INFO - PROCESS | 4087 | __end_cc_report 23:18:43 INFO - PROCESS | 4087 | __startTimestamp1460614723351__endTimestamp 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | ------- Summary: start ------- 23:18:43 INFO - PROCESS | 4087 | Number of tests: 14 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.69 (3.3%) stddev-sans-first:3.91 23:18:43 INFO - PROCESS | 4087 | Values: 110.0 112.0 107.0 112.0 112.0 111.0 100.0 110.0 111.0 111.0 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:153.50 stddev:19.88 (12.9%) stddev-sans-first:20.88 23:18:43 INFO - PROCESS | 4087 | Values: 155.0 126.0 152.0 175.0 128.0 151.0 156.0 127.0 177.0 125.0 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 23:18:43 INFO - PROCESS | 4087 | Values: 160.0 161.0 160.0 161.0 162.0 160.0 162.0 162.0 161.0 161.0 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#3] audio-fft Cycles:10 Average:88.80 Median:73.50 stddev:19.07 (25.9%) stddev-sans-first:19.56 23:18:43 INFO - PROCESS | 4087 | Values: 75.0 76.0 106.0 117.0 74.0 76.0 73.0 117.0 101.0 73.0 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:93.00 stddev:25.98 (27.9%) stddev-sans-first:26.86 23:18:43 INFO - PROCESS | 4087 | Values: 93.0 93.0 149.0 93.0 93.0 94.0 145.0 95.0 92.0 147.0 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:18:43 INFO - PROCESS | 4087 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 23:18:43 INFO - PROCESS | 4087 | Values: 146.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:18:43 INFO - PROCESS | 4087 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:57.00 stddev:5.21 (9.1%) stddev-sans-first:5.50 23:18:43 INFO - PROCESS | 4087 | Values: 57.0 57.0 58.0 57.0 57.0 56.0 58.0 73.0 56.0 55.0 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 23:18:43 INFO - PROCESS | 4087 | Values: 62.0 63.0 62.0 63.0 62.0 62.0 63.0 61.0 62.0 62.0 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.50 stddev:2.67 (3.3%) stddev-sans-first:2.80 23:18:43 INFO - PROCESS | 4087 | Values: 80.0 80.0 80.0 78.0 81.0 81.0 80.0 80.0 88.0 82.0 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:128.50 stddev:27.35 (21.3%) stddev-sans-first:28.80 23:18:43 INFO - PROCESS | 4087 | Values: 127.0 127.0 130.0 126.0 125.0 130.0 128.0 129.0 214.0 127.0 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:164.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 23:18:43 INFO - PROCESS | 4087 | Values: 164.0 165.0 163.0 164.0 163.0 163.0 165.0 163.0 160.0 166.0 23:18:43 INFO - PROCESS | 4087 | 23:18:43 INFO - PROCESS | 4087 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:67.00 stddev:3.52 (5.3%) stddev-sans-first:3.71 23:18:43 INFO - PROCESS | 4087 | Values: 67.0 67.0 67.0 67.0 67.0 66.0 67.0 69.0 67.0 78.0 23:18:43 INFO - PROCESS | 4087 | -------- Summary: end -------- 23:18:43 INFO - PROCESS | 4087 | 23:18:44 INFO - TEST-INFO | 4087: exit 0 23:18:44 INFO - TEST-OK | kraken | took 60851ms 23:18:44 INFO - SUITE-END | took 1172s 23:18:44 INFO - Completed test suite (00:19:32) 23:18:44 INFO - javascript benchmark 23:18:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.354805490847, 3131.0606817954636, 3171.0803866878623, 3172.8889488867894, 3193.3134376109138, 5225.137852254374, 5262.368515778107, 5285.682859028451, 5286.550643195333, 5307.840764777058, 5186.740662966846, 5252.789888404459, 5263.236830659552, 5277.287566178565, 5278.287431196787, 4734.928976065362, 4790.23356262998, 4825.638077144211, 4867.196912509432, 4880.389951256093, 4807.134715751164, 4842.152623290927, 4844.5882100021545, 4893.975530122362, 4935.555799978001, 4717.669763116583, 4824.155772739774, 4876.756162191876, 4879.316895634614, 4901.53435423636, 4766.666333356667, 4767.69010014348, 4768.950830817214, 4776.188048031843, 4811.687240329367, 4641.11818754439, 4724.0, 4759.571638552512, 4784.354112194844, 4796.424429068499, 5211.973940130275, 5223.37319521656, 5227.11139106349, 5228.973855130738, 5268.578513718893, 5603.439656034405, 5614.747336369873, 5632.295963004624, 5633.943660563424, 5638.069718496443, 5388.137897936312, 5584.972075139639, 5657.745401456944, 5673.177389278573, 5673.290838645169, 5265.605079619044, 5267.657602255841, 5287.154055351164, 5290.153575427913, 5290.68255904647, 5709.74306156224, 5752.539796816244, 5761.337446193741, 5765.279340082489, 5769.538436925036, 5358.624896257303, 5446.972765136228, 5484.149956756709, 5503.477169668875, 5505.944940550543, 5543.1408131739645, 5555.30558680165, 5558.77764889408, 5560.0, 5560.916586251209, 5536.584756143306, 5536.889262214733, 5537.141743029837, 5538.972305138448, 5590.133529302964, 5465.371482279589, 5599.132134519156, 5624.578156638268, 5635.464630860061, 5674.716264186774, 4185.183889141649, 4185.769782661982, 4190.266703326966, 4190.371444283321, 4220.78896055196, 3708.8331025103935, 3764.792936388525, 3767.3783825669007, 3808.295465338921, 3817.4846395736777, 5221.921671174935, 5245.26566280721, 5277.208418737144, 5283.418823929442, 5289.18017707256, 5585.245991791056, 5622.32532096151, 5631.7747290108755, 5633.943660563424, 5639.63342382752, 5079.492050794891, 5270.262163297141, 5271.0, 5279.208118782137, 5323.015242180131, 4854.732989685601, 4865.537773911473, 4871.391076115486, 4899.461059283476, 4908.779104940286, 5788.9710551447815, 5790.942090579125, 5792.913106303409, 5802.245708057925, 5816.069428891442, 5343.7060961647485, 5585.497305242548, 5608.887822243614, 5609.607327487037, 5653.3781284057895, 5841.32824725162, 5856.502197313106, 5862.472377486047, 5867.442592953663, 5897.174395584536, 5563.0, 5581.190727344593, 5585.720713964204, 5585.804496842754, 5593.8321850344555, 5534.972325138348, 5645.096784514458, 5654.406287339934, 5669.234653321749, 5717.142428635738, 5336.226247194058, 5340.49265319794, 5340.599455040965, 5341.572674185978, 5393.40672526014, 5344.064788662046, 5346.385165705994, 5349.384820745664, 5352.785888564414, 5400.83797486076, 5178.948210517998, 5227.18978558324, 5303.496167864047, 5359.678419294854, 5364.597655175956, 5390.541803946709, 5401.3248343957, 5403.972980135231, 5411.080116380146, 5413.10683737179, 5278.5249327560705, 5281.392639846466, 5284.709340986283, 5298.70857102863, 5331.920021199608], "value": 5159.046185186558, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.7081715368048, 641.2625480697197, 652.6801867085123, 660.0725979998101, 663.1909070933463, 29790.553141702865, 30522.38955220897, 30574.388512229743, 30600.54099188514, 37621.81189094051, 40290.395644065364, 41131.85851768529, 41208.38187427191, 41208.58791412085, 41294.58705412945, 8567.400281980248, 8787.604557794883, 8788.42875213109, 8791.252743516809, 8792.60433280504, 8633.740987770378, 8746.737597872043, 8750.649974001033, 8757.956210218972, 8765.298776097929, 8766.386352955296, 8829.33779966505, 8837.734867953972, 8841.248493878029, 9058.501782401965, 8950.686725964593, 9026.864597031017, 9029.909700903005, 9032.412893161923, 9046.954765226197, 8830.42602230853, 8965.103489651048, 8973.371863969525, 8977.102289771035, 8985.326100542485, 40535.594644053475, 40674.593254067375, 40932.0, 40992.1801563967, 41007.38488922668, 3349.698527132545, 3394.4229480988292, 3406.7615266931325, 3810.580836108026, 4071.796410179479, 31345.8432707835, 31706.682933170836, 31711.20721981946, 31924.840375797972, 32171.6782832171, 4282.657387409, 4395.362672412514, 4396.384506169139, 4452.332150177467, 4457.6433885289425, 206679.0, 207042.0, 207213.0, 207929.0, 208074.0, 45197.0, 45253.321200181366, 45287.0, 45440.3183952241, 45483.31775023377, 58754.706226468596, 58837.70581147067, 58903.705481472316, 58971.70514147402, 59019.70490147522, 15987.920060399856, 16161.353545858034, 16167.35330586787, 16202.594935126715, 16216.918915405584, 11397.658070257905, 11421.257618254953, 11475.196736228383, 11496.827547586792, 11505.539778408769, 14426.927865360605, 16353.754693679604, 16495.422660206834, 16553.337866485446, 16658.833411665728, 5160.819371322061, 6040.758369665252, 6256.74973001084, 6308.653024083719, 6399.328070552618, 868.9217970382696, 881.3698205782896, 894.7226359828474, 903.4534106865383, 1094.8467214589964, 31704.682953170635, 32871.3425731484, 33163.3367332652, 33533.329333413196, 33692.49461258083, 1077.7359546911057, 1126.814075677504, 1213.8846809553079, 1217.0993464835958, 1267.5563552756462, 16273.430429934895, 16327.755083673754, 16356.509304720877, 16477.83522164763, 16509.91745041267, 410368.0, 415726.0, 416087.0, 417257.0, 417620.0, 57661.711691441276, 58133.709331453916, 58145.709271454216, 58218.41781582215, 58326.41673583295, 1230.8522977242787, 1274.936253187337, 1370.0820450298324, 1390.8331000280032, 1436.0163288147862, 29901.401971960004, 30532.168069915875, 30748.0, 30752.0, 30948.535771962986, 42016.0, 42383.0, 42460.36309455299, 42492.5750742501, 42532.36201456919, 199847.0, 202688.0, 203872.0, 203891.0, 204347.0, 35699.28601427905, 36453.63546364503, 41102.58897411107, 41633.37549936693, 42532.1493570133, 35798.28403431969, 36000.81999589985, 36045.63954360423, 36442.453363200104, 36530.0, 33983.320333593685, 36000.0, 37039.44440833336, 37223.0, 37467.62532374641, 36093.63906360903, 36153.81923090473, 36194.45708314325, 36239.45640815337, 36724.265514689025, 40312.0, 40639.593604064765, 41464.1707165861, 41494.17011659689, 41626.167476649694, 33136.0, 34833.24720753671, 35586.82206589054, 35729.64270357263, 36269.27461450809, 27670.584941225494, 27773.305667358476, 28017.719822802326, 28029.859850700617, 28139.71860281371], "value": 18428.56017790929, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.69218087258884, 385.166115360245, 402.88517772434864, 403.65487508180524, 406.3599830267328, 18076.819231807676, 18678.813211867877, 18741.0, 18746.0, 19513.60972780547, 17440.215190316434, 17724.645507089852, 18168.54578635535, 19418.22327106914, 19500.51248718783, 5180.792768289264, 5479.0, 5665.23519324892, 5818.0400233961345, 5844.941550584504, 5408.945910540883, 5431.076716958127, 5442.700651464168, 5461.890762184754, 5462.180672899057, 5445.319335083114, 5449.100898351767, 5561.221428999943, 5977.850553736148, 5988.281406231258, 5913.970430147843, 6042.214512113397, 6044.3955604439425, 6059.36376680451, 6110.633361998272, 5319.148936170232, 5380.273663055476, 5449.6730196188355, 5450.836474905759, 5453.672779633195, 12607.243565386107, 12649.683757906034, 12665.936670316682, 16968.49094527166, 20836.791632083787, 2174.5868285025954, 2203.6804663323887, 2257.4694946687678, 2268.875211863347, 2277.453411181321, 9307.76730581734, 9416.717498475056, 9416.952915235448, 9511.381760185566, 9752.658656946973, 1887.509247595635, 1920.0, 1965.6756635155182, 1980.5939782344728, 1999.9400017999337, 77539.0, 78339.6083019587, 78872.60563697202, 78902.21097789006, 79000.0, 9947.651832185838, 10338.793224135476, 10359.792804143875, 10846.186536009673, 11036.503357348938, 13573.728525429633, 13700.931495342658, 13709.794353084511, 13722.078908952755, 13747.587572372844, 7607.08714954198, 7670.8082297943, 7776.144624091346, 7776.65005074773, 7852.921470785219, 7551.924480755232, 7687.846243075107, 7731.884021739678, 7838.921610783819, 7839.960800196077, 4290.742555446684, 4298.398224248608, 4304.569543045733, 4369.519352871182, 4421.248387774086, 1936.0765244480936, 1942.1357495914183, 1944.826760816222, 1952.580195257998, 2016.1229865008768, 907.7503686486269, 997.3517213811081, 1007.1942446043137, 1008.7931973945324, 1041.3335465302212, 18824.717629235573, 18858.811411885705, 18905.14926828296, 19024.752475247526, 19176.71234931477, 946.4983558713893, 991.8413053911339, 1023.9795204096025, 1031.4687935713114, 1045.153425725165, 10064.446455444875, 10668.519916603771, 10721.83917241242, 10749.677509674722, 10762.139028877828, 339218.0, 339656.2240643131, 340349.0, 341654.0, 344608.15438842186, 65715.0, 78074.0, 80712.19287807046, 87077.56461217653, 96661.51669241609, 958.4824194934657, 958.8705524754068, 961.8268711631973, 981.8723565936383, 1005.4369553050316, 15699.843001569838, 15710.135942523271, 15729.764053539435, 15898.364065437252, 15983.280752366403, 36371.63628363683, 38265.426018609185, 38633.80683096567, 39041.0, 39161.804190978866, 52023.47976520186, 53178.46821531735, 53262.46737532575, 54470.0, 54634.45365546294, 7785.9610701948395, 7855.8036049096945, 8037.879431808411, 8103.108658047492, 8120.066192387715, 11215.495302711235, 11707.531698731955, 11881.5841445549, 12806.935965320114, 13574.0, 10725.249232553646, 11117.0, 11234.382108984084, 11500.94249528747, 11869.5845645402, 10989.0, 11213.495392707511, 11286.0, 11618.186726929034, 11641.88358116408, 6594.637294948824, 10865.0, 11149.498272577592, 11895.524179032742, 12039.63881083569, 7926.682932682858, 7974.322182614543, 8102.189781021851, 8135.471194372347, 8182.509049457051, 9958.502074896081, 11567.363794991355, 11787.882121178678, 11943.940280298542, 12151.331676757864], "value": 8675.163395169222, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.169955347121, 1444.3428240150733, 1459.226609896755, 1483.6513419346452, 1510.8791296696263, 6927.480438967079, 7867.173946735589, 8085.555294458817, 8091.635876385562, 8093.676252949882, 7770.4172187085915, 7959.522428654271, 7967.282944534991, 7970.96014519928, 7974.122846486882, 1874.0723341945757, 2098.674705420662, 2134.2210093315985, 2168.3820111268215, 2173.608750424923, 2162.5999190149796, 2183.4977955070344, 2185.06042401768, 2187.453136715821, 2189.091527016294, 2147.291393840037, 2188.2997440818945, 2196.7473740519804, 2203.0857194264363, 2205.7683943185975, 1845.4555906007693, 2117.947051323714, 2186.158329043322, 2186.3222401055564, 2190.0, 2084.697718830761, 2106.283863486422, 2117.8411619128474, 2120.3638908327594, 2153.0418963561224, 7901.446898717092, 7964.203579642048, 7966.203379662045, 7966.840663186704, 7974.202579742037, 4655.185342565072, 4837.201861692816, 4843.9031219375765, 4864.975675121602, 4873.805047798084, 3013.773966952487, 3029.424409362236, 3070.2477892916377, 3111.6577176510564, 3132.79636823608, 1023.7696518283401, 1024.7950409918046, 1025.1137906252532, 1052.69998050556, 1055.6516349604613, 9904.90095099047, 10062.748431289203, 10263.384196948207, 10270.1783857292, 10827.891721082768, 3995.6603688686787, 4019.9397009044887, 4142.275101857163, 4173.478315210598, 4206.074663574009, 8775.517346545874, 8786.077461866413, 8793.648254069894, 8798.604062817189, 8803.339749518811, 4115.36211887158, 4832.202686556749, 4852.223644216979, 4867.9269810952865, 4883.3651625288485, 4377.934330985037, 4422.3808666786035, 4424.646028317727, 4462.687611867138, 4467.7319360838455, 3478.1652403423504, 3525.9118522036642, 3587.7488575799443, 3611.566612006576, 3657.7256705747177, 1010.7927874785652, 1085.1210519479248, 1088.5319312695617, 1090.5910283643634, 1097.3525619884306, 961.4904100826573, 985.1527686189871, 990.1880458024351, 996.6810620601483, 1010.282699283517, 5556.6943818089585, 5716.7994721109035, 5750.0, 5812.9709351452975, 5932.911006334908, 967.3760424526141, 994.8010397920444, 1004.0, 1016.5323950982483, 1031.0617338222182, 4008.8596899108393, 4160.854370097092, 4182.351735481006, 4185.602367775056, 4197.916041679149, 9696.418214907128, 10040.447775372424, 10146.898531014744, 10203.234757393077, 10223.284370094021, 10032.749181270381, 10049.24630652704, 10052.497375131214, 10067.647632332833, 10094.545745441474, 7212.783616491513, 7521.4734968551675, 7525.887111693329, 7528.811779705551, 7664.961675191588, 5599.60802743804, 5822.912656310074, 5879.764809407576, 5903.380145084704, 5980.252468441445, 9112.635494580407, 9185.219256363283, 9251.722448326562, 9275.30435217348, 9287.860682089638, 9402.247820174507, 9408.482533460725, 9423.29325300619, 9426.387284826464, 9540.666076687283, 7058.6470676467, 7129.7861064168155, 7140.857182856417, 7160.677769500281, 7161.283871613005, 7588.962055189689, 7613.0483689538805, 7614.581198034161, 7650.1584825668015, 7690.846183076419, 6907.723691052302, 6949.4440444765305, 7141.143062832493, 7196.640167991475, 7223.783286501413, 7029.753958611424, 7087.893681594884, 7104.502684812013, 7155.356017958408, 7174.928250717426, 6523.575967562093, 6596.175478065242, 6598.1422415085735, 6599.60402375859, 6604.768833090819, 4913.091078150554, 5009.248612707977, 5022.4977502249485, 5060.898782024413, 5087.084324821568, 5029.673071250357, 5091.872703182302, 5113.846584602468, 5256.789728410974, 5262.868428289324], "value": 4295.072716453348, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.57779109247065, 312.55773081090257, 312.93271946531496, 314.4089112468559, 315.19467759873527, 5450.591205659572, 5547.140193270049, 5649.915251271229, 5697.458741419564, 5739.368669446363, 5614.410486898878, 5627.521660658849, 5660.688662123582, 5673.631213971089, 5677.460641239086, 4286.828526858922, 4296.935545966813, 4301.118270754503, 4313.611774940255, 4316.56834316569, 4161.916761664765, 4277.165952639237, 4310.051788606502, 4313.2451820931365, 4326.653867690593, 4241.893952651193, 4242.957570424287, 4249.830006799724, 4253.766042867641, 4270.957290427087, 4242.172776308621, 4254.149170165979, 4260.957390426087, 4262.616364527192, 4263.978680106579, 3534.5228394166716, 3673.8897833065053, 3701.148735790783, 3703.4444833274956, 3704.49989251453, 5445.455454454563, 5446.782128714846, 5461.508464238238, 5478.753456094485, 5502.889942201174, 4893.535114164184, 4899.240617704261, 4900.068986892479, 4913.508649135094, 4924.0, 5557.249771280906, 5910.763569457216, 5911.93585154672, 5928.407159284037, 5946.699581732137, 4037.9596204037875, 4057.1885622875543, 4064.4512990746166, 4075.5313138988804, 4076.510818701745, 6122.540809439265, 6193.1639228704, 6195.31851496335, 6209.2548894133, 6210.658413787285, 4045.9190816183514, 4127.628513433805, 4148.56440073794, 4151.813168407429, 4154.335306350969, 4136.875893723193, 4165.291900376943, 4168.6039826216465, 4171.83312667496, 4173.31140361843, 4839.612830973514, 4858.805647774049, 4860.586850117779, 4866.46468888422, 4871.0, 5559.527440167631, 5762.4525670061275, 5897.262842144732, 5944.554158438048, 5956.16613674086, 1435.4617018618019, 1446.522647526314, 1447.920364379948, 1455.6724736934104, 1458.752766384747, 931.3713243560569, 950.7100334397936, 962.3600305796567, 970.7427531704104, 976.4043933200742, 5654.773809047592, 5703.686297253691, 5713.657180569179, 5727.140928860621, 5728.656280623176, 6088.512918966472, 6102.72537735803, 6115.239127936287, 6127.693615319216, 6132.325444201134, 5505.476979686923, 5669.489745922887, 5677.716114194273, 5683.658980461103, 5693.146028095736, 3245.789023713451, 3257.250832308535, 3260.3316320154313, 3260.5598244236726, 3265.6571060038827, 6093.908591371133, 6295.685215739195, 6302.684865756693, 6314.494840412756, 6324.272708638566, 6207.937920620826, 6211.720472578745, 6217.564770466024, 6219.253689557282, 6234.604603754342, 6257.5932564383165, 6292.968535157295, 6301.243850737941, 6316.526260530479, 6334.3032266450655, 5818.0981947798155, 6181.690915454299, 6195.132681424694, 6207.0, 6214.658193799384, 6107.236595425394, 6110.358412366638, 6115.602485838406, 6124.938750612437, 6153.538484613582, 6271.3728627136925, 6379.74481020754, 6382.266039405342, 6417.7753778617525, 6419.743210271724, 4073.9592604073578, 4092.897677558085, 4110.807865719027, 4112.0, 4114.753114813121, 5912.46787789101, 5912.645241285537, 6195.380461953769, 6209.099680546386, 6216.595921265103, 5936.317323507852, 5944.613600115978, 5973.372795856372, 5980.730867111078, 5992.550558708202, 5953.791617293374, 5963.552733545088, 5989.8203053908455, 6011.248593925759, 6014.127951447103, 5670.0, 5881.882362352814, 5912.231409916855, 5913.58604897653, 5919.348871624204, 5989.2812862456785, 6030.668313242813, 6059.606125601822, 6065.484433823174, 6075.149479072845, 5735.598508104393, 5912.793052243151, 5919.319278283053, 5929.6145750526075, 5932.436418540232], "value": 4453.387549025852, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.5764060329233, 852.0457088061376, 860.2988564320075, 861.3668953319309, 867.8047439326152, 13616.114952528078, 13766.17402955822, 13775.793363099561, 13925.164490130599, 13944.163350198995, 12143.878561214386, 12247.448864801083, 12279.754404911897, 12289.938550307259, 12301.0, 516.7726200471781, 796.6932730898617, 821.2731732416825, 821.4250024982537, 824.7690646618956, 819.1808191808192, 824.1922915542772, 824.7113510271387, 825.0223485170063, 827.3339961331126, 871.1288711288711, 871.424859592669, 872.9912700873006, 873.4759144513305, 873.6112429968666, 703.802935178151, 846.3313981954249, 870.1820288928387, 874.6588830356167, 874.7944233105216, 636.3064259956669, 637.6301744987942, 638.4605008767584, 638.4796390941368, 638.683851493509, 12912.806307905388, 12948.093633445662, 12986.350682465933, 13000.154989925624, 13002.674933126653, 13387.799183012263, 13576.0, 13590.32048397586, 13630.0, 13681.0, 10833.512491937881, 10910.454477276184, 10937.507812148473, 10950.726231844188, 11123.221374503788, 3753.0598305938156, 3803.448499967517, 3884.7086468514976, 3920.8235629396745, 3967.74209676373, 52525.47474525244, 52551.47448525504, 52716.47283527154, 52916.470835291926, 54205.72897135528, 10172.847407288897, 10317.896821031844, 10376.066154046172, 10399.168066554657, 10609.89390106089, 17125.22936467862, 17134.571635709206, 17380.304787808345, 17401.0, 17459.38892138769, 7922.762317130495, 7975.322097621651, 7975.561344126013, 8076.919230807616, 8131.186881311822, 4638.026014536985, 4709.882252943704, 4733.5503127202865, 4776.2119250324, 4860.270959356125, 3207.951880721791, 3301.8018918864946, 3302.488114342281, 3304.6530114337647, 3415.487676848493, 572.1389309089793, 616.737886398279, 622.6357580815273, 629.5026928726346, 638.6232123047424, 667.1560475997867, 701.225146213437, 735.2610626320513, 736.3814395907357, 794.082834326354, 9022.909770902339, 9035.593398297093, 9279.884925431312, 9487.430754154773, 9692.612295508241, 717.6089031477753, 721.3868212019742, 735.3896266099125, 747.0624366420108, 753.3972821742584, 4467.218236808546, 4496.280595104768, 4511.5262897395305, 4517.11916176349, 4558.475775285819, 61413.0, 61975.38024619786, 63012.05481917775, 63287.050694239624, 63347.6832615834, 55440.72279638576, 55490.0, 56146.438535614936, 56565.0, 57405.0, 50480.0, 51199.0, 51220.97558048818, 51681.74159129256, 52087.739561301954, 8396.202360775716, 8503.489790612583, 8655.264302534355, 8754.737357879274, 8804.647814087364, 28956.710432896245, 29139.12582622525, 29219.0, 29620.703792961795, 29905.551416729202, 38752.930942250656, 38840.41739373855, 39720.205595888496, 40728.59271407248, 41138.38292425556, 10600.257981941499, 11026.779464410827, 11146.219764616399, 11332.660020199408, 11496.88503114958, 12795.232286062866, 13000.544980925622, 13059.0, 13555.59333220005, 13669.521566745514, 9872.210223182272, 11367.715807104889, 11884.405779711153, 12327.815082773586, 12754.42605082792, 12338.691532711755, 12509.249445033327, 12524.37378131108, 12537.686557836127, 12653.746925061263, 11425.0, 11581.942090289494, 11688.590899318484, 11906.226095303777, 11933.4033298333, 10050.69847904564, 10141.543630536791, 10574.15406767472, 10641.521131548943, 10668.573257069631, 9879.456629885426, 10096.596136154472, 10101.797964040825, 10132.645357412455, 10309.0], "value": 6555.181134127502, "unit": "score"}], "name": "dromaeo_css", "value": 6851.2701218996835, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 107.0, 112.0, 112.0, 111.0, 100.0, 110.0, 111.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 152.0, 175.0, 128.0, 151.0, 156.0, 127.0, 177.0, 125.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 162.0, 160.0, 162.0, 162.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 106.0, 117.0, 74.0, 76.0, 73.0, 117.0, 101.0, 73.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 149.0, 93.0, 93.0, 94.0, 145.0, 95.0, 92.0, 147.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 57.0, 57.0, 56.0, 58.0, 73.0, 56.0, 55.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0, 61.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 78.0, 81.0, 81.0, 80.0, 80.0, 88.0, 82.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 130.0, 126.0, 125.0, 130.0, 128.0, 129.0, 214.0, 127.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 164.0, 163.0, 163.0, 165.0, 163.0, 160.0, 166.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 69.0, 67.0, 78.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1543.4, "alertThreshold": 2.0}]} 23:18:44 INFO - Return code: 0 23:18:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:18:44 ERROR - # TBPL SUCCESS # 23:18:44 INFO - Running post-action listener: _resource_record_post_action 23:18:44 INFO - Running post-run listener: _resource_record_post_run 23:18:45 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536080384; Read time: 8; Write time: 415652 23:18:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 243822592; Read time: 0; Write time: 247296 23:18:45 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292196352; Read time: 8; Write time: 168356 23:18:45 INFO - Running post-run listener: _upload_blobber_files 23:18:45 INFO - Blob upload gear active. 23:18:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:18:45 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:18:45 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:18:45 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:18:46 INFO - (blobuploader) - INFO - Open directory for files ... 23:18:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:18:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:18:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:18:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:18:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:18:46 INFO - (blobuploader) - INFO - Done attempting. 23:18:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:18:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:18:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:18:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:18:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:18:47 INFO - (blobuploader) - INFO - Done attempting. 23:18:47 INFO - (blobuploader) - INFO - Iteration through files over. 23:18:47 INFO - Return code: 0 23:18:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:18:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:18:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2ae008ab808ba4102e5ca1e43d7842c3f9c4372a535ad7c51152012a33665fb9f24be257a58583b694f88ade4abf74be3203f0198df43571432785f00f0667a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/009ce5c01e4a84af13c381e9f4374a34adefcde00b719c4fdf301f7809f72cdca73bd7d21d24028624b6e8276706d6eea9605e5c79950c8f4bc2a3f0c62d4b55"} 23:18:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:18:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:18:47 INFO - Contents: 23:18:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2ae008ab808ba4102e5ca1e43d7842c3f9c4372a535ad7c51152012a33665fb9f24be257a58583b694f88ade4abf74be3203f0198df43571432785f00f0667a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/009ce5c01e4a84af13c381e9f4374a34adefcde00b719c4fdf301f7809f72cdca73bd7d21d24028624b6e8276706d6eea9605e5c79950c8f4bc2a3f0c62d4b55"} 23:18:47 INFO - Running post-run listener: copy_logs_to_upload_dir 23:18:47 INFO - Copying logs to upload dir... 23:18:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:18:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.837913 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-13 23:18:47.786272) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 23:18:47.789492) ========= 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-1460612528.810122-2029278502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2ae008ab808ba4102e5ca1e43d7842c3f9c4372a535ad7c51152012a33665fb9f24be257a58583b694f88ade4abf74be3203f0198df43571432785f00f0667a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/009ce5c01e4a84af13c381e9f4374a34adefcde00b719c4fdf301f7809f72cdca73bd7d21d24028624b6e8276706d6eea9605e5c79950c8f4bc2a3f0c62d4b55"} build_url:https://queue.taskcluster.net/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011498 build_url: 'https://queue.taskcluster.net/v1/task/O-qz74yZR9yowlI01hQYoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2ae008ab808ba4102e5ca1e43d7842c3f9c4372a535ad7c51152012a33665fb9f24be257a58583b694f88ade4abf74be3203f0198df43571432785f00f0667a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/009ce5c01e4a84af13c381e9f4374a34adefcde00b719c4fdf301f7809f72cdca73bd7d21d24028624b6e8276706d6eea9605e5c79950c8f4bc2a3f0c62d4b55"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 23:18:47.814865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 23:18:47.815240) ========= 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-1460612528.810122-2029278502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 23:18:47.910508) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 23:18:47.910867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 23:18:47.911210) ========= ========= Total master_lag: 0.31 =========