builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1455431231.81 results: success (0) buildid: 20160213193337 builduid: b7fb0b8fe6294e95a322dbefbe898940 revision: e355cacefc881ba360d412853b57e8e060e966f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:11.813863) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:11.814872) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:11.815531) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006450 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.21 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.028956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.029261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.099093) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.099408) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.149005) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.149309) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.152787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.153103) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-13 22:27:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.5M=0s 2016-02-13 22:27:14 (35.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149828 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.328340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.328661) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016824 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.389521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-13 22:27:12.389875) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e355cacefc881ba360d412853b57e8e060e966f4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e355cacefc881ba360d412853b57e8e060e966f4 --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=e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-13 22:27:14,234 truncating revision to first 12 chars 2016-02-13 22:27:14,234 Setting DEBUG logging. 2016-02-13 22:27:14,234 attempt 1/10 2016-02-13 22:27:14,234 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e355cacefc88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-13 22:27:15,172 unpacking tar archive at: mozilla-central-e355cacefc88/testing/mozharness/ program finished with exit code 0 elapsedTime=1.232020 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-13 22:27:13.636464) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:13.637183) ========= echo e355cacefc881ba360d412853b57e8e060e966f4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e355cacefc881ba360d412853b57e8e060e966f4'] 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=e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e355cacefc881ba360d412853b57e8e060e966f4 program finished with exit code 0 elapsedTime=0.004654 script_repo_revision: 'e355cacefc881ba360d412853b57e8e060e966f4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:13.689797) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:13.690137) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:13.700275) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-02-13 22:27:13.700595) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:27:15 INFO - MultiFileLogger online at 20160213 22:27:15 in /builds/slave/test-pgo 22:27:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:27:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:27:15 INFO - {'append_to_log': False, 22:27:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:27:15 INFO - 'blob_upload_branch': 'Firefox', 22:27:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:27:15 INFO - 'branch': 'Firefox', 22:27:15 INFO - 'buildbot_json_path': 'buildprops.json', 22:27:15 INFO - 'config_files': ('talos/linux_config.py',), 22:27:15 INFO - 'default_actions': ('clobber', 22:27:15 INFO - 'read-buildbot-config', 22:27:15 INFO - 'download-and-extract', 22:27:15 INFO - 'populate-webroot', 22:27:15 INFO - 'create-virtualenv', 22:27:15 INFO - 'install', 22:27:15 INFO - 'run-tests'), 22:27:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:27:15 INFO - 'download_minidump_stackwalk': True, 22:27:15 INFO - 'download_symbols': 'ondemand', 22:27:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:27:15 INFO - 'tooltool.py': '/tools/tooltool.py', 22:27:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:27:15 INFO - '/tools/misc-python/virtualenv.py')}, 22:27:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:27:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:27:15 INFO - 'installer_path': 'installer.exe', 22:27:15 INFO - 'log_level': 'info', 22:27:15 INFO - 'log_name': 'talos', 22:27:15 INFO - 'log_to_console': True, 22:27:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:27:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:27:15 INFO - 'opt_config_files': (), 22:27:15 INFO - 'pip_index': False, 22:27:15 INFO - 'sps_profile': False, 22:27:15 INFO - 'sps_profile_interval': 0, 22:27:15 INFO - 'suite': 'dromaeojs-e10s', 22:27:15 INFO - 'system_bits': '32', 22:27:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:27:15 INFO - 'title': 'talos-linux64-ix-067', 22:27:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:27:15 INFO - 'use_talos_json': True, 22:27:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:27:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:27:15 INFO - 'work_dir': 'build'} 22:27:15 INFO - ##### 22:27:15 INFO - ##### Running clobber step. 22:27:15 INFO - ##### 22:27:15 INFO - Running pre-action listener: _resource_record_pre_action 22:27:15 INFO - Running main action method: clobber 22:27:15 INFO - rmtree: /builds/slave/test-pgo/build 22:27:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:27:16 INFO - Running post-action listener: _resource_record_post_action 22:27:16 INFO - ##### 22:27:16 INFO - ##### Running read-buildbot-config step. 22:27:16 INFO - ##### 22:27:16 INFO - Running pre-action listener: _resource_record_pre_action 22:27:16 INFO - Running main action method: read_buildbot_config 22:27:16 INFO - Using buildbot properties: 22:27:16 INFO - { 22:27:16 INFO - "project": "", 22:27:16 INFO - "product": "firefox", 22:27:16 INFO - "script_repo_revision": "production", 22:27:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:27:16 INFO - "repository": "", 22:27:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:27:16 INFO - "buildid": "20160213193337", 22:27:16 INFO - "pgo_build": "True", 22:27:16 INFO - "basedir": "/builds/slave/test-pgo", 22:27:16 INFO - "buildnumber": 638, 22:27:16 INFO - "slavename": "talos-linux64-ix-067", 22:27:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:27:16 INFO - "platform": "ubuntu64_hw", 22:27:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:27:16 INFO - "branch": "mozilla-central", 22:27:16 INFO - "repo_path": "mozilla-central", 22:27:16 INFO - "revision": "e355cacefc881ba360d412853b57e8e060e966f4", 22:27:16 INFO - "stage_platform": "linux64-pgo", 22:27:16 INFO - "builduid": "b7fb0b8fe6294e95a322dbefbe898940", 22:27:16 INFO - "slavebuilddir": "test" 22:27:16 INFO - } 22:27:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:27:16 INFO - Running post-action listener: _resource_record_post_action 22:27:16 INFO - ##### 22:27:16 INFO - ##### Running download-and-extract step. 22:27:16 INFO - ##### 22:27:16 INFO - Running pre-action listener: _resource_record_pre_action 22:27:16 INFO - Running main action method: download_and_extract 22:27:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:27: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:27:16 INFO - https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:27:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/test_packages.json 22:27:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/test_packages.json 22:27:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:27:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:27:20 INFO - Downloaded 1448 bytes. 22:27:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:27:20 INFO - Using the following test package requirements: 22:27:20 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:27:20 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:27:20 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:27:20 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:20 INFO - u'jsshell-linux-x86_64.zip'], 22:27:20 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:27:20 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:27:20 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:27:20 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:27:20 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:27:20 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:27:20 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:27:20 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:27:20 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:27:20 INFO - https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:27:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:27:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:27:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:27:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:27:26 INFO - Downloaded 23296245 bytes. 22:27:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:27:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:27:27 INFO - Return code: 0 22:27:27 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:27 INFO - https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:27:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:27:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:27:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:27:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:27:29 INFO - Downloaded 23296245 bytes. 22:27:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:27:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:27:30 INFO - Return code: 0 22:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:30 INFO - https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:27:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:27:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:27:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:27:31 INFO - Downloaded 10707070 bytes. 22:27:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:27:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:27:31 INFO - Return code: 0 22:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:31 INFO - https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:27:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:27:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:27:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:27:34 INFO - Downloaded 56509585 bytes. 22:27:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:27:34 INFO - mkdir: /builds/slave/test-pgo/properties 22:27:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:27:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:27:34 INFO - Contents: 22:27:34 INFO - build_url:https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:27:35 INFO - Running post-action listener: _resource_record_post_action 22:27:35 INFO - Running post-action listener: set_extra_try_arguments 22:27:35 INFO - ##### 22:27:35 INFO - ##### Running populate-webroot step. 22:27:35 INFO - ##### 22:27:35 INFO - Running pre-action listener: _resource_record_pre_action 22:27:35 INFO - Running main action method: populate_webroot 22:27:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:27:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:27:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:27:35 INFO - '--tppagecycles', 22:27:35 INFO - '7'], 22:27:35 INFO - 'tests': ['tsvgm']}}, 22:27:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:27:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:27:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:27:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:27:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:27:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:27:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:27:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:35 INFO - 'talos_options': ['--e10s'], 22:27:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:27:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:35 INFO - 'tests': ['damp', 'tps']}, 22:27:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:35 INFO - 'talos_options': ['--e10s'], 22:27:35 INFO - 'tests': ['damp', 'tps']}, 22:27:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:27:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:27:35 INFO - 'other': {'tests': ['a11yr', 22:27:35 INFO - 'ts_paint', 22:27:35 INFO - 'tpaint', 22:27:35 INFO - 'sessionrestore', 22:27:35 INFO - 'sessionrestore_no_auto_restore']}, 22:27:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:27:35 INFO - 'tests': ['a11yr', 22:27:35 INFO - 'ts_paint', 22:27:35 INFO - 'tpaint', 22:27:35 INFO - 'sessionrestore', 22:27:35 INFO - 'sessionrestore_no_auto_restore']}, 22:27:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:27:35 INFO - 'tests': ['a11yr', 22:27:35 INFO - 'ts_paint', 22:27:35 INFO - 'tpaint', 22:27:35 INFO - 'sessionrestore', 22:27:35 INFO - 'sessionrestore_no_auto_restore']}, 22:27:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:27:35 INFO - 'tests': ['a11yr', 22:27:35 INFO - 'ts_paint', 22:27:35 INFO - 'tpaint', 22:27:35 INFO - 'sessionrestore', 22:27:35 INFO - 'sessionrestore_no_auto_restore']}, 22:27:35 INFO - 'other_l64': {'tests': ['a11yr', 22:27:35 INFO - 'ts_paint', 22:27:35 INFO - 'tpaint', 22:27:35 INFO - 'sessionrestore', 22:27:35 INFO - 'sessionrestore_no_auto_restore']}, 22:27:35 INFO - 'other_nol64': {'tests': ['a11yr', 22:27:35 INFO - 'ts_paint', 22:27:35 INFO - 'tpaint', 22:27:35 INFO - 'sessionrestore', 22:27:35 INFO - 'sessionrestore_no_auto_restore']}, 22:27:35 INFO - 'svgr': {'tests': ['tsvgx', 22:27:35 INFO - 'tsvgr_opacity', 22:27:35 INFO - 'tart', 22:27:35 INFO - 'tscrollx', 22:27:35 INFO - 'cart']}, 22:27:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:27:35 INFO - 'tests': ['tsvgx', 22:27:35 INFO - 'tsvgr_opacity', 22:27:35 INFO - 'tart', 22:27:35 INFO - 'tscrollx', 22:27:35 INFO - 'cart']}, 22:27:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:35 INFO - 'tests': ['tp5o']}, 22:27:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:35 INFO - 'talos_options': ['--e10s'], 22:27:35 INFO - 'tests': ['tp5o']}, 22:27:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:35 INFO - 'talos_options': ['--xperf_path', 22:27:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:27:35 INFO - 'tests': ['tp5n']}, 22:27:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:35 INFO - 'talos_options': ['--e10s', 22:27:35 INFO - '--xperf_path', 22:27:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:27:35 INFO - 'tests': ['tp5n']}}, 22:27:35 INFO - 'talos.zip': {'path': '', 22:27:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:27:35 INFO - Running post-action listener: _resource_record_post_action 22:27:35 INFO - ##### 22:27:35 INFO - ##### Running create-virtualenv step. 22:27:35 INFO - ##### 22:27:35 INFO - Running pre-action listener: _resource_record_pre_action 22:27:35 INFO - Running main action method: create_virtualenv 22:27:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:27:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:27:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:27:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:27:35 INFO - Using real prefix '/usr' 22:27:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:27:35 INFO - Installing distribute.............................................................................................................................................................................................done. 22:27:37 INFO - Installing pip.................done. 22:27:37 INFO - Return code: 0 22:27:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:27: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:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff40243df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8c0>, '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 0x13fd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fdc50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', '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:27: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:27: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 pip>=1.5 22:27:37 INFO - Using env: {'DISPLAY': ':0', 22:27:37 INFO - 'HOME': '/home/cltbld', 22:27:37 INFO - 'LANG': 'en_US.UTF-8', 22:27:37 INFO - 'LANGUAGE': 'en_US:en', 22:27:37 INFO - 'LOGNAME': 'cltbld', 22:27:37 INFO - 'MAIL': '/var/mail/cltbld', 22:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:37 INFO - 'MOZ_NO_REMOTE': '1', 22:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:37 INFO - 'NO_EM_RESTART': '1', 22:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:37 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:37 INFO - 'SHELL': '/bin/bash', 22:27:37 INFO - 'SHLVL': '1', 22:27:37 INFO - 'TERM': 'linux', 22:27:37 INFO - 'TMOUT': '86400', 22:27:37 INFO - 'USER': 'cltbld', 22:27:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', 22:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:37 INFO - '_': '/tools/buildbot/bin/python'} 22:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:27:38 INFO - Cleaning up... 22:27:38 INFO - Return code: 0 22:27:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff40243df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8c0>, '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 0x13fd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fdc50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', '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:27:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:27:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:27:38 INFO - Using env: {'DISPLAY': ':0', 22:27:38 INFO - 'HOME': '/home/cltbld', 22:27:38 INFO - 'LANG': 'en_US.UTF-8', 22:27:38 INFO - 'LANGUAGE': 'en_US:en', 22:27:38 INFO - 'LOGNAME': 'cltbld', 22:27:38 INFO - 'MAIL': '/var/mail/cltbld', 22:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:38 INFO - 'MOZ_NO_REMOTE': '1', 22:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:38 INFO - 'NO_EM_RESTART': '1', 22:27:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:38 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:38 INFO - 'SHELL': '/bin/bash', 22:27:38 INFO - 'SHLVL': '1', 22:27:38 INFO - 'TERM': 'linux', 22:27:38 INFO - 'TMOUT': '86400', 22:27:38 INFO - 'USER': 'cltbld', 22:27:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', 22:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:38 INFO - '_': '/tools/buildbot/bin/python'} 22:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:38 INFO - Downloading/unpacking psutil>=0.7.1 22:27: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:27: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:27: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:27: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:27: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:27: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:27:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:27:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:40 INFO - Installing collected packages: psutil 22:27:40 INFO - Running setup.py install for psutil 22:27:40 INFO - building 'psutil._psutil_linux' extension 22:27:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:27:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:27:40 INFO - building 'psutil._psutil_posix' extension 22:27:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:27:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:27:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:40 INFO - Successfully installed psutil 22:27:40 INFO - Cleaning up... 22:27:40 INFO - Return code: 0 22:27:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff40243df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8c0>, '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 0x13fd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fdc50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', '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:27:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:27:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:27:40 INFO - Using env: {'DISPLAY': ':0', 22:27:40 INFO - 'HOME': '/home/cltbld', 22:27:40 INFO - 'LANG': 'en_US.UTF-8', 22:27:40 INFO - 'LANGUAGE': 'en_US:en', 22:27:40 INFO - 'LOGNAME': 'cltbld', 22:27:40 INFO - 'MAIL': '/var/mail/cltbld', 22:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:40 INFO - 'MOZ_NO_REMOTE': '1', 22:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:40 INFO - 'NO_EM_RESTART': '1', 22:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:40 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:40 INFO - 'SHELL': '/bin/bash', 22:27:40 INFO - 'SHLVL': '1', 22:27:40 INFO - 'TERM': 'linux', 22:27:40 INFO - 'TMOUT': '86400', 22:27:40 INFO - 'USER': 'cltbld', 22:27:40 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', 22:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:40 INFO - '_': '/tools/buildbot/bin/python'} 22:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:27:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:27:42 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:27:42 INFO - Installing collected packages: mozsystemmonitor 22:27:42 INFO - Running setup.py install for mozsystemmonitor 22:27:42 INFO - Successfully installed mozsystemmonitor 22:27:42 INFO - Cleaning up... 22:27:42 INFO - Return code: 0 22:27:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:27:42 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:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff40243df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8c0>, '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 0x13fd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fdc50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', '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:27:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:27:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:27:43 INFO - Using env: {'DISPLAY': ':0', 22:27:43 INFO - 'HOME': '/home/cltbld', 22:27:43 INFO - 'LANG': 'en_US.UTF-8', 22:27:43 INFO - 'LANGUAGE': 'en_US:en', 22:27:43 INFO - 'LOGNAME': 'cltbld', 22:27:43 INFO - 'MAIL': '/var/mail/cltbld', 22:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:43 INFO - 'MOZ_NO_REMOTE': '1', 22:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:43 INFO - 'NO_EM_RESTART': '1', 22:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:43 INFO - 'SHELL': '/bin/bash', 22:27:43 INFO - 'SHLVL': '1', 22:27:43 INFO - 'TERM': 'linux', 22:27:43 INFO - 'TMOUT': '86400', 22:27:43 INFO - 'USER': 'cltbld', 22:27:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', 22:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:43 INFO - '_': '/tools/buildbot/bin/python'} 22:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:43 INFO - Downloading/unpacking blobuploader==1.2.4 22:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:44 INFO - Downloading blobuploader-1.2.4.tar.gz 22:27:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:27:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:27: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:27: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:27: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:27: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:27: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:27: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:27:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:27:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:27: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:27: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:27: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:27: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:27: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:27: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:27:45 INFO - Downloading docopt-0.6.1.tar.gz 22:27:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:27:45 INFO - Installing collected packages: blobuploader, requests, docopt 22:27:45 INFO - Running setup.py install for blobuploader 22:27:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:27:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:27:46 INFO - Running setup.py install for requests 22:27:46 INFO - Running setup.py install for docopt 22:27:46 INFO - Successfully installed blobuploader requests docopt 22:27:46 INFO - Cleaning up... 22:27:46 INFO - Return code: 0 22:27:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff40243df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8c0>, '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 0x13fd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fdc50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', '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:27:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:27:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:27:46 INFO - Using env: {'DISPLAY': ':0', 22:27:46 INFO - 'HOME': '/home/cltbld', 22:27:46 INFO - 'LANG': 'en_US.UTF-8', 22:27:46 INFO - 'LANGUAGE': 'en_US:en', 22:27:46 INFO - 'LOGNAME': 'cltbld', 22:27:46 INFO - 'MAIL': '/var/mail/cltbld', 22:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:46 INFO - 'MOZ_NO_REMOTE': '1', 22:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:46 INFO - 'NO_EM_RESTART': '1', 22:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:46 INFO - 'SHELL': '/bin/bash', 22:27:46 INFO - 'SHLVL': '1', 22:27:46 INFO - 'TERM': 'linux', 22:27:46 INFO - 'TMOUT': '86400', 22:27:46 INFO - 'USER': 'cltbld', 22:27:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', 22:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:46 INFO - '_': '/tools/buildbot/bin/python'} 22:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:27:46 INFO - Running setup.py (path:/tmp/pip-py8ilm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:27:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:27:46 INFO - Running setup.py (path:/tmp/pip-b57sJS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:27:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:27:46 INFO - Running setup.py (path:/tmp/pip-r6x4V6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:27:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:27:46 INFO - Running setup.py (path:/tmp/pip-PUTaDb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:27:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:27:47 INFO - Running setup.py (path:/tmp/pip-8WPRtt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:27:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:27:47 INFO - Running setup.py (path:/tmp/pip-Nl7Arg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:27:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:27:47 INFO - Running setup.py (path:/tmp/pip-RMVADU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:27:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:27:47 INFO - Running setup.py (path:/tmp/pip-pHxnj5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:27:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:27:47 INFO - Running setup.py (path:/tmp/pip-kGesYt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:27:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:27:47 INFO - Running setup.py (path:/tmp/pip-EZLxXa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:27:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:27:47 INFO - Running setup.py (path:/tmp/pip-_pRQK2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:27:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:27:47 INFO - Running setup.py (path:/tmp/pip-R32Rmv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:27:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:27:47 INFO - Running setup.py (path:/tmp/pip-nZiU0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:27:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:27:47 INFO - Running setup.py (path:/tmp/pip-MNFXHA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:27:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:27:47 INFO - Running setup.py (path:/tmp/pip-9dlyLt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:27:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:27:47 INFO - Running setup.py (path:/tmp/pip-bCFimR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:27:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:27:47 INFO - Running setup.py (path:/tmp/pip-m9fRhr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:27:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:27:47 INFO - Running setup.py install for manifestparser 22:27:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:27:48 INFO - Running setup.py install for mozcrash 22:27:48 INFO - Running setup.py install for mozdebug 22:27:48 INFO - Running setup.py install for mozdevice 22:27:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:27:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:27:48 INFO - Running setup.py install for mozfile 22:27:48 INFO - Running setup.py install for mozhttpd 22:27:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:27:48 INFO - Running setup.py install for mozinfo 22:27:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:27:48 INFO - Running setup.py install for mozInstall 22:27:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:27:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:27:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:27:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:27:48 INFO - Running setup.py install for mozleak 22:27:48 INFO - Running setup.py install for mozlog 22:27:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:27:48 INFO - Running setup.py install for moznetwork 22:27:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:27:49 INFO - Running setup.py install for mozprocess 22:27:49 INFO - Running setup.py install for mozprofile 22:27:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:27:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:27:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:27:49 INFO - Running setup.py install for mozrunner 22:27:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:27:49 INFO - Running setup.py install for mozscreenshot 22:27:49 INFO - Running setup.py install for moztest 22:27:49 INFO - Running setup.py install for mozversion 22:27:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:27:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:27:49 INFO - Cleaning up... 22:27:49 INFO - Return code: 0 22:27:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:49 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 0x7ff40243df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8c0>, '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 0x13fd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fdc50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', '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:27:49 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:27:49 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:27:49 INFO - Using env: {'DISPLAY': ':0', 22:27:49 INFO - 'HOME': '/home/cltbld', 22:27:49 INFO - 'LANG': 'en_US.UTF-8', 22:27:49 INFO - 'LANGUAGE': 'en_US:en', 22:27:49 INFO - 'LOGNAME': 'cltbld', 22:27:49 INFO - 'MAIL': '/var/mail/cltbld', 22:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:49 INFO - 'MOZ_NO_REMOTE': '1', 22:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:49 INFO - 'NO_EM_RESTART': '1', 22:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:49 INFO - 'SHELL': '/bin/bash', 22:27:49 INFO - 'SHLVL': '1', 22:27:49 INFO - 'TERM': 'linux', 22:27:49 INFO - 'TMOUT': '86400', 22:27:49 INFO - 'USER': 'cltbld', 22:27:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', 22:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:49 INFO - '_': '/tools/buildbot/bin/python'} 22:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:27:49 INFO - Running setup.py (path:/tmp/pip-MpvgzD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:27:50 INFO - Running setup.py (path:/tmp/pip-BnmgL0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:27:50 INFO - Running setup.py (path:/tmp/pip-G8KXRG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:27:50 INFO - Running setup.py (path:/tmp/pip-Dwbs9V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:27:50 INFO - Running setup.py (path:/tmp/pip-mO6uHp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:27:50 INFO - Running setup.py (path:/tmp/pip-Cm91Tp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:27:50 INFO - Running setup.py (path:/tmp/pip-wUd0jO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:27:50 INFO - Running setup.py (path:/tmp/pip-NXjlEJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:27:50 INFO - Running setup.py (path:/tmp/pip-dNoLgD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:27:50 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:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:27:50 INFO - Running setup.py (path:/tmp/pip-vig7gt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:27:50 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:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:27:50 INFO - Running setup.py (path:/tmp/pip-lKgPd_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:27:50 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:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:27:50 INFO - Running setup.py (path:/tmp/pip-C9B3pL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:27:50 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:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:27:50 INFO - Running setup.py (path:/tmp/pip-nHxcW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:27:50 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:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:27:50 INFO - Running setup.py (path:/tmp/pip-hluM_f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:27:50 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:27:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:27:50 INFO - Running setup.py (path:/tmp/pip-r8vEp6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:27:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:27:51 INFO - Running setup.py (path:/tmp/pip-gsBi2S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:27:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:27:51 INFO - Running setup.py (path:/tmp/pip-8ToEAZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:27:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:27: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:27: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:27: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:27: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:27: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:27: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:27:52 INFO - Downloading blessings-1.6.tar.gz 22:27:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:27:53 INFO - Installing collected packages: blessings 22:27:53 INFO - Running setup.py install for blessings 22:27:53 INFO - Successfully installed blessings 22:27:53 INFO - Cleaning up... 22:27:53 INFO - Return code: 0 22:27:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:27:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:27:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:27:53 INFO - Reading from file tmpfile_stdout 22:27:53 INFO - Current package versions: 22:27:53 INFO - argparse == 1.2.1 22:27:53 INFO - blessings == 1.6 22:27:53 INFO - blobuploader == 1.2.4 22:27:53 INFO - docopt == 0.6.1 22:27:53 INFO - manifestparser == 1.1 22:27:53 INFO - mozInstall == 1.12 22:27:53 INFO - mozcrash == 0.16 22:27:53 INFO - mozdebug == 0.1 22:27:53 INFO - mozdevice == 0.48 22:27:53 INFO - mozfile == 1.2 22:27:53 INFO - mozhttpd == 0.7 22:27:53 INFO - mozinfo == 0.9 22:27:53 INFO - mozleak == 0.1 22:27:53 INFO - mozlog == 3.1 22:27:53 INFO - moznetwork == 0.27 22:27:53 INFO - mozprocess == 0.22 22:27:53 INFO - mozprofile == 0.28 22:27:53 INFO - mozrunner == 6.11 22:27:53 INFO - mozscreenshot == 0.1 22:27:53 INFO - mozsystemmonitor == 0.0 22:27:53 INFO - moztest == 0.7 22:27:53 INFO - mozversion == 1.4 22:27:53 INFO - psutil == 3.1.1 22:27:53 INFO - requests == 1.2.3 22:27:53 INFO - wsgiref == 0.1.2 22:27:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:53 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 0x7ff40243df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8c0>, '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 0x13fd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fdc50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', '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:27:53 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:27:53 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:27:53 INFO - Using env: {'DISPLAY': ':0', 22:27:53 INFO - 'HOME': '/home/cltbld', 22:27:53 INFO - 'LANG': 'en_US.UTF-8', 22:27:53 INFO - 'LANGUAGE': 'en_US:en', 22:27:53 INFO - 'LOGNAME': 'cltbld', 22:27:53 INFO - 'MAIL': '/var/mail/cltbld', 22:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:53 INFO - 'MOZ_NO_REMOTE': '1', 22:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:53 INFO - 'NO_EM_RESTART': '1', 22:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:53 INFO - 'SHELL': '/bin/bash', 22:27:53 INFO - 'SHLVL': '1', 22:27:53 INFO - 'TERM': 'linux', 22:27:53 INFO - 'TMOUT': '86400', 22:27:53 INFO - 'USER': 'cltbld', 22:27:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', 22:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:53 INFO - '_': '/tools/buildbot/bin/python'} 22:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:53 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:27:53 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:27:53 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:27:53 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:27:53 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:27:53 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:27:53 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:27:53 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:27:53 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:27:53 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:27:53 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:27:53 INFO - Cleaning up... 22:27:53 INFO - Return code: 0 22:27:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff40243df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8c0>, '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 0x13fd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fdc50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', '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:27:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:27:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:27:53 INFO - Using env: {'DISPLAY': ':0', 22:27:53 INFO - 'HOME': '/home/cltbld', 22:27:53 INFO - 'LANG': 'en_US.UTF-8', 22:27:53 INFO - 'LANGUAGE': 'en_US:en', 22:27:53 INFO - 'LOGNAME': 'cltbld', 22:27:53 INFO - 'MAIL': '/var/mail/cltbld', 22:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:53 INFO - 'MOZ_NO_REMOTE': '1', 22:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:53 INFO - 'NO_EM_RESTART': '1', 22:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:53 INFO - 'SHELL': '/bin/bash', 22:27:53 INFO - 'SHLVL': '1', 22:27:53 INFO - 'TERM': 'linux', 22:27:53 INFO - 'TMOUT': '86400', 22:27:53 INFO - 'USER': 'cltbld', 22:27:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', 22:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:53 INFO - '_': '/tools/buildbot/bin/python'} 22:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:53 INFO - Downloading/unpacking jsonschema 22:27: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:27: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:27: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:27: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:27: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:27: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:27:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:27:55 INFO - Downloading/unpacking functools32 (from jsonschema) 22:27:55 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:27:55 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:27:55 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:27:55 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:27:55 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:27:55 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:27:55 INFO - Downloading functools32-3.2.3-2.tar.gz 22:27:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:27:55 INFO - warning: no files found matching '*.txt' 22:27:55 INFO - no previously-included directories found matching 'build' 22:27:55 INFO - no previously-included directories found matching 'dist' 22:27:55 INFO - no previously-included directories found matching '.git*' 22:27:55 INFO - Installing collected packages: jsonschema, functools32 22:27:56 INFO - Running setup.py install for functools32 22:27:56 INFO - warning: no files found matching '*.txt' 22:27:56 INFO - no previously-included directories found matching 'build' 22:27:56 INFO - no previously-included directories found matching 'dist' 22:27:56 INFO - no previously-included directories found matching '.git*' 22:27:56 INFO - Successfully installed jsonschema functools32 22:27:56 INFO - Cleaning up... 22:27:56 INFO - Return code: 0 22:27:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff40243df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fc8c0>, '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 0x13fd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fdc50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', '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:27:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:27:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:27:56 INFO - Using env: {'DISPLAY': ':0', 22:27:56 INFO - 'HOME': '/home/cltbld', 22:27:56 INFO - 'LANG': 'en_US.UTF-8', 22:27:56 INFO - 'LANGUAGE': 'en_US:en', 22:27:56 INFO - 'LOGNAME': 'cltbld', 22:27:56 INFO - 'MAIL': '/var/mail/cltbld', 22:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:56 INFO - 'MOZ_NO_REMOTE': '1', 22:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:56 INFO - 'NO_EM_RESTART': '1', 22:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:56 INFO - 'SHELL': '/bin/bash', 22:27:56 INFO - 'SHLVL': '1', 22:27:56 INFO - 'TERM': 'linux', 22:27:56 INFO - 'TMOUT': '86400', 22:27:56 INFO - 'USER': 'cltbld', 22:27:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', 22:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:56 INFO - '_': '/tools/buildbot/bin/python'} 22:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:56 INFO - Downloading/unpacking flake8 22:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:27:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:27:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:27:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:27:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:27:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:27:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:27:58 INFO - no previously-included directories found matching 'docs/_build' 22:27:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:27:58 INFO - Running setup.py install for pep8 22:27:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:27:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:27:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:27:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:27:59 INFO - no previously-included directories found matching 'docs/_build' 22:27:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:27:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:27:59 INFO - Cleaning up... 22:27:59 INFO - Return code: 0 22:27:59 INFO - Running post-action listener: _resource_record_post_action 22:27:59 INFO - Running post-action listener: _start_resource_monitoring 22:27:59 INFO - Starting resource monitoring. 22:27:59 INFO - ##### 22:27:59 INFO - ##### Running install step. 22:27:59 INFO - ##### 22:27:59 INFO - Running pre-action listener: _resource_record_pre_action 22:27:59 INFO - Running main action method: install 22:27:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:27:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:27:59 INFO - Reading from file tmpfile_stdout 22:27:59 INFO - Detecting whether we're running mozinstall >=1.0... 22:27:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:27:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:27:59 INFO - Reading from file tmpfile_stdout 22:27:59 INFO - Output received: 22:27:59 INFO - Usage: mozinstall [options] installer 22:27:59 INFO - Options: 22:27:59 INFO - -h, --help show this help message and exit 22:27:59 INFO - -d DEST, --destination=DEST 22:27:59 INFO - Directory to install application into. [default: 22:27:59 INFO - "/builds/slave/test-pgo"] 22:27:59 INFO - --app=APP Application being installed. [default: firefox] 22:27:59 INFO - mkdir: /builds/slave/test-pgo/build/application 22:27:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:27:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:28:15 INFO - Reading from file tmpfile_stdout 22:28:15 INFO - Output received: 22:28:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:28:15 INFO - Running post-action listener: _resource_record_post_action 22:28:15 INFO - ##### 22:28:15 INFO - ##### Running run-tests step. 22:28:15 INFO - ##### 22:28:15 INFO - Running pre-action listener: _resource_record_pre_action 22:28:15 INFO - Running main action method: run_tests 22:28:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:28:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:28:15 INFO - Python 2.7.3 22:28:15 INFO - Return code: 0 22:28:15 INFO - grabbing minidump binary from tooltool 22:28:15 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:28:15 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 0x13fc8c0>, '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 0x13fd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fdc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:28:15 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:28:15 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:28:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:28:15 INFO - Return code: 0 22:28:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:28:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:28:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:28:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:28:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:28:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:28:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:28:16 INFO - Return code: 0 22:28:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:28:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:28:16 INFO - Using env: {'DISPLAY': ':0', 22:28:16 INFO - 'HOME': '/home/cltbld', 22:28:16 INFO - 'LANG': 'en_US.UTF-8', 22:28:16 INFO - 'LANGUAGE': 'en_US:en', 22:28:16 INFO - 'LOGNAME': 'cltbld', 22:28:16 INFO - 'MAIL': '/var/mail/cltbld', 22:28:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:28:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:16 INFO - 'MOZ_NO_REMOTE': '1', 22:28:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:16 INFO - 'NO_EM_RESTART': '1', 22:28:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:28:16 INFO - 'PWD': '/builds/slave/test-pgo', 22:28:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:28:16 INFO - 'SHELL': '/bin/bash', 22:28:16 INFO - 'SHLVL': '1', 22:28:16 INFO - 'TERM': 'linux', 22:28:16 INFO - 'TMOUT': '86400', 22:28:16 INFO - 'USER': 'cltbld', 22:28:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326', 22:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:16 INFO - '_': '/tools/buildbot/bin/python'} 22:28:16 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:28:16 INFO - mozversion application_buildid: 20160213193337 22:28:16 INFO - mozversion application_changeset: e355cacefc881ba360d412853b57e8e060e966f4 22:28:16 INFO - mozversion application_display_name: Nightly 22:28:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:28:16 INFO - mozversion application_name: Firefox 22:28:16 INFO - mozversion application_remotingname: firefox 22:28:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:28:16 INFO - mozversion application_vendor: Mozilla 22:28:16 INFO - mozversion application_version: 47.0a1 22:28:16 INFO - mozversion platform_buildid: 20160213193337 22:28:16 INFO - mozversion platform_changeset: e355cacefc881ba360d412853b57e8e060e966f4 22:28:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:28:16 INFO - mozversion platform_version: 47.0a1 22:28:16 INFO - using testdate: 1455431296 22:28:16 INFO - actual date: 1455431296 22:28:16 INFO - starting webserver on 'localhost:37310' 22:28:16 INFO - SUITE-START | Running 2 tests 22:28:16 INFO - TEST-START | dromaeo_css 22:28:16 INFO - operating with platform_type : linux_ 22:28:16 INFO - Initialising browser for dromaeo_css test... 22:28:17 INFO - TEST-INFO | started process 22499 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpScuvPq/profile http://localhost:37310/getInfo.html) 22:28:20 INFO - PROCESS | 22499 | 22:28:20 INFO - PROCESS | 22499 | (process:22580): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:28:21 INFO - PROCESS | 22499 | __metrics Screen width/height:1600/1200 22:28:21 INFO - PROCESS | 22499 | colorDepth:24 22:28:21 INFO - PROCESS | 22499 | Browser inner width/height: 1024/697 22:28:21 INFO - PROCESS | 22499 | __metrics 22:28:22 INFO - TEST-INFO | 22499: exit 0 22:28:22 INFO - Browser initialized. 22:28:22 INFO - Running cycle 1/1 for dromaeo_css test... 22:28:22 INFO - TEST-INFO | started process 22631 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpScuvPq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:28:23 INFO - PROCESS | 22631 | 22:28:23 INFO - PROCESS | 22631 | (process:22689): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:28:34 INFO - PROCESS | 22631 | RSS: Main: 159023104 22:28:34 INFO - PROCESS | 22631 | 22:29:24 INFO - PROCESS | 22631 | 1455431364102 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:31:32 INFO - PROCESS | 22631 | Cycle 1(1): loaded http://localhost:37310/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37310/tests/dromaeo/cssquery-ext.html) 22:31:32 INFO - PROCESS | 22631 | RSS: Main: 167084032 22:31:32 INFO - PROCESS | 22631 | 22:34:34 INFO - PROCESS | 22631 | Cycle 1(1): loaded http://localhost:37310/tests/dromaeo/cssquery-ext.html (next: http://localhost:37310/tests/dromaeo/cssquery-jquery.html) 22:34:35 INFO - PROCESS | 22631 | RSS: Main: 160034816 22:34:35 INFO - PROCESS | 22631 | 22:37:37 INFO - PROCESS | 22631 | Cycle 1(1): loaded http://localhost:37310/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37310/tests/dromaeo/cssquery-mootools.html) 22:37:37 INFO - PROCESS | 22631 | RSS: Main: 162304000 22:37:37 INFO - PROCESS | 22631 | 22:40:39 INFO - PROCESS | 22631 | Cycle 1(1): loaded http://localhost:37310/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37310/tests/dromaeo/cssquery-prototype.html) 22:40:40 INFO - PROCESS | 22631 | RSS: Main: 159928320 22:40:40 INFO - PROCESS | 22631 | 22:43:42 INFO - PROCESS | 22631 | Cycle 1(1): loaded http://localhost:37310/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37310/tests/dromaeo/cssquery-yui.html) 22:43:42 INFO - PROCESS | 22631 | RSS: Main: 159674368 22:43:42 INFO - PROCESS | 22631 | 22:46:45 INFO - PROCESS | 22631 | Cycle 1(1): loaded http://localhost:37310/tests/dromaeo/cssquery-yui.html (next: http://localhost:37310/tests/dromaeo/cssquery-dojo.html) 22:46:45 INFO - PROCESS | 22631 | RSS: Main: 161669120 22:46:45 INFO - PROCESS | 22631 | 22:46:45 INFO - PROCESS | 22631 | __start_tp_report 22:46:45 INFO - PROCESS | 22631 | _x_x_mozilla_page_load 22:46:45 INFO - PROCESS | 22631 | _x_x_mozilla_page_load_details 22:46:45 INFO - PROCESS | 22631 | |i|pagename|runs| 22:46:45 INFO - PROCESS | 22631 | |0;dojo.html;3233.1432170474823;3240.0765781752207;3264.7551433642484;3286.786358886673;3304.1739565108724;5275.947240527594;5312.362516498021;5339.305890234269;5341.813036543722;5363.865903352418;5292.523672869441;5307.389650190229;5361.651492652974;5397.8380648580505;5461.126219804832;4862.076205520949;4879.975600121995;4909.600763782323;4965.950340496603;5000.824971126011;346.8036265750666;4882.877928051809;4885.682430641997;4886.560209581155;4924.70451772893;4856.150173719585;4861.683990540603;4880.511948805127;4882.3408839806525;4910.999999999982;4755.785989630475;4888.828890988798;4902.4362198346935;4925.4335751388335;4949.480304568005;4877.731724755137;4908.361912951294;4908.460069392364;4915.2872833439305;4934.25986102084;5118.539331460149;5131.281620573122;5154.639175257734;5185.455527169668;5209.973950130263;5700.486956173922;5725.198472213893;5738.483536481736;5806.390329015477;5929.495992840613;5828.300603927513;5844.649321040709;5848.67832269225;5849.2103566018895;5866.9706651466895;5404.189371594253;5411.134218525057;5416.566674666017;5468.343798744097;5496.367917689477;5744.913826292609;5825.7378417971295;5835.183074369592;5903.26209223847;5935.198748168942;5737.024705800024;5746.339170995389;5758.222639943638;5760.164776107525;5760.971195143998;5685.431456854364;5798.043322851767;5805.564582656318;5849;5864.67744274069;5770.422957704196;5774.855628609318;5790.478856902815;5794.275715535558;5823.068309070529;5720.456556627114;5738.397468265855;5738.8278351649515;5772.191893134965;5785.27684039495;4401.119776044804;4402.933955990663;4439.889002774892;4471.217536931024;4482.125985432809;3955.20895820837;3971.4837071180564;3988.940165897514;3997.920041599152;4003.739756915791;5370.892582148335;5378.300820893259;5385.515472900624;5390.19147127934;5419.34967803866;5686.488216060492;5797.768089276466;5812.273465816773;5853.64878107315;5904.409559044061;5309.41596424393;5336.546393556591;5350.277712508761;5395.973020134874;5433.402325744165;4870.09903167915;4936.802527898843;4942.728149951715;4942.777575009133;4983.825566105169;6015.54883383748;6067.7876274331065;6073.51411887048;6081.908771368433;6131.938680613226;5772.797952071742;5816.156657284755;5828.94171058284;5833.533317334688;5836.445537673914;5900.763969441175;5956.047032474783;5987.670678112571;6051.273847138372;6076.1493390924425;5698.601097923106;5703.372629010722;5706.572007099568;5707.229524014205;5708.058170401837;5754.625949313281;5767.971160144172;5772.624779389326;5773.364929857797;5782.306123265235;5475.945240547543;5508.256385387921;5532.5297349724115;5568.16477528374;5635.802746903839;5621.100623900156;5673.262475878109;5683.431656834284;5689.975804355256;5693.857653558694;5451.61838671305;5526.723663816873;5608.635438696471;5612.887742245214;5627.915581266366;5722.713864306685;5728.914066288926;5739.053056245672;5746.367899531132;5799.188113664175;5496;5513.531349835309;5542.362628297636;5542.806001789918;5569.415211402907 22:46:45 INFO - PROCESS | 22631 | |1;ext.html;503.35067762586266;513.2762804445732;565.7538970547812;568.7469076261065;568.8606291458593;34716.47925281123;35201.64798352015;35241.64758352416;35623.2875342493;35656.46515302266;37327.253454930884;37507.24985500295;37918.810405948;38064.80967595165;38132.23735525288;8140.9592952035155;8434.198751118634;8437.409381343308;8458.830823383529;8468.830623387528;8300.958495207515;8419.70531031414;8424.957875210615;8613.009503907037;8693.652253909837;8611.095834937336;8662.913370866274;8682.30541556674;8684.305255579538;8685.131486851327;8577.442466239705;8600.440971336875;8690.652373905035;8698.347623928168;8714.956425217897;8536.402451828375;8679;8694.913050869474;8721.302295816384;8767.167119123673;37343;37780.43329350062;38075.428868566996;38098.61901380978;38219.617803821886;2734.753872151516;3160.2415420299194;3739.8317075731657;3770.3024940386117;3880.1075752576785;24909.50180996388;25499;25625.487490250278;25754.48491030169;25793;3723.7765734056043;3736.7010639149075;3778.3576791945434;3781.092537790938;3786.129190286222;183400;184702;184960;185018;185044;38604.80697596494;52204.95590088253;52688;52695.73652131715;52900.47099528956;37811;37856.810715946245;37983.24033519314;38116.42825357622;38181.80909095437;12491.50033998648;12527.060470464568;12603.243805371523;12614.432350544248;12632.431540580696;10488.68533943983;10496.26526143178;10516.15967205736;10575.048245657928;10592.099671528007;12957.416916238792;13057.804132938014;13443.395047222899;13445.932770336281;13452.93273533626;5560.360558535739;5635.380108188096;5643.294588176478;5647.124695672177;5678.346990096192;949.240607513986;980.1374790184592;1019.6482213636284;1049.4333060147587;1063.2344711807486;27218.45563088727;27679.446411071665;27781.861090694416;28042.439151216862;28059.57910631342;986.9654562090292;1045.5556388534842;1076.9461526923778;1080.400377790318;1151.9366434846163;14313.28433578317;14336;14399.78400323996;14542.781858272134;14548.345324460424;302923;306974;308415;308658;308885;49154.75422622864;49346.75326623344;49454;49914.750426247636;49967.50032499628;1231.9630411087683;1268.3911722373311;1269.6635391621228;1269.904757143218;1272.8345315108977;26531.7346826537;27356.863215683796;27687.30781730392;27693.72306276992;27899.721002789713;43078;43440;43454.13091738211;43555.34666980061;43681.56318436775;288681;290798;291102;291472;291651;30741.23146921345;31380.05859824209;39771.60228397795;40547.79726101468;41028;37340.81329593444;37949;38537.229255415295;38903;39457.2108557833;34593.13517162091;34744.30511389809;34820.47769283412;35323.29353412969;35555.82222088873;35538.289234215685;35922;36380.454293185096;36708.44937325996;37092.443613345284;32031.199220019687;32230.35539289248;32251.193720157185;35816.82091589525;36309.27381452409;28251.43497130087;29808.552871707376;30211.546826797177;30342.84828575843;30509;23992.880035599712;24726.50546989086;25067.24798256055;25316.367090822878;25473.74526254788 22:46:45 INFO - PROCESS | 22631 | |2;jquery.html;330.88821559559875;332.20602759405017;333.8147328232831;341.90255777103516;349.72546550957503;16058.759118613216;16100.436484723023;16604.66790664186;17240.655186896256;17372.47882563522;15131.394744210245;15334.079955202697;15345.30946107425;15423.845761542381;15576.221188940535;4440.866773996777;4646.326282689008;4672.135654903836;4676.602488788457;4689.320048592952;4674.579287864091;4709.199436095855;6545.967270163643;6868;6876.140482439695;6162.599431036991;6444.6133232006;6484.773032943848;6844.794656160323;6847.246802851682;6335.588186767845;6422.421982021617;6531.60810351378;6841.897371539431;6848.3494068063455;6418.711157997901;6529.640869752162;6531.379518945692;6532;6562.376574225489;21070.683939740917;21245.575088498143;21465.141394344206;21878.562428751335;21964.231251906265;2148.054855863431;2249.876256805875;2317.073170731704;2436.074291769134;2974.6876577959433;13553.864461355457;13769.173849569059;13880.93059534706;13962.162270263816;14304.642383940381;1960.284496158906;1984.2559040359865;2006.6488364536149;2046.8567200295986;2068.606964676722;65524.67237663781;66152;66260.33739662638;66867.3313266866;68824.31175688229;14088;15056.924715376354;15126;15177.468788592347;15298.388064477518;22666.773332266464;22854.885725571265;23118.19086332004;23186.420339491648;23303.650445243336;8396.034456037634;8459.111793261742;8469.57652117404;8697.434666746767;8716.084811094745;7069.787906362817;7097.219305876452;7150.10623672041;7150.96424517874;7291.052163218854;7316.524425912405;7468.589227592534;7546.056742907137;7578.621068946531;7617.961910190414;2977.925551861221;2988.2379993102054;3051.9389612207633;3058.3883223354974;3122.344307695364;781.5529636369042;838.3125836813754;867.509856930832;923.7275003873873;948.805494873563;15047.548573542812;15796.36814527429;15867.444639437565;15929.36282548685;16215.83784162167;896.1531352871605;896.5651658945407;918.7978644698155;921.8156368726281;956.3735753081743;9071.319651026068;9313.953430232941;9317.673881414117;9325.067493250757;9517.714468565953;566017;569407;571680;578094;661590;71348.2865171352;74012;74243;76218;77105;1077.1490522487147;1103.3600511703353;1108.578740078765;1113.5935383584933;1116.8771435142128;14273;14922.104673719612;14944.775828362366;15011.699766004836;15230.847691522942;30704.232394190323;31179.532307015867;31383.21541961469;32133.196670083435;32473.02580922576;41277.587224127376;43331.13337733291;43475;43664;43749.12501749884;7336.449766267658;7419.703211871465;7427.108746950401;7526.661300241392;7645.770626881203;10312.639057632947;10949.616763413242;11122.165837562054;11172.38551879622;11486.21963595644;9448.244140468883;9478.620855165991;9729.805403891742;9832.262580306362;10095.596176153165;9592.904070959481;9692.951535242279;10056.245781566266;10158.13655839262;10211.84682229782;9728.805423891625;9842.212622990286;9853.655122070693;9961.153301969123;10076.899231007596;7040.260772618802;7083.3979111774015;7149.356557909813;7189.532680375759;7191.892121618075;9577.281703872377;9685.70942871715;9983.101520863158;9993.150582200595;10068.798624027624 22:46:45 INFO - PROCESS | 22631 | |3;mootools.html;1333.2200662612372;1388.1601631013236;1478.9778153327702;1638.8606968407692;1655.776470176526;6908.067410899527;7546.056742907137;7644.503107298022;7844.09792873819;7863.724769633064;7534;7548.88676669849;7636;7646.502977306485;7659.119201291853;2285.14307134824;2309.6603969697535;2310.1106074161403;2312.5952958232324;2315.2128276386024;2253.0537174386795;2263.592553340398;2322.1175953137786;2323.279783267184;2332.5334933013464;2229.7770222977733;2274.65880117982;2283.577538155438;2285.8171346292256;2306.630939049752;2247.73027236731;2264.4338915271182;2283.8401311908174;2310.4108452344713;2310.8266879984067;2321.8258630602772;2322.1408079010707;2344.3201471573225;2346.554154710617;2373.667686523888;7626.1611222766005;7713.34436572892;7734.729284475073;7749.7675069748;7779.805504862367;4434;4504.144212599595;4521.321801729767;4524.796384162721;4532.456105267389;2973.36072744361;2985.626796650419;3058.4953482675332;3072.6620071792086;3114.174743692923;882.5940067568926;886.5744442667491;893.1782759860944;920.7882187096939;923.9168474837297;10790.838137427945;10831.891681083245;10850.511726972305;10910.563577456893;10932;4096;4127.958720412757;4178.644815190682;4181.289180839264;4187.309093999456;8084.272415482635;8228.547429891414;8236.052853921756;8266.380021498411;8276.710315138942;4524.660650451229;4555.316702494652;4560.33875088117;4563.703359281702;4588.655850811202;4223.640990515779;4240.300350442204;4241.1941731071;4254.936175957363;4268.722533035343;3368.3768502827056;3387.458006718913;3400.9457068308407;3407.727381809449;3435.639257877887;1037.2531777120462;1054.7152268887357;1055.4142450939803;1064.2443864855884;1070.6948519672012;938.2353381993653;946.9857952130724;1002.6089824968268;1009.0010889219619;1250.7310928150491;7177.605231712201;7180.138383394026;7208.171060328024;7214;7242.275772422716;570.54356514788;581.5260562641433;593.5726277080495;598.4105655928906;732.3591857125016;5541;5616.522595579339;5617.073182924772;5629.7185140742795;5672.858178545569;9194;9342.719718408458;9631.181349585364;9699.806003880023;9715.514224288758;9576.329656923948;9586.328956972944;9599.184069354043;9620.90379096214;9648.565814538362;7363.300486453778;7444.404447644176;7539.585322807188;7612.276833700789;7618.514389693956;7230;7244.311790379906;7254.056972593529;7254.492185546961;7280.089988751406;8362.581870906552;8469.237768600855;8638.13618638131;8639;8718.956405217934;8649.91350086491;8798.516081615573;8820.2061814437;8838.823223535364;8903.376763626484;6442.838929026624;6474.4820414365795;6484.773032943825;6487.772927947499;6498.317676644074;7454.068241469817;7461.888071678821;7484.887726683995;7496.850062998818;7501.924980750123;6347.936520634919;6860.897086543806;6919.273476284918;7055.647217638995;7378.926210737824;6892.965535172292;6923.307669233036;6939.583624982517;6964.582125072309;7091.503594748525;6891.620960847001;6993.790186294419;6999.6850141742725;7007.7196912122945;7048.718051277891;6455.903161452676;6498.967505162444;6516.152900122954;6519.4784417245555;6530.67346632657;6461.289258181502;6540.50946179048;6558.1802274715665;6568.934310656832;6575.473962082926 22:46:45 INFO - PROCESS | 22631 | |4;prototype.html;310.51404551876317;314.3963589907378;315.5597940872483;315.909965659787;320.2681871922657;6168.167297414848;6177.752889884405;6307.747690092391;6373.745050197992;6388.9999999999945;6261.154744109544;6271.1533942917695;6293.339199384068;6301.716422760976;6314.052892066193;4714.151452738497;4717.764111794397;4718.221493453576;4720.59874910633;4721.787519561628;4704.506026867164;4716.787744551486;4725.8582242532775;4726.858194254178;4734.692245004081;4612.324851586089;4634.907301853961;4661.46393164787;4673.2055550556315;4694.530546945295;4659;4660.673752837302;4661.6969896956925;4672.649551283667;4696.9530304696855;4015.678745700337;4026.355783074723;4026.355783074723;4035.2131334389805;4041.312976793952;5941.494972927263;6001;6010.128531362928;6011.338752737195;6017.097435384728;5258.290130832365;5433.130699088127;5440.564754819605;5447.836564903059;5465.262189604392;6563.442107420828;6578.506612004119;6629.436497897636;6630.469562434993;6636.469082473391;4421.823127074946;4428.977855110736;4433.800478978422;4436;4437.600615944548;6649.80050598478;6907.585544867274;6910.756063908494;6933.965330173367;7002.5098243123;4400.537943515948;4495.57292057254;4495.662825288116;4498.190325741398;4508.932366014513;4502.167099086614;4537.069900670354;4538.818447262072;4546.272596384562;4552;5382.650127741685;5384.730763461889;5388.595855310789;5391.73041347931;5405.081136206854;6632.8673426531195;6700.2294736105;6711.697973591103;6724.865502690017;6734.494912881553;1545.8917875748589;1575.850294222047;1579.9605009874845;1589.5946533633849;1599.2163839718687;1018.0328687746522;1021.0606242257142;1028.1569113327;1030.5465595138114;1035.29082578434;6225.719842607094;6245.875082498324;6265.8120256392385;6275.529335299871;6281.96859015702;6838.281980391987;6857.348551887562;6857.937019761945;6864.656767161622;6868.038474613558;6128.662923539248;6223.097650840603;6254.6872656366995;6263.780767673201;6268.49852011838;3679.889603311905;3699.075231192202;3704.3517384457614;3707.1102935295335;3723.478712980185;7110.3956163725625;7126;7166.498345115792;7182.8204294892;7207.45944054198;6927.238003819576;6980.895286570705;6984.930150698428;7019.333163349474;7060.293970602898;7253.891191632129;7331.78004659861;7347.008153899155;7387.113546374362;7392.852142957111;6963.895541566779;6965.79102626922;6965.930340696731;6980.267071957372;6991.96504017497;6792.150981127359;6873.140857392826;6900.03399524057;6901;6902.758403455855;7293.963530182527;7321.267873212849;7322.853542929218;7329.486935914648;7345.8898116527225;4454.420925279693;4494.865154045384;4535.773211339354;4538.773061346986;4539.5006549280215;6911.239763625897;7016.438684905093;7026.262242464672;7036.648167591702;7046;6690.431313338421;6718.8320291993095;6738.460923126237;6744.156980377453;6757.86484270302;6668.733250670113;6696.866062678621;6737.62943038118;6746.291639377795;6749.966250168718;6455.419012288917;6593.769218077345;6618.966905165636;6627.3372662733345;6637.1703537057865;6785.864282714219;6802.081718968074;6805.693743781443;6809.795706128824;6813.727450901908;6567.474602031731;6586.47308215332;6593.505487088391;6633.834154146185;6645 22:46:45 INFO - PROCESS | 22631 | |5;yui.html;671.8824205763991;674.841412268117;768.8308572114133;787.7400457848911;791.5329955326356;13587.45650173993;13865.722685546283;13927.164370137798;13941.093828901114;13955.441782328708;12954.48182072716;12986;13020.804687929689;13032.283224422654;13033.08768386211;690.4821383962028;690.8411065454949;693.1543516909388;706.7667669669023;718.622723070387;716.380331013672;718.924512926143;739.109373205289;751.2975368030882;753.0850017229066;771.7800426878341;773.6093272897207;781.5506084001694;781.5701364249668;788.5505262000662;775.4765533265023;778.1129512355947;779.2363483785894;780.6721177105601;786.4534148766552;566.7138095261867;567.2597260574948;571.5085026876883;572.461885827321;573.8651416917021;13261.403236854365;13299.20204787716;13306.933465332708;13351.265680387574;13389.19664820114;12220.388980550937;12239.75520489594;12514.624561263177;12541.059420543404;12548.937255313756;10527.578896844117;10548;10556.208284378703;10561.524731387106;10584.100351470135;4209.2633789086785;4247.299195632717;4251.149770046003;4278.529361770203;4327.06968001878;49408.25887611689;49545.50454495445;49630;49723.75138124322;49786;9657.613695452103;9673.903260967441;9805.313628045968;10019.649312274036;10233.181345492343;16501;16554.503364899072;16651.33394664224;16690;16702.916485417496;7388.926110738824;7675.385969122457;7738.651760670783;7743.457957943003;7855.332296754726;4577.839775607904;4601.493835678073;4603.815847366068;4613.492515823256;4706.576408123216;3127;3134.341788224453;3138.325260069096;3146.5122905949615;3159.3681263746885;575.7869588252373;578.4273569166495;581.325662231809;585.0434539527903;598.1715324275909;600.8618017855918;624.487919905673;655.6393983309256;659.4987809264993;681.2472218198918;8548.529830859363;9241.21449676785;9675.419474831533;9729.951350243346;9849.359791613522;545.0924211188407;576.5877397660608;677.9355961183679;692.2765709833236;710.0875375142916;3923.4507168996365;4186.960015077461;4228.4080228768;4228.450301460791;4298.140371925565;55467;55837.441625583226;55839.720801395735;55972;61666.69166654138;47495.287570686465;48580.5141948576;49262.753686232056;49460.75269623629;49719.50280497149;43613.78193109014;44174.779126104164;44405.777971109936;45191.77404112958;45349.773251133534;8906.287497000094;9058.818823623622;9085.54572271397;9106.726798196065;9158.725238242863;32570.674293256765;32739.181520461225;33676.831615841766;33719.662803371655;33783.49324760081;38251.2349753009;38469.807650961564;43042.56957430386;43396.783016084715;43505.78247108871;10565.313254638424;10945.83581246298;10979.17656175774;11060.612878549213;11145.498452569816;12204.145709800583;12210.633680989584;12238.87761122413;12688.809667855174;13049.086563940433;11337.149713771665;11343.48954297075;11587.420628968686;11638.88361116378;11866.347350895438;11235.88764112381;11325.546978120783;11479.25384849982;11785.644845275925;11813.822792657946;10900.509477073709;11330.830037549607;11702;11840.763184736084;12273;9186.954065229631;9249.583768730288;9430.62277508892;9531.952340238255;9582.281328900499;9567.712968610953;10205.234607404325;10338.638147664795;10376.636817711646;10461.843072353768 22:46:45 INFO - PROCESS | 22631 | __end_tp_report 22:46:45 INFO - PROCESS | 22631 | __start_cc_report 22:46:45 INFO - PROCESS | 22631 | _x_x_mozilla_cycle_collect,308 22:46:45 INFO - PROCESS | 22631 | __end_cc_report 22:46:45 INFO - PROCESS | 22631 | __startTimestamp1455432405764__endTimestamp 22:46:45 INFO - PROCESS | 22631 | 22:46:45 INFO - PROCESS | 22631 | ------- Summary: start ------- 22:46:45 INFO - PROCESS | 22631 | Number of tests: 6 22:46:45 INFO - PROCESS | 22631 | 22:46:45 INFO - PROCESS | 22631 | [#0] dojo.html Cycles:165 Average:5334.96 Median:5542.36 stddev:714.64 (12.9%) stddev-sans-first:697.55 22:46:45 INFO - PROCESS | 22631 | Values: 3233.1 3240.1 3264.8 3286.8 3304.2 5275.9 5312.4 5339.3 5341.8 5363.9 5292.5 5307.4 5361.7 5397.8 5461.1 4862.1 4880.0 4909.6 4966.0 5000.8 346.8 4882.9 4885.7 4886.6 4924.7 4856.2 4861.7 4880.5 4882.3 4911.0 4755.8 4888.8 4902.4 4925.4 4949.5 4877.7 4908.4 4908.5 4915.3 4934.3 5118.5 5131.3 5154.6 5185.5 5210.0 5700.5 5725.2 5738.5 5806.4 5929.5 5828.3 5844.6 5848.7 5849.2 5867.0 5404.2 5411.1 5416.6 5468.3 5496.4 5744.9 5825.7 5835.2 5903.3 5935.2 5737.0 5746.3 5758.2 5760.2 5761.0 5685.4 5798.0 5805.6 5849.0 5864.7 5770.4 5774.9 5790.5 5794.3 5823.1 5720.5 5738.4 5738.8 5772.2 5785.3 4401.1 4402.9 4439.9 4471.2 4482.1 3955.2 3971.5 3988.9 3997.9 4003.7 5370.9 5378.3 5385.5 5390.2 5419.3 5686.5 5797.8 5812.3 5853.6 5904.4 5309.4 5336.5 5350.3 5396.0 5433.4 4870.1 4936.8 4942.7 4942.8 4983.8 6015.5 6067.8 6073.5 6081.9 6131.9 5772.8 5816.2 5828.9 5833.5 5836.4 5900.8 5956.0 5987.7 6051.3 6076.1 5698.6 5703.4 5706.6 5707.2 5708.1 5754.6 5768.0 5772.6 5773.4 5782.3 5475.9 5508.3 5532.5 5568.2 5635.8 5621.1 5673.3 5683.4 5690.0 5693.9 5451.6 5526.7 5608.6 5612.9 5627.9 5722.7 5728.9 5739.1 5746.4 5799.2 5496.0 5513.5 5542.4 5542.8 5569.4 22:46:45 INFO - PROCESS | 22631 | 22:46:45 INFO - PROCESS | 22631 | [#1] ext.html Cycles:180 Average:41677.84 Median:35869.41 stddev:69747.47 (194.4%) stddev-sans-first:69874.61 22:46:45 INFO - PROCESS | 22631 | Values: 503.4 513.3 565.8 568.7 568.9 34716.5 35201.6 35241.6 35623.3 35656.5 37327.3 37507.2 37918.8 38064.8 38132.2 8141.0 8434.2 8437.4 8458.8 8468.8 8301.0 8419.7 8425.0 8613.0 8693.7 8611.1 8662.9 8682.3 8684.3 8685.1 8577.4 8600.4 8690.7 8698.3 8715.0 8536.4 8679.0 8694.9 8721.3 8767.2 37343.0 37780.4 38075.4 38098.6 38219.6 2734.8 3160.2 3739.8 3770.3 3880.1 24909.5 25499.0 25625.5 25754.5 25793.0 3723.8 3736.7 3778.4 3781.1 3786.1 183400.0 184702.0 184960.0 185018.0 185044.0 38604.8 52205.0 52688.0 52695.7 52900.5 37811.0 37856.8 37983.2 38116.4 38181.8 12491.5 12527.1 12603.2 12614.4 12632.4 10488.7 10496.3 10516.2 10575.0 10592.1 12957.4 13057.8 13443.4 13445.9 13452.9 5560.4 5635.4 5643.3 5647.1 5678.3 949.2 980.1 1019.6 1049.4 1063.2 27218.5 27679.4 27781.9 28042.4 28059.6 987.0 1045.6 1076.9 1080.4 1151.9 14313.3 14336.0 14399.8 14542.8 14548.3 302923.0 306974.0 308415.0 308658.0 308885.0 49154.8 49346.8 49454.0 49914.8 49967.5 1232.0 1268.4 1269.7 1269.9 1272.8 26531.7 27356.9 27687.3 27693.7 27899.7 43078.0 43440.0 43454.1 43555.3 43681.6 288681.0 290798.0 291102.0 291472.0 291651.0 30741.2 31380.1 39771.6 40547.8 41028.0 37340.8 37949.0 38537.2 38903.0 39457.2 34593.1 34744.3 34820.5 35323.3 35555.8 35538.3 35922.0 36380.5 36708.4 37092.4 32031.2 32230.4 32251.2 35816.8 36309.3 28251.4 29808.6 30211.5 30342.8 30509.0 23992.9 24726.5 25067.2 25316.4 25473.7 22:46:45 INFO - PROCESS | 22631 | 22:46:45 INFO - PROCESS | 22631 | [#2] jquery.html Cycles:180 Average:29997.16 Median:4682.96 stddev:96391.99 (2058.4%) stddev-sans-first:96636.66 22:46:45 INFO - PROCESS | 22631 | Values: 330.9 332.2 333.8 341.9 349.7 16058.8 16100.4 16604.7 17240.7 17372.5 15131.4 15334.1 15345.3 15423.8 15576.2 4440.9 4646.3 4672.1 4676.6 4689.3 4674.6 4709.2 6546.0 6868.0 6876.1 6162.6 6444.6 6484.8 6844.8 6847.2 6335.6 6422.4 6531.6 6841.9 6848.3 6418.7 6529.6 6531.4 6532.0 6562.4 21070.7 21245.6 21465.1 21878.6 21964.2 2148.1 2249.9 2317.1 2436.1 2974.7 13553.9 13769.2 13880.9 13962.2 14304.6 1960.3 1984.3 2006.6 2046.9 2068.6 65524.7 66152.0 66260.3 66867.3 68824.3 14088.0 15056.9 15126.0 15177.5 15298.4 22666.8 22854.9 23118.2 23186.4 23303.7 8396.0 8459.1 8469.6 8697.4 8716.1 7069.8 7097.2 7150.1 7151.0 7291.1 7316.5 7468.6 7546.1 7578.6 7618.0 2977.9 2988.2 3051.9 3058.4 3122.3 781.6 838.3 867.5 923.7 948.8 15047.5 15796.4 15867.4 15929.4 16215.8 896.2 896.6 918.8 921.8 956.4 9071.3 9314.0 9317.7 9325.1 9517.7 566017.0 569407.0 571680.0 578094.0 661590.0 71348.3 74012.0 74243.0 76218.0 77105.0 1077.1 1103.4 1108.6 1113.6 1116.9 14273.0 14922.1 14944.8 15011.7 15230.8 30704.2 31179.5 31383.2 32133.2 32473.0 41277.6 43331.1 43475.0 43664.0 43749.1 7336.4 7419.7 7427.1 7526.7 7645.8 10312.6 10949.6 11122.2 11172.4 11486.2 9448.2 9478.6 9729.8 9832.3 10095.6 9592.9 9693.0 10056.2 10158.1 10211.8 9728.8 9842.2 9853.7 9961.2 10076.9 7040.3 7083.4 7149.4 7189.5 7191.9 9577.3 9685.7 9983.1 9993.2 10068.8 22:46:45 INFO - PROCESS | 22631 | 22:46:45 INFO - PROCESS | 22631 | [#3] mootools.html Cycles:180 Average:5400.67 Median:6507.56 stddev:2866.11 (44.0%) stddev-sans-first:2857.85 22:46:45 INFO - PROCESS | 22631 | Values: 1333.2 1388.2 1479.0 1638.9 1655.8 6908.1 7546.1 7644.5 7844.1 7863.7 7534.0 7548.9 7636.0 7646.5 7659.1 2285.1 2309.7 2310.1 2312.6 2315.2 2253.1 2263.6 2322.1 2323.3 2332.5 2229.8 2274.7 2283.6 2285.8 2306.6 2247.7 2264.4 2283.8 2310.4 2310.8 2321.8 2322.1 2344.3 2346.6 2373.7 7626.2 7713.3 7734.7 7749.8 7779.8 4434.0 4504.1 4521.3 4524.8 4532.5 2973.4 2985.6 3058.5 3072.7 3114.2 882.6 886.6 893.2 920.8 923.9 10790.8 10831.9 10850.5 10910.6 10932.0 4096.0 4128.0 4178.6 4181.3 4187.3 8084.3 8228.5 8236.1 8266.4 8276.7 4524.7 4555.3 4560.3 4563.7 4588.7 4223.6 4240.3 4241.2 4254.9 4268.7 3368.4 3387.5 3400.9 3407.7 3435.6 1037.3 1054.7 1055.4 1064.2 1070.7 938.2 947.0 1002.6 1009.0 1250.7 7177.6 7180.1 7208.2 7214.0 7242.3 570.5 581.5 593.6 598.4 732.4 5541.0 5616.5 5617.1 5629.7 5672.9 9194.0 9342.7 9631.2 9699.8 9715.5 9576.3 9586.3 9599.2 9620.9 9648.6 7363.3 7444.4 7539.6 7612.3 7618.5 7230.0 7244.3 7254.1 7254.5 7280.1 8362.6 8469.2 8638.1 8639.0 8719.0 8649.9 8798.5 8820.2 8838.8 8903.4 6442.8 6474.5 6484.8 6487.8 6498.3 7454.1 7461.9 7484.9 7496.9 7501.9 6347.9 6860.9 6919.3 7055.6 7378.9 6893.0 6923.3 6939.6 6964.6 7091.5 6891.6 6993.8 6999.7 7007.7 7048.7 6455.9 6499.0 6516.2 6519.5 6530.7 6461.3 6540.5 6558.2 6568.9 6575.5 22:46:45 INFO - PROCESS | 22631 | 22:46:45 INFO - PROCESS | 22631 | [#4] prototype.html Cycles:180 Average:5538.77 Median:6269.83 stddev:1741.20 (27.8%) stddev-sans-first:1701.29 22:46:45 INFO - PROCESS | 22631 | Values: 310.5 314.4 315.6 315.9 320.3 6168.2 6177.8 6307.7 6373.7 6389.0 6261.2 6271.2 6293.3 6301.7 6314.1 4714.2 4717.8 4718.2 4720.6 4721.8 4704.5 4716.8 4725.9 4726.9 4734.7 4612.3 4634.9 4661.5 4673.2 4694.5 4659.0 4660.7 4661.7 4672.6 4697.0 4015.7 4026.4 4026.4 4035.2 4041.3 5941.5 6001.0 6010.1 6011.3 6017.1 5258.3 5433.1 5440.6 5447.8 5465.3 6563.4 6578.5 6629.4 6630.5 6636.5 4421.8 4429.0 4433.8 4436.0 4437.6 6649.8 6907.6 6910.8 6934.0 7002.5 4400.5 4495.6 4495.7 4498.2 4508.9 4502.2 4537.1 4538.8 4546.3 4552.0 5382.7 5384.7 5388.6 5391.7 5405.1 6632.9 6700.2 6711.7 6724.9 6734.5 1545.9 1575.9 1580.0 1589.6 1599.2 1018.0 1021.1 1028.2 1030.5 1035.3 6225.7 6245.9 6265.8 6275.5 6282.0 6838.3 6857.3 6857.9 6864.7 6868.0 6128.7 6223.1 6254.7 6263.8 6268.5 3679.9 3699.1 3704.4 3707.1 3723.5 7110.4 7126.0 7166.5 7182.8 7207.5 6927.2 6980.9 6984.9 7019.3 7060.3 7253.9 7331.8 7347.0 7387.1 7392.9 6963.9 6965.8 6965.9 6980.3 6992.0 6792.2 6873.1 6900.0 6901.0 6902.8 7294.0 7321.3 7322.9 7329.5 7345.9 4454.4 4494.9 4535.8 4538.8 4539.5 6911.2 7016.4 7026.3 7036.6 7046.0 6690.4 6718.8 6738.5 6744.2 6757.9 6668.7 6696.9 6737.6 6746.3 6750.0 6455.4 6593.8 6619.0 6627.3 6637.2 6785.9 6802.1 6805.7 6809.8 6813.7 6567.5 6586.5 6593.5 6633.8 6645.0 22:46:45 INFO - PROCESS | 22631 | 22:46:45 INFO - PROCESS | 22631 | [#5] yui.html Cycles:180 Average:13625.69 Median:24963.81 stddev:15478.11 (62.0%) stddev-sans-first:15490.96 22:46:45 INFO - PROCESS | 22631 | Values: 671.9 674.8 768.8 787.7 791.5 13587.5 13865.7 13927.2 13941.1 13955.4 12954.5 12986.0 13020.8 13032.3 13033.1 690.5 690.8 693.2 706.8 718.6 716.4 718.9 739.1 751.3 753.1 771.8 773.6 781.6 781.6 788.6 775.5 778.1 779.2 780.7 786.5 566.7 567.3 571.5 572.5 573.9 13261.4 13299.2 13306.9 13351.3 13389.2 12220.4 12239.8 12514.6 12541.1 12548.9 10527.6 10548.0 10556.2 10561.5 10584.1 4209.3 4247.3 4251.1 4278.5 4327.1 49408.3 49545.5 49630.0 49723.8 49786.0 9657.6 9673.9 9805.3 10019.6 10233.2 16501.0 16554.5 16651.3 16690.0 16702.9 7388.9 7675.4 7738.7 7743.5 7855.3 4577.8 4601.5 4603.8 4613.5 4706.6 3127.0 3134.3 3138.3 3146.5 3159.4 575.8 578.4 581.3 585.0 598.2 600.9 624.5 655.6 659.5 681.2 8548.5 9241.2 9675.4 9730.0 9849.4 545.1 576.6 677.9 692.3 710.1 3923.5 4187.0 4228.4 4228.5 4298.1 55467.0 55837.4 55839.7 55972.0 61666.7 47495.3 48580.5 49262.8 49460.8 49719.5 43613.8 44174.8 44405.8 45191.8 45349.8 8906.3 9058.8 9085.5 9106.7 9158.7 32570.7 32739.2 33676.8 33719.7 33783.5 38251.2 38469.8 43042.6 43396.8 43505.8 10565.3 10945.8 10979.2 11060.6 11145.5 12204.1 12210.6 12238.9 12688.8 13049.1 11337.1 11343.5 11587.4 11638.9 11866.3 11235.9 11325.5 11479.3 11785.6 11813.8 10900.5 11330.8 11702.0 11840.8 12273.0 9187.0 9249.6 9430.6 9532.0 9582.3 9567.7 10205.2 10338.6 10376.6 10461.8 22:46:45 INFO - PROCESS | 22631 | -------- Summary: end -------- 22:46:45 INFO - PROCESS | 22631 | 22:46:46 INFO - TEST-INFO | 22631: exit 0 22:46:46 INFO - TEST-OK | dromaeo_css | took 1109448ms 22:46:46 INFO - TEST-START | kraken 22:46:46 INFO - operating with platform_type : linux_ 22:46:46 INFO - Initialising browser for kraken test... 22:46:46 INFO - TEST-INFO | started process 22871 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7Vuezu/profile http://localhost:37310/getInfo.html) 22:46:49 INFO - PROCESS | 22871 | 22:46:49 INFO - PROCESS | 22871 | (process:22941): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:46:50 INFO - PROCESS | 22871 | __metrics Screen width/height:1600/1200 22:46:50 INFO - PROCESS | 22871 | colorDepth:24 22:46:50 INFO - PROCESS | 22871 | Browser inner width/height: 1024/697 22:46:50 INFO - PROCESS | 22871 | __metrics 22:46:51 INFO - TEST-INFO | 22871: exit 0 22:46:51 INFO - Browser initialized. 22:46:51 INFO - Running cycle 1/1 for kraken test... 22:46:51 INFO - TEST-INFO | started process 22992 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7Vuezu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:46:53 INFO - PROCESS | 22992 | 22:46:53 INFO - PROCESS | 22992 | (process:23050): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:47:03 INFO - PROCESS | 22992 | RSS: Main: 158670848 22:47:03 INFO - PROCESS | 22992 | 22:47:06 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37310/tests/kraken/driver.html?testName=audio-beat-detection) 22:47:06 INFO - PROCESS | 22992 | RSS: Main: 163729408 22:47:06 INFO - PROCESS | 22992 | 22:47:09 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37310/tests/kraken/driver.html?testName=audio-dft) 22:47:09 INFO - PROCESS | 22992 | RSS: Main: 165842944 22:47:09 INFO - PROCESS | 22992 | 22:47:12 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37310/tests/kraken/driver.html?testName=audio-fft) 22:47:13 INFO - PROCESS | 22992 | RSS: Main: 159944704 22:47:13 INFO - PROCESS | 22992 | 22:47:15 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37310/tests/kraken/driver.html?testName=audio-oscillator) 22:47:15 INFO - PROCESS | 22992 | RSS: Main: 160796672 22:47:15 INFO - PROCESS | 22992 | 22:47:18 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37310/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:47:18 INFO - PROCESS | 22992 | RSS: Main: 161800192 22:47:18 INFO - PROCESS | 22992 | 22:47:21 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37310/tests/kraken/driver.html?testName=imaging-darkroom) 22:47:22 INFO - PROCESS | 22992 | RSS: Main: 161783808 22:47:22 INFO - PROCESS | 22992 | 22:47:25 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37310/tests/kraken/driver.html?testName=imaging-desaturate) 22:47:26 INFO - PROCESS | 22992 | RSS: Main: 161472512 22:47:26 INFO - PROCESS | 22992 | 22:47:29 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37310/tests/kraken/driver.html?testName=json-parse-financial) 22:47:29 INFO - PROCESS | 22992 | RSS: Main: 161701888 22:47:29 INFO - PROCESS | 22992 | 22:47:31 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37310/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:47:32 INFO - PROCESS | 22992 | RSS: Main: 159961088 22:47:32 INFO - PROCESS | 22992 | 22:47:33 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37310/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:47:34 INFO - PROCESS | 22992 | RSS: Main: 159977472 22:47:34 INFO - PROCESS | 22992 | 22:47:36 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37310/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:47:37 INFO - PROCESS | 22992 | RSS: Main: 161259520 22:47:37 INFO - PROCESS | 22992 | 22:47:39 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:47:40 INFO - PROCESS | 22992 | RSS: Main: 162037760 22:47:40 INFO - PROCESS | 22992 | 22:47:42 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:47:43 INFO - PROCESS | 22992 | RSS: Main: 160845824 22:47:43 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | Cycle 1(1): loaded http://localhost:37310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37310/tests/kraken/driver.html?testName=ai-astar) 22:47:45 INFO - PROCESS | 22992 | RSS: Main: 164384768 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | __start_tp_report 22:47:45 INFO - PROCESS | 22992 | _x_x_mozilla_page_load 22:47:45 INFO - PROCESS | 22992 | _x_x_mozilla_page_load_details 22:47:45 INFO - PROCESS | 22992 | |i|pagename|runs| 22:47:45 INFO - PROCESS | 22992 | |0;ai-astar;111;106;114;112;113;125;113;113;111;113 22:47:45 INFO - PROCESS | 22992 | |1;audio-beat-detection;156;127;157;166;128;167;155;126;170;127 22:47:45 INFO - PROCESS | 22992 | |2;audio-dft;164;164;165;164;163;163;164;170;165;163 22:47:45 INFO - PROCESS | 22992 | |3;audio-fft;74;74;74;163;74;76;72;73;158;74 22:47:45 INFO - PROCESS | 22992 | |4;audio-oscillator;96;96;152;96;98;97;145;96;97;144 22:47:45 INFO - PROCESS | 22992 | |5;imaging-gaussian-blur;120;115;117;116;115;116;115;116;116;115 22:47:45 INFO - PROCESS | 22992 | |6;imaging-darkroom;150;147;149;148;151;147;148;147;149;149 22:47:45 INFO - PROCESS | 22992 | |7;imaging-desaturate;97;98;96;101;99;98;96;102;96;96 22:47:45 INFO - PROCESS | 22992 | |8;json-parse-financial;59;63;60;63;63;59;58;64;59;56 22:47:45 INFO - PROCESS | 22992 | |9;json-stringify-tinderbox;67;67;67;66;67;67;69;66;67;68 22:47:45 INFO - PROCESS | 22992 | |10;stanford-crypto-aes;85;84;85;83;86;84;83;92;95;86 22:47:45 INFO - PROCESS | 22992 | |11;stanford-crypto-ccm;120;121;119;120;120;120;134;122;137;130 22:47:45 INFO - PROCESS | 22992 | |12;stanford-crypto-pbkdf2;145;152;155;154;160;151;153;147;156;141 22:47:45 INFO - PROCESS | 22992 | |13;stanford-crypto-sha256-iterative;75;72;72;68;72;69;75;70;69;68 22:47:45 INFO - PROCESS | 22992 | __end_tp_report 22:47:45 INFO - PROCESS | 22992 | __start_cc_report 22:47:45 INFO - PROCESS | 22992 | _x_x_mozilla_cycle_collect,759 22:47:45 INFO - PROCESS | 22992 | __end_cc_report 22:47:45 INFO - PROCESS | 22992 | __startTimestamp1455432465429__endTimestamp 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | ------- Summary: start ------- 22:47:45 INFO - PROCESS | 22992 | Number of tests: 14 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:4.75 (4.2%) stddev-sans-first:4.97 22:47:45 INFO - PROCESS | 22992 | Values: 111.0 106.0 114.0 112.0 113.0 125.0 113.0 113.0 111.0 113.0 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:156.50 stddev:18.65 (11.9%) stddev-sans-first:19.54 22:47:45 INFO - PROCESS | 22992 | Values: 156.0 127.0 157.0 166.0 128.0 167.0 155.0 126.0 170.0 127.0 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.07 (1.3%) stddev-sans-first:2.19 22:47:45 INFO - PROCESS | 22992 | Values: 164.0 164.0 165.0 164.0 163.0 163.0 164.0 170.0 165.0 163.0 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#3] audio-fft Cycles:10 Average:91.20 Median:74.00 stddev:36.56 (49.4%) stddev-sans-first:38.24 22:47:45 INFO - PROCESS | 22992 | Values: 74.0 74.0 74.0 163.0 74.0 76.0 72.0 73.0 158.0 74.0 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:96.00 stddev:24.45 (25.5%) stddev-sans-first:25.27 22:47:45 INFO - PROCESS | 22992 | Values: 96.0 96.0 152.0 96.0 98.0 97.0 145.0 96.0 97.0 144.0 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#5] imaging-gaussian-blur Cycles:10 Average:116.10 Median:116.00 stddev:1.52 (1.3%) stddev-sans-first:0.71 22:47:45 INFO - PROCESS | 22992 | Values: 120.0 115.0 117.0 116.0 115.0 116.0 115.0 116.0 116.0 115.0 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:1.35 (0.9%) stddev-sans-first:1.32 22:47:45 INFO - PROCESS | 22992 | Values: 150.0 147.0 149.0 148.0 151.0 147.0 148.0 147.0 149.0 149.0 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:96.50 stddev:2.18 (2.3%) stddev-sans-first:2.29 22:47:45 INFO - PROCESS | 22992 | Values: 97.0 98.0 96.0 101.0 99.0 98.0 96.0 102.0 96.0 96.0 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:61.50 stddev:2.67 (4.3%) stddev-sans-first:2.79 22:47:45 INFO - PROCESS | 22992 | Values: 59.0 63.0 60.0 63.0 63.0 59.0 58.0 64.0 59.0 56.0 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 22:47:45 INFO - PROCESS | 22992 | Values: 67.0 67.0 67.0 66.0 67.0 67.0 69.0 66.0 67.0 68.0 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:85.50 stddev:4.00 (4.7%) stddev-sans-first:4.22 22:47:45 INFO - PROCESS | 22992 | Values: 85.0 84.0 85.0 83.0 86.0 84.0 83.0 92.0 95.0 86.0 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:121.50 stddev:6.72 (5.5%) stddev-sans-first:6.94 22:47:45 INFO - PROCESS | 22992 | Values: 120.0 121.0 119.0 120.0 120.0 120.0 134.0 122.0 137.0 130.0 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.40 Median:153.50 stddev:5.64 (3.7%) stddev-sans-first:5.49 22:47:45 INFO - PROCESS | 22992 | Values: 145.0 152.0 155.0 154.0 160.0 151.0 153.0 147.0 156.0 141.0 22:47:45 INFO - PROCESS | 22992 | 22:47:45 INFO - PROCESS | 22992 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:72.00 stddev:2.62 (3.6%) stddev-sans-first:2.35 22:47:45 INFO - PROCESS | 22992 | Values: 75.0 72.0 72.0 68.0 72.0 69.0 75.0 70.0 69.0 68.0 22:47:45 INFO - PROCESS | 22992 | -------- Summary: end -------- 22:47:45 INFO - PROCESS | 22992 | 22:47:46 INFO - TEST-INFO | 22992: exit 0 22:47:46 INFO - TEST-OK | kraken | took 60023ms 22:47:46 INFO - SUITE-END | took 1169s 22:47:46 INFO - Completed test suite (00:19:29) 22:47:46 INFO - Working with test: dromaeo_css 22:47:46 INFO - Generating results file: dromaeo_css 22:47:46 INFO - Working with test: kraken 22:47:46 INFO - Generating results file: kraken 22:47:46 INFO - javascript benchmark 22:47:46 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:47:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 22:47:46 INFO - process_Request line: dromaeo_css 6906.87 graph.html#tests=[[72,1,43]] 22:47:46 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:47:46 INFO - process_Request line: kraken 1551.40 graph.html#tests=[[232,1,43]] 22:47:46 INFO - RETURN: dromaeo_css: 6906.87 22:47:46 INFO - RETURN: kraken: 1551.40 22:47:46 INFO - javascript benchmark 22:47:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3233.1432170474823, 3240.0765781752207, 3264.7551433642484, 3286.786358886673, 3304.1739565108724, 5275.947240527594, 5312.362516498021, 5339.305890234269, 5341.813036543722, 5363.865903352418, 5292.523672869441, 5307.389650190229, 5361.651492652974, 5397.8380648580505, 5461.126219804832, 4862.076205520949, 4879.975600121995, 4909.600763782323, 4965.950340496603, 5000.824971126011, 346.8036265750666, 4882.877928051809, 4885.682430641997, 4886.560209581155, 4924.70451772893, 4856.150173719585, 4861.683990540603, 4880.511948805127, 4882.3408839806525, 4910.999999999982, 4755.785989630475, 4888.828890988798, 4902.4362198346935, 4925.4335751388335, 4949.480304568005, 4877.731724755137, 4908.361912951294, 4908.460069392364, 4915.2872833439305, 4934.25986102084, 5118.539331460149, 5131.281620573122, 5154.639175257734, 5185.455527169668, 5209.973950130263, 5700.486956173922, 5725.198472213893, 5738.483536481736, 5806.390329015477, 5929.495992840613, 5828.300603927513, 5844.649321040709, 5848.67832269225, 5849.2103566018895, 5866.9706651466895, 5404.189371594253, 5411.134218525057, 5416.566674666017, 5468.343798744097, 5496.367917689477, 5744.913826292609, 5825.7378417971295, 5835.183074369592, 5903.26209223847, 5935.198748168942, 5737.024705800024, 5746.339170995389, 5758.222639943638, 5760.164776107525, 5760.971195143998, 5685.431456854364, 5798.043322851767, 5805.564582656318, 5849.0, 5864.67744274069, 5770.422957704196, 5774.855628609318, 5790.478856902815, 5794.275715535558, 5823.068309070529, 5720.456556627114, 5738.397468265855, 5738.8278351649515, 5772.191893134965, 5785.27684039495, 4401.119776044804, 4402.933955990663, 4439.889002774892, 4471.217536931024, 4482.125985432809, 3955.20895820837, 3971.4837071180564, 3988.940165897514, 3997.920041599152, 4003.739756915791, 5370.892582148335, 5378.300820893259, 5385.515472900624, 5390.19147127934, 5419.34967803866, 5686.488216060492, 5797.768089276466, 5812.273465816773, 5853.64878107315, 5904.409559044061, 5309.41596424393, 5336.546393556591, 5350.277712508761, 5395.973020134874, 5433.402325744165, 4870.09903167915, 4936.802527898843, 4942.728149951715, 4942.777575009133, 4983.825566105169, 6015.54883383748, 6067.7876274331065, 6073.51411887048, 6081.908771368433, 6131.938680613226, 5772.797952071742, 5816.156657284755, 5828.94171058284, 5833.533317334688, 5836.445537673914, 5900.763969441175, 5956.047032474783, 5987.670678112571, 6051.273847138372, 6076.1493390924425, 5698.601097923106, 5703.372629010722, 5706.572007099568, 5707.229524014205, 5708.058170401837, 5754.625949313281, 5767.971160144172, 5772.624779389326, 5773.364929857797, 5782.306123265235, 5475.945240547543, 5508.256385387921, 5532.5297349724115, 5568.16477528374, 5635.802746903839, 5621.100623900156, 5673.262475878109, 5683.431656834284, 5689.975804355256, 5693.857653558694, 5451.61838671305, 5526.723663816873, 5608.635438696471, 5612.887742245214, 5627.915581266366, 5722.713864306685, 5728.914066288926, 5739.053056245672, 5746.367899531132, 5799.188113664175, 5496.0, 5513.531349835309, 5542.362628297636, 5542.806001789918, 5569.415211402907], "unit": "score", "name": "dojo.html", "value": 5290.678598192786}, {"lowerIsBetter": false, "replicates": [503.35067762586266, 513.2762804445732, 565.7538970547812, 568.7469076261065, 568.8606291458593, 34716.47925281123, 35201.64798352015, 35241.64758352416, 35623.2875342493, 35656.46515302266, 37327.253454930884, 37507.24985500295, 37918.810405948, 38064.80967595165, 38132.23735525288, 8140.9592952035155, 8434.198751118634, 8437.409381343308, 8458.830823383529, 8468.830623387528, 8300.958495207515, 8419.70531031414, 8424.957875210615, 8613.009503907037, 8693.652253909837, 8611.095834937336, 8662.913370866274, 8682.30541556674, 8684.305255579538, 8685.131486851327, 8577.442466239705, 8600.440971336875, 8690.652373905035, 8698.347623928168, 8714.956425217897, 8536.402451828375, 8679.0, 8694.913050869474, 8721.302295816384, 8767.167119123673, 37343.0, 37780.43329350062, 38075.428868566996, 38098.61901380978, 38219.617803821886, 2734.753872151516, 3160.2415420299194, 3739.8317075731657, 3770.3024940386117, 3880.1075752576785, 24909.50180996388, 25499.0, 25625.487490250278, 25754.48491030169, 25793.0, 3723.7765734056043, 3736.7010639149075, 3778.3576791945434, 3781.092537790938, 3786.129190286222, 183400.0, 184702.0, 184960.0, 185018.0, 185044.0, 38604.80697596494, 52204.95590088253, 52688.0, 52695.73652131715, 52900.47099528956, 37811.0, 37856.810715946245, 37983.24033519314, 38116.42825357622, 38181.80909095437, 12491.50033998648, 12527.060470464568, 12603.243805371523, 12614.432350544248, 12632.431540580696, 10488.68533943983, 10496.26526143178, 10516.15967205736, 10575.048245657928, 10592.099671528007, 12957.416916238792, 13057.804132938014, 13443.395047222899, 13445.932770336281, 13452.93273533626, 5560.360558535739, 5635.380108188096, 5643.294588176478, 5647.124695672177, 5678.346990096192, 949.240607513986, 980.1374790184592, 1019.6482213636284, 1049.4333060147587, 1063.2344711807486, 27218.45563088727, 27679.446411071665, 27781.861090694416, 28042.439151216862, 28059.57910631342, 986.9654562090292, 1045.5556388534842, 1076.9461526923778, 1080.400377790318, 1151.9366434846163, 14313.28433578317, 14336.0, 14399.78400323996, 14542.781858272134, 14548.345324460424, 302923.0, 306974.0, 308415.0, 308658.0, 308885.0, 49154.75422622864, 49346.75326623344, 49454.0, 49914.750426247636, 49967.50032499628, 1231.9630411087683, 1268.3911722373311, 1269.6635391621228, 1269.904757143218, 1272.8345315108977, 26531.7346826537, 27356.863215683796, 27687.30781730392, 27693.72306276992, 27899.721002789713, 43078.0, 43440.0, 43454.13091738211, 43555.34666980061, 43681.56318436775, 288681.0, 290798.0, 291102.0, 291472.0, 291651.0, 30741.23146921345, 31380.05859824209, 39771.60228397795, 40547.79726101468, 41028.0, 37340.81329593444, 37949.0, 38537.229255415295, 38903.0, 39457.2108557833, 34593.13517162091, 34744.30511389809, 34820.47769283412, 35323.29353412969, 35555.82222088873, 35538.289234215685, 35922.0, 36380.454293185096, 36708.44937325996, 37092.443613345284, 32031.199220019687, 32230.35539289248, 32251.193720157185, 35816.82091589525, 36309.27381452409, 28251.43497130087, 29808.552871707376, 30211.546826797177, 30342.84828575843, 30509.0, 23992.880035599712, 24726.50546989086, 25067.24798256055, 25316.367090822878, 25473.74526254788], "unit": "score", "name": "ext.html", "value": 16982.758993457242}, {"lowerIsBetter": false, "replicates": [330.88821559559875, 332.20602759405017, 333.8147328232831, 341.90255777103516, 349.72546550957503, 16058.759118613216, 16100.436484723023, 16604.66790664186, 17240.655186896256, 17372.47882563522, 15131.394744210245, 15334.079955202697, 15345.30946107425, 15423.845761542381, 15576.221188940535, 4440.866773996777, 4646.326282689008, 4672.135654903836, 4676.602488788457, 4689.320048592952, 4674.579287864091, 4709.199436095855, 6545.967270163643, 6868.0, 6876.140482439695, 6162.599431036991, 6444.6133232006, 6484.773032943848, 6844.794656160323, 6847.246802851682, 6335.588186767845, 6422.421982021617, 6531.60810351378, 6841.897371539431, 6848.3494068063455, 6418.711157997901, 6529.640869752162, 6531.379518945692, 6532.0, 6562.376574225489, 21070.683939740917, 21245.575088498143, 21465.141394344206, 21878.562428751335, 21964.231251906265, 2148.054855863431, 2249.876256805875, 2317.073170731704, 2436.074291769134, 2974.6876577959433, 13553.864461355457, 13769.173849569059, 13880.93059534706, 13962.162270263816, 14304.642383940381, 1960.284496158906, 1984.2559040359865, 2006.6488364536149, 2046.8567200295986, 2068.606964676722, 65524.67237663781, 66152.0, 66260.33739662638, 66867.3313266866, 68824.31175688229, 14088.0, 15056.924715376354, 15126.0, 15177.468788592347, 15298.388064477518, 22666.773332266464, 22854.885725571265, 23118.19086332004, 23186.420339491648, 23303.650445243336, 8396.034456037634, 8459.111793261742, 8469.57652117404, 8697.434666746767, 8716.084811094745, 7069.787906362817, 7097.219305876452, 7150.10623672041, 7150.96424517874, 7291.052163218854, 7316.524425912405, 7468.589227592534, 7546.056742907137, 7578.621068946531, 7617.961910190414, 2977.925551861221, 2988.2379993102054, 3051.9389612207633, 3058.3883223354974, 3122.344307695364, 781.5529636369042, 838.3125836813754, 867.509856930832, 923.7275003873873, 948.805494873563, 15047.548573542812, 15796.36814527429, 15867.444639437565, 15929.36282548685, 16215.83784162167, 896.1531352871605, 896.5651658945407, 918.7978644698155, 921.8156368726281, 956.3735753081743, 9071.319651026068, 9313.953430232941, 9317.673881414117, 9325.067493250757, 9517.714468565953, 566017.0, 569407.0, 571680.0, 578094.0, 661590.0, 71348.2865171352, 74012.0, 74243.0, 76218.0, 77105.0, 1077.1490522487147, 1103.3600511703353, 1108.578740078765, 1113.5935383584933, 1116.8771435142128, 14273.0, 14922.104673719612, 14944.775828362366, 15011.699766004836, 15230.847691522942, 30704.232394190323, 31179.532307015867, 31383.21541961469, 32133.196670083435, 32473.02580922576, 41277.587224127376, 43331.13337733291, 43475.0, 43664.0, 43749.12501749884, 7336.449766267658, 7419.703211871465, 7427.108746950401, 7526.661300241392, 7645.770626881203, 10312.639057632947, 10949.616763413242, 11122.165837562054, 11172.38551879622, 11486.21963595644, 9448.244140468883, 9478.620855165991, 9729.805403891742, 9832.262580306362, 10095.596176153165, 9592.904070959481, 9692.951535242279, 10056.245781566266, 10158.13655839262, 10211.84682229782, 9728.805423891625, 9842.212622990286, 9853.655122070693, 9961.153301969123, 10076.899231007596, 7040.260772618802, 7083.3979111774015, 7149.356557909813, 7189.532680375759, 7191.892121618075, 9577.281703872377, 9685.70942871715, 9983.101520863158, 9993.150582200595, 10068.798624027624], "unit": "score", "name": "jquery.html", "value": 8971.436627080306}, {"lowerIsBetter": false, "replicates": [1333.2200662612372, 1388.1601631013236, 1478.9778153327702, 1638.8606968407692, 1655.776470176526, 6908.067410899527, 7546.056742907137, 7644.503107298022, 7844.09792873819, 7863.724769633064, 7534.0, 7548.88676669849, 7636.0, 7646.502977306485, 7659.119201291853, 2285.14307134824, 2309.6603969697535, 2310.1106074161403, 2312.5952958232324, 2315.2128276386024, 2253.0537174386795, 2263.592553340398, 2322.1175953137786, 2323.279783267184, 2332.5334933013464, 2229.7770222977733, 2274.65880117982, 2283.577538155438, 2285.8171346292256, 2306.630939049752, 2247.73027236731, 2264.4338915271182, 2283.8401311908174, 2310.4108452344713, 2310.8266879984067, 2321.8258630602772, 2322.1408079010707, 2344.3201471573225, 2346.554154710617, 2373.667686523888, 7626.1611222766005, 7713.34436572892, 7734.729284475073, 7749.7675069748, 7779.805504862367, 4434.0, 4504.144212599595, 4521.321801729767, 4524.796384162721, 4532.456105267389, 2973.36072744361, 2985.626796650419, 3058.4953482675332, 3072.6620071792086, 3114.174743692923, 882.5940067568926, 886.5744442667491, 893.1782759860944, 920.7882187096939, 923.9168474837297, 10790.838137427945, 10831.891681083245, 10850.511726972305, 10910.563577456893, 10932.0, 4096.0, 4127.958720412757, 4178.644815190682, 4181.289180839264, 4187.309093999456, 8084.272415482635, 8228.547429891414, 8236.052853921756, 8266.380021498411, 8276.710315138942, 4524.660650451229, 4555.316702494652, 4560.33875088117, 4563.703359281702, 4588.655850811202, 4223.640990515779, 4240.300350442204, 4241.1941731071, 4254.936175957363, 4268.722533035343, 3368.3768502827056, 3387.458006718913, 3400.9457068308407, 3407.727381809449, 3435.639257877887, 1037.2531777120462, 1054.7152268887357, 1055.4142450939803, 1064.2443864855884, 1070.6948519672012, 938.2353381993653, 946.9857952130724, 1002.6089824968268, 1009.0010889219619, 1250.7310928150491, 7177.605231712201, 7180.138383394026, 7208.171060328024, 7214.0, 7242.275772422716, 570.54356514788, 581.5260562641433, 593.5726277080495, 598.4105655928906, 732.3591857125016, 5541.0, 5616.522595579339, 5617.073182924772, 5629.7185140742795, 5672.858178545569, 9194.0, 9342.719718408458, 9631.181349585364, 9699.806003880023, 9715.514224288758, 9576.329656923948, 9586.328956972944, 9599.184069354043, 9620.90379096214, 9648.565814538362, 7363.300486453778, 7444.404447644176, 7539.585322807188, 7612.276833700789, 7618.514389693956, 7230.0, 7244.311790379906, 7254.056972593529, 7254.492185546961, 7280.089988751406, 8362.581870906552, 8469.237768600855, 8638.13618638131, 8639.0, 8718.956405217934, 8649.91350086491, 8798.516081615573, 8820.2061814437, 8838.823223535364, 8903.376763626484, 6442.838929026624, 6474.4820414365795, 6484.773032943825, 6487.772927947499, 6498.317676644074, 7454.068241469817, 7461.888071678821, 7484.887726683995, 7496.850062998818, 7501.924980750123, 6347.936520634919, 6860.897086543806, 6919.273476284918, 7055.647217638995, 7378.926210737824, 6892.965535172292, 6923.307669233036, 6939.583624982517, 6964.582125072309, 7091.503594748525, 6891.620960847001, 6993.790186294419, 6999.6850141742725, 7007.7196912122945, 7048.718051277891, 6455.903161452676, 6498.967505162444, 6516.152900122954, 6519.4784417245555, 6530.67346632657, 6461.289258181502, 6540.50946179048, 6558.1802274715665, 6568.934310656832, 6575.473962082926], "unit": "score", "name": "mootools.html", "value": 4343.345953390404}, {"lowerIsBetter": false, "replicates": [310.51404551876317, 314.3963589907378, 315.5597940872483, 315.909965659787, 320.2681871922657, 6168.167297414848, 6177.752889884405, 6307.747690092391, 6373.745050197992, 6388.9999999999945, 6261.154744109544, 6271.1533942917695, 6293.339199384068, 6301.716422760976, 6314.052892066193, 4714.151452738497, 4717.764111794397, 4718.221493453576, 4720.59874910633, 4721.787519561628, 4704.506026867164, 4716.787744551486, 4725.8582242532775, 4726.858194254178, 4734.692245004081, 4612.324851586089, 4634.907301853961, 4661.46393164787, 4673.2055550556315, 4694.530546945295, 4659.0, 4660.673752837302, 4661.6969896956925, 4672.649551283667, 4696.9530304696855, 4015.678745700337, 4026.355783074723, 4026.355783074723, 4035.2131334389805, 4041.312976793952, 5941.494972927263, 6001.0, 6010.128531362928, 6011.338752737195, 6017.097435384728, 5258.290130832365, 5433.130699088127, 5440.564754819605, 5447.836564903059, 5465.262189604392, 6563.442107420828, 6578.506612004119, 6629.436497897636, 6630.469562434993, 6636.469082473391, 4421.823127074946, 4428.977855110736, 4433.800478978422, 4436.0, 4437.600615944548, 6649.80050598478, 6907.585544867274, 6910.756063908494, 6933.965330173367, 7002.5098243123, 4400.537943515948, 4495.57292057254, 4495.662825288116, 4498.190325741398, 4508.932366014513, 4502.167099086614, 4537.069900670354, 4538.818447262072, 4546.272596384562, 4552.0, 5382.650127741685, 5384.730763461889, 5388.595855310789, 5391.73041347931, 5405.081136206854, 6632.8673426531195, 6700.2294736105, 6711.697973591103, 6724.865502690017, 6734.494912881553, 1545.8917875748589, 1575.850294222047, 1579.9605009874845, 1589.5946533633849, 1599.2163839718687, 1018.0328687746522, 1021.0606242257142, 1028.1569113327, 1030.5465595138114, 1035.29082578434, 6225.719842607094, 6245.875082498324, 6265.8120256392385, 6275.529335299871, 6281.96859015702, 6838.281980391987, 6857.348551887562, 6857.937019761945, 6864.656767161622, 6868.038474613558, 6128.662923539248, 6223.097650840603, 6254.6872656366995, 6263.780767673201, 6268.49852011838, 3679.889603311905, 3699.075231192202, 3704.3517384457614, 3707.1102935295335, 3723.478712980185, 7110.3956163725625, 7126.0, 7166.498345115792, 7182.8204294892, 7207.45944054198, 6927.238003819576, 6980.895286570705, 6984.930150698428, 7019.333163349474, 7060.293970602898, 7253.891191632129, 7331.78004659861, 7347.008153899155, 7387.113546374362, 7392.852142957111, 6963.895541566779, 6965.79102626922, 6965.930340696731, 6980.267071957372, 6991.96504017497, 6792.150981127359, 6873.140857392826, 6900.03399524057, 6901.0, 6902.758403455855, 7293.963530182527, 7321.267873212849, 7322.853542929218, 7329.486935914648, 7345.8898116527225, 4454.420925279693, 4494.865154045384, 4535.773211339354, 4538.773061346986, 4539.5006549280215, 6911.239763625897, 7016.438684905093, 7026.262242464672, 7036.648167591702, 7046.0, 6690.431313338421, 6718.8320291993095, 6738.460923126237, 6744.156980377453, 6757.86484270302, 6668.733250670113, 6696.866062678621, 6737.62943038118, 6746.291639377795, 6749.966250168718, 6455.419012288917, 6593.769218077345, 6618.966905165636, 6627.3372662733345, 6637.1703537057865, 6785.864282714219, 6802.081718968074, 6805.693743781443, 6809.795706128824, 6813.727450901908, 6567.474602031731, 6586.47308215332, 6593.505487088391, 6633.834154146185, 6645.0], "unit": "score", "name": "prototype.html", "value": 4951.527672996805}, {"lowerIsBetter": false, "replicates": [671.8824205763991, 674.841412268117, 768.8308572114133, 787.7400457848911, 791.5329955326356, 13587.45650173993, 13865.722685546283, 13927.164370137798, 13941.093828901114, 13955.441782328708, 12954.48182072716, 12986.0, 13020.804687929689, 13032.283224422654, 13033.08768386211, 690.4821383962028, 690.8411065454949, 693.1543516909388, 706.7667669669023, 718.622723070387, 716.380331013672, 718.924512926143, 739.109373205289, 751.2975368030882, 753.0850017229066, 771.7800426878341, 773.6093272897207, 781.5506084001694, 781.5701364249668, 788.5505262000662, 775.4765533265023, 778.1129512355947, 779.2363483785894, 780.6721177105601, 786.4534148766552, 566.7138095261867, 567.2597260574948, 571.5085026876883, 572.461885827321, 573.8651416917021, 13261.403236854365, 13299.20204787716, 13306.933465332708, 13351.265680387574, 13389.19664820114, 12220.388980550937, 12239.75520489594, 12514.624561263177, 12541.059420543404, 12548.937255313756, 10527.578896844117, 10548.0, 10556.208284378703, 10561.524731387106, 10584.100351470135, 4209.2633789086785, 4247.299195632717, 4251.149770046003, 4278.529361770203, 4327.06968001878, 49408.25887611689, 49545.50454495445, 49630.0, 49723.75138124322, 49786.0, 9657.613695452103, 9673.903260967441, 9805.313628045968, 10019.649312274036, 10233.181345492343, 16501.0, 16554.503364899072, 16651.33394664224, 16690.0, 16702.916485417496, 7388.926110738824, 7675.385969122457, 7738.651760670783, 7743.457957943003, 7855.332296754726, 4577.839775607904, 4601.493835678073, 4603.815847366068, 4613.492515823256, 4706.576408123216, 3127.0, 3134.341788224453, 3138.325260069096, 3146.5122905949615, 3159.3681263746885, 575.7869588252373, 578.4273569166495, 581.325662231809, 585.0434539527903, 598.1715324275909, 600.8618017855918, 624.487919905673, 655.6393983309256, 659.4987809264993, 681.2472218198918, 8548.529830859363, 9241.21449676785, 9675.419474831533, 9729.951350243346, 9849.359791613522, 545.0924211188407, 576.5877397660608, 677.9355961183679, 692.2765709833236, 710.0875375142916, 3923.4507168996365, 4186.960015077461, 4228.4080228768, 4228.450301460791, 4298.140371925565, 55467.0, 55837.441625583226, 55839.720801395735, 55972.0, 61666.69166654138, 47495.287570686465, 48580.5141948576, 49262.753686232056, 49460.75269623629, 49719.50280497149, 43613.78193109014, 44174.779126104164, 44405.777971109936, 45191.77404112958, 45349.773251133534, 8906.287497000094, 9058.818823623622, 9085.54572271397, 9106.726798196065, 9158.725238242863, 32570.674293256765, 32739.181520461225, 33676.831615841766, 33719.662803371655, 33783.49324760081, 38251.2349753009, 38469.807650961564, 43042.56957430386, 43396.783016084715, 43505.78247108871, 10565.313254638424, 10945.83581246298, 10979.17656175774, 11060.612878549213, 11145.498452569816, 12204.145709800583, 12210.633680989584, 12238.87761122413, 12688.809667855174, 13049.086563940433, 11337.149713771665, 11343.48954297075, 11587.420628968686, 11638.88361116378, 11866.347350895438, 11235.88764112381, 11325.546978120783, 11479.25384849982, 11785.644845275925, 11813.822792657946, 10900.509477073709, 11330.830037549607, 11702.0, 11840.763184736084, 12273.0, 9186.954065229631, 9249.583768730288, 9430.62277508892, 9531.952340238255, 9582.281328900499, 9567.712968610953, 10205.234607404325, 10338.638147664795, 10376.636817711646, 10461.843072353768], "unit": "score", "name": "yui.html", "value": 6261.899035005417}], "name": "dromaeo_css", "value": 6906.868579878694}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 114.0, 112.0, 113.0, 125.0, 113.0, 113.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 157.0, 166.0, 128.0, 167.0, 155.0, 126.0, 170.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 165.0, 164.0, 163.0, 163.0, 164.0, 170.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 74.0, 163.0, 74.0, 76.0, 72.0, 73.0, 158.0, 74.0], "unit": "score", "name": "audio-fft", "value": 91.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 152.0, 96.0, 98.0, 97.0, 145.0, 96.0, 97.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 111.7}, {"lowerIsBetter": true, "replicates": [120.0, 115.0, 117.0, 116.0, 115.0, 116.0, 115.0, 116.0, 116.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.1}, {"lowerIsBetter": true, "replicates": [150.0, 147.0, 149.0, 148.0, 151.0, 147.0, 148.0, 147.0, 149.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 148.5}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 96.0, 101.0, 99.0, 98.0, 96.0, 102.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.9}, {"lowerIsBetter": true, "replicates": [59.0, 63.0, 60.0, 63.0, 63.0, 59.0, 58.0, 64.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 60.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 69.0, 66.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 85.0, 83.0, 86.0, 84.0, 83.0, 92.0, 95.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [120.0, 121.0, 119.0, 120.0, 120.0, 120.0, 134.0, 122.0, 137.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [145.0, 152.0, 155.0, 154.0, 160.0, 151.0, 153.0, 147.0, 156.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.4}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 72.0, 68.0, 72.0, 69.0, 75.0, 70.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.0}], "name": "kraken", "value": 1551.4}]} 22:47:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1551.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6906.87"}}} 22:47:46 INFO - Return code: 0 22:47:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:47:46 INFO - # TBPL SUCCESS # 22:47:46 INFO - Running post-action listener: _resource_record_post_action 22:47:46 INFO - Running post-run listener: _resource_record_post_run 22:47:48 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 540319744; Read time: 0; Write time: 398316 22:47:48 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240222208; Read time: 0; Write time: 225376 22:47:48 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 300097536; Read time: 0; Write time: 172940 22:47:48 INFO - Running post-run listener: _upload_blobber_files 22:47:48 INFO - Blob upload gear active. 22:47:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:47:48 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 22:47:48 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:47:48 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:47:48 INFO - (blobuploader) - INFO - Open directory for files ... 22:47:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:47:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:47:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:47:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:49 INFO - (blobuploader) - INFO - Done attempting. 22:47:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:47:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:47:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:47:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:50 INFO - (blobuploader) - INFO - Done attempting. 22:47:50 INFO - (blobuploader) - INFO - Iteration through files over. 22:47:50 INFO - Return code: 0 22:47:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:47:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:47:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b001396f2a425f7b019d530aca0f12033b1d5b44637138a225f701dc726cd75057da8240dd2630cd91542ac39d475ca73cd9ff75c4d2fa7b400d3b493c8b5d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/481c82821c3429c2d9c4287392be60e00b665d5771345382f1422e63e237ab714475fef34757166c43aaba8c6638ab996bedbb98f7218c7c07d5e2dfdd1f9dde"} 22:47:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:47:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:47:50 INFO - Contents: 22:47:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b001396f2a425f7b019d530aca0f12033b1d5b44637138a225f701dc726cd75057da8240dd2630cd91542ac39d475ca73cd9ff75c4d2fa7b400d3b493c8b5d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/481c82821c3429c2d9c4287392be60e00b665d5771345382f1422e63e237ab714475fef34757166c43aaba8c6638ab996bedbb98f7218c7c07d5e2dfdd1f9dde"} 22:47:50 INFO - Running post-run listener: copy_logs_to_upload_dir 22:47:50 INFO - Copying logs to upload dir... 22:47:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:47:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.676270 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-02-13 22:47:48.375281) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-13 22:47:48.378710) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b001396f2a425f7b019d530aca0f12033b1d5b44637138a225f701dc726cd75057da8240dd2630cd91542ac39d475ca73cd9ff75c4d2fa7b400d3b493c8b5d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/481c82821c3429c2d9c4287392be60e00b665d5771345382f1422e63e237ab714475fef34757166c43aaba8c6638ab996bedbb98f7218c7c07d5e2dfdd1f9dde"} build_url:https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b001396f2a425f7b019d530aca0f12033b1d5b44637138a225f701dc726cd75057da8240dd2630cd91542ac39d475ca73cd9ff75c4d2fa7b400d3b493c8b5d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/481c82821c3429c2d9c4287392be60e00b665d5771345382f1422e63e237ab714475fef34757166c43aaba8c6638ab996bedbb98f7218c7c07d5e2dfdd1f9dde"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-13 22:47:48.402837) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:47:48.403176) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1455427491.994781-421184326 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:47:48.488024) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-13 22:47:48.488339) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-13 22:47:48.488610) ========= ========= Total master_lag: 0.48 =========