builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1457215878.67 results: success (0) buildid: 20160305113006 builduid: 1d434a5d89db4f3cb2db4c7346cc09e9 revision: b29add2c129122e4af8582cac68259c0cc96baec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:18.669687) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:18.670181) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:18.670515) ========= 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-1457214805.853392-1532103523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006464 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:18.747025) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:18.747354) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:18.928967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:18.929269) ========= 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-1457214805.853392-1532103523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004778 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:19.021025) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:19.021335) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:19.021755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:19.022078) ========= 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-1457214805.853392-1532103523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-05 14:11:19-- 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% 39.8M=0s 2016-03-05 14:11:19 (39.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106821 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:19.147878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:19.148203) ========= 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-1457214805.853392-1532103523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020086 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:19.201079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:19.201453) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b29add2c129122e4af8582cac68259c0cc96baec --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b29add2c129122e4af8582cac68259c0cc96baec --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-1457214805.853392-1532103523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-05 14:11:19,483 truncating revision to first 12 chars 2016-03-05 14:11:19,484 Setting DEBUG logging. 2016-03-05 14:11:19,484 attempt 1/10 2016-03-05 14:11:19,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b29add2c1291?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-05 14:11:19,825 unpacking tar archive at: fx-team-b29add2c1291/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646314 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:19.863608) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:19.866966) ========= echo b29add2c129122e4af8582cac68259c0cc96baec in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b29add2c129122e4af8582cac68259c0cc96baec'] 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-1457214805.853392-1532103523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b29add2c129122e4af8582cac68259c0cc96baec program finished with exit code 0 elapsedTime=0.004671 script_repo_revision: 'b29add2c129122e4af8582cac68259c0cc96baec' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:19.920244) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:19.920551) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-05 14:11:19.931080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-05 14:11:19.931358) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1457214805.853392-1532103523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:11:20 INFO - MultiFileLogger online at 20160305 14:11:20 in /builds/slave/test-pgo 14:11:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:11:20 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:11:20 INFO - {'append_to_log': False, 14:11:20 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:11:20 INFO - 'blob_upload_branch': 'Fx-Team', 14:11:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:11:20 INFO - 'branch': 'Fx-Team', 14:11:20 INFO - 'buildbot_json_path': 'buildprops.json', 14:11:20 INFO - 'config_files': ('talos/linux_config.py',), 14:11:20 INFO - 'default_actions': ('clobber', 14:11:20 INFO - 'read-buildbot-config', 14:11:20 INFO - 'download-and-extract', 14:11:20 INFO - 'populate-webroot', 14:11:20 INFO - 'create-virtualenv', 14:11:20 INFO - 'install', 14:11:20 INFO - 'run-tests'), 14:11:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:11:20 INFO - 'download_minidump_stackwalk': True, 14:11:20 INFO - 'download_symbols': 'ondemand', 14:11:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:11:20 INFO - 'tooltool.py': '/tools/tooltool.py', 14:11:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:11:20 INFO - '/tools/misc-python/virtualenv.py')}, 14:11:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:11:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:11:20 INFO - 'installer_path': 'installer.exe', 14:11:20 INFO - 'log_level': 'info', 14:11:20 INFO - 'log_name': 'talos', 14:11:20 INFO - 'log_to_console': True, 14:11:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:11:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:11:20 INFO - 'opt_config_files': (), 14:11:20 INFO - 'pip_index': False, 14:11:20 INFO - 'sps_profile': False, 14:11:20 INFO - 'sps_profile_interval': 0, 14:11:20 INFO - 'suite': 'dromaeojs', 14:11:20 INFO - 'system_bits': '32', 14:11:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:11:20 INFO - 'title': 'talos-linux64-ix-067', 14:11:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:11:20 INFO - 'use_talos_json': True, 14:11:20 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:11:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:11:20 INFO - 'work_dir': 'build'} 14:11:20 INFO - ##### 14:11:20 INFO - ##### Running clobber step. 14:11:20 INFO - ##### 14:11:20 INFO - Running pre-action listener: _resource_record_pre_action 14:11:20 INFO - Running main action method: clobber 14:11:20 INFO - rmtree: /builds/slave/test-pgo/build 14:11:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:11:20 INFO - Running post-action listener: _resource_record_post_action 14:11:20 INFO - ##### 14:11:20 INFO - ##### Running read-buildbot-config step. 14:11:20 INFO - ##### 14:11:20 INFO - Running pre-action listener: _resource_record_pre_action 14:11:20 INFO - Running main action method: read_buildbot_config 14:11:20 INFO - Using buildbot properties: 14:11:20 INFO - { 14:11:20 INFO - "project": "", 14:11:20 INFO - "product": "firefox", 14:11:20 INFO - "script_repo_revision": "production", 14:11:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:11:20 INFO - "repository": "", 14:11:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:11:20 INFO - "buildid": "20160305113006", 14:11:20 INFO - "pgo_build": "True", 14:11:20 INFO - "basedir": "/builds/slave/test-pgo", 14:11:20 INFO - "buildnumber": 978, 14:11:20 INFO - "slavename": "talos-linux64-ix-067", 14:11:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:11:20 INFO - "platform": "ubuntu64_hw", 14:11:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:11:20 INFO - "branch": "fx-team", 14:11:20 INFO - "repo_path": "integration/fx-team", 14:11:20 INFO - "revision": "b29add2c129122e4af8582cac68259c0cc96baec", 14:11:20 INFO - "stage_platform": "linux64-pgo", 14:11:20 INFO - "builduid": "1d434a5d89db4f3cb2db4c7346cc09e9", 14:11:20 INFO - "slavebuilddir": "test" 14:11:20 INFO - } 14:11:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 14:11:20 INFO - Running post-action listener: _resource_record_post_action 14:11:20 INFO - ##### 14:11:20 INFO - ##### Running download-and-extract step. 14:11:20 INFO - ##### 14:11:20 INFO - Running pre-action listener: _resource_record_pre_action 14:11:20 INFO - Running main action method: download_and_extract 14:11:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:11: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')]} 14:11:20 INFO - https://queue.taskcluster.net/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 14:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 14:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 14:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:11:25 INFO - Downloaded 1448 bytes. 14:11:25 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 14:11:25 INFO - Using the following test package requirements: 14:11:25 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:11:25 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:11:25 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:11:25 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:25 INFO - u'jsshell-linux-x86_64.zip'], 14:11:25 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:11:25 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:11:25 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:11:25 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:11:25 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:11:25 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:11:25 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:11:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:11:25 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:25 INFO - https://queue.taskcluster.net/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:11:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:11:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:11:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/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 14:11:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/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 14:11:30 INFO - Downloaded 23400454 bytes. 14:11:30 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'] 14:11:30 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 14:11:31 INFO - Return code: 0 14:11:31 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 14:11: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')]} 14:11:31 INFO - https://queue.taskcluster.net/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:11:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:11:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:11:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/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 14:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/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 14:11:33 INFO - Downloaded 23400454 bytes. 14:11:33 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'] 14:11:33 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 14:11:35 INFO - Return code: 0 14:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:35 INFO - https://queue.taskcluster.net/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/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 14:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/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 14:11:36 INFO - Downloaded 10803659 bytes. 14:11:36 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'] 14:11:36 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 14:11:36 INFO - Return code: 0 14:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:36 INFO - https://queue.taskcluster.net/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:11:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:11:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:11:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/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 14:11:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LszUj8SUR9mC_jzwaB9htg/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 14:11:37 INFO - Downloaded 56117043 bytes. 14:11:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:11:37 INFO - mkdir: /builds/slave/test-pgo/properties 14:11:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:11:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:11:37 INFO - Contents: 14:11:37 INFO - build_url:https://queue.taskcluster.net/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:11:38 INFO - Running post-action listener: _resource_record_post_action 14:11:38 INFO - Running post-action listener: set_extra_try_arguments 14:11:38 INFO - ##### 14:11:38 INFO - ##### Running populate-webroot step. 14:11:38 INFO - ##### 14:11:38 INFO - Running pre-action listener: _resource_record_pre_action 14:11:38 INFO - Running main action method: populate_webroot 14:11:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:38 INFO - '--tppagecycles', 14:11:38 INFO - '7'], 14:11:38 INFO - 'tests': ['tsvgm']}}, 14:11:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:11:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:11:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:11:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:11:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'talos_options': ['--e10s'], 14:11:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'tests': ['damp', 'tps']}, 14:11:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'talos_options': ['--e10s'], 14:11:38 INFO - 'tests': ['damp', 'tps']}, 14:11:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:11:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:38 INFO - 'other': {'tests': ['a11yr', 14:11:38 INFO - 'ts_paint', 14:11:38 INFO - 'tpaint', 14:11:38 INFO - 'sessionrestore', 14:11:38 INFO - 'sessionrestore_no_auto_restore']}, 14:11:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:11:38 INFO - 'tests': ['a11yr', 14:11:38 INFO - 'ts_paint', 14:11:38 INFO - 'tpaint', 14:11:38 INFO - 'sessionrestore', 14:11:38 INFO - 'sessionrestore_no_auto_restore']}, 14:11:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:11:38 INFO - 'tests': ['a11yr', 14:11:38 INFO - 'ts_paint', 14:11:38 INFO - 'tpaint', 14:11:38 INFO - 'sessionrestore', 14:11:38 INFO - 'sessionrestore_no_auto_restore']}, 14:11:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:11:38 INFO - 'tests': ['a11yr', 14:11:38 INFO - 'ts_paint', 14:11:38 INFO - 'tpaint', 14:11:38 INFO - 'sessionrestore', 14:11:38 INFO - 'sessionrestore_no_auto_restore']}, 14:11:38 INFO - 'other_l64': {'tests': ['a11yr', 14:11:38 INFO - 'ts_paint', 14:11:38 INFO - 'tpaint', 14:11:38 INFO - 'sessionrestore', 14:11:38 INFO - 'sessionrestore_no_auto_restore']}, 14:11:38 INFO - 'other_nol64': {'tests': ['a11yr', 14:11:38 INFO - 'ts_paint', 14:11:38 INFO - 'tpaint', 14:11:38 INFO - 'sessionrestore', 14:11:38 INFO - 'sessionrestore_no_auto_restore']}, 14:11:38 INFO - 'svgr': {'tests': ['tsvgx', 14:11:38 INFO - 'tsvgr_opacity', 14:11:38 INFO - 'tart', 14:11:38 INFO - 'tscrollx', 14:11:38 INFO - 'cart']}, 14:11:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:11:38 INFO - 'tests': ['tsvgx', 14:11:38 INFO - 'tsvgr_opacity', 14:11:38 INFO - 'tart', 14:11:38 INFO - 'tscrollx', 14:11:38 INFO - 'cart']}, 14:11:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'tests': ['tp5o']}, 14:11:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'talos_options': ['--e10s'], 14:11:38 INFO - 'tests': ['tp5o']}, 14:11:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'talos_options': ['--xperf_path', 14:11:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:38 INFO - 'tests': ['tp5n']}, 14:11:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:38 INFO - 'talos_options': ['--e10s', 14:11:38 INFO - '--xperf_path', 14:11:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:38 INFO - 'tests': ['tp5n']}}, 14:11:38 INFO - 'talos.zip': {'path': '', 14:11:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:38 INFO - Running post-action listener: _resource_record_post_action 14:11:38 INFO - ##### 14:11:38 INFO - ##### Running create-virtualenv step. 14:11:38 INFO - ##### 14:11:38 INFO - Running pre-action listener: _resource_record_pre_action 14:11:38 INFO - Running main action method: create_virtualenv 14:11:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:11:38 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 14:11:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:11:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:38 INFO - Using real prefix '/usr' 14:11:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:11:38 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:40 INFO - Installing pip.................done. 14:11:40 INFO - Return code: 0 14:11:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:11: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')]} 14:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7715ae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23676d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6920>, '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 0x23f7820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7cb0>, '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-1457214805.853392-1532103523', '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 14:11: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:11: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 pip>=1.5 14:11:40 INFO - Using env: {'DISPLAY': ':0', 14:11:40 INFO - 'HOME': '/home/cltbld', 14:11:40 INFO - 'LANG': 'en_US.UTF-8', 14:11:40 INFO - 'LANGUAGE': 'en_US:en', 14:11:40 INFO - 'LOGNAME': 'cltbld', 14:11:40 INFO - 'MAIL': '/var/mail/cltbld', 14:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:40 INFO - 'MOZ_NO_REMOTE': '1', 14:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:40 INFO - 'NO_EM_RESTART': '1', 14:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:40 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:40 INFO - 'SHELL': '/bin/bash', 14:11:40 INFO - 'SHLVL': '1', 14:11:40 INFO - 'TERM': 'linux', 14:11:40 INFO - 'TMOUT': '86400', 14:11:40 INFO - 'USER': 'cltbld', 14:11:40 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457214805.853392-1532103523', 14:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:40 INFO - '_': '/tools/buildbot/bin/python'} 14:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:41 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 14:11:41 INFO - Cleaning up... 14:11:41 INFO - Return code: 0 14:11:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7715ae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23676d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6920>, '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 0x23f7820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7cb0>, '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-1457214805.853392-1532103523', '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 14:11:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:11:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:11:41 INFO - Using env: {'DISPLAY': ':0', 14:11:41 INFO - 'HOME': '/home/cltbld', 14:11:41 INFO - 'LANG': 'en_US.UTF-8', 14:11:41 INFO - 'LANGUAGE': 'en_US:en', 14:11:41 INFO - 'LOGNAME': 'cltbld', 14:11:41 INFO - 'MAIL': '/var/mail/cltbld', 14:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:41 INFO - 'MOZ_NO_REMOTE': '1', 14:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:41 INFO - 'NO_EM_RESTART': '1', 14:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:41 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:41 INFO - 'SHELL': '/bin/bash', 14:11:41 INFO - 'SHLVL': '1', 14:11:41 INFO - 'TERM': 'linux', 14:11:41 INFO - 'TMOUT': '86400', 14:11:41 INFO - 'USER': 'cltbld', 14:11:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457214805.853392-1532103523', 14:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:41 INFO - '_': '/tools/buildbot/bin/python'} 14:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:41 INFO - Downloading/unpacking psutil>=0.7.1 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:43 INFO - Installing collected packages: psutil 14:11:43 INFO - Running setup.py install for psutil 14:11:43 INFO - building 'psutil._psutil_linux' extension 14:11:43 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 14:11:43 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 14:11:43 INFO - building 'psutil._psutil_posix' extension 14:11:43 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 14:11:43 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 14:11:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:43 INFO - Successfully installed psutil 14:11:43 INFO - Cleaning up... 14:11:43 INFO - Return code: 0 14:11:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:11: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')]} 14:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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', '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 0x7f7715ae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23676d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6920>, '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 0x23f7820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7cb0>, '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-1457214805.853392-1532103523', '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 14:11: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:11: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 mozsystemmonitor==0.0.0 14:11:43 INFO - Using env: {'DISPLAY': ':0', 14:11:43 INFO - 'HOME': '/home/cltbld', 14:11:43 INFO - 'LANG': 'en_US.UTF-8', 14:11:43 INFO - 'LANGUAGE': 'en_US:en', 14:11:43 INFO - 'LOGNAME': 'cltbld', 14:11:43 INFO - 'MAIL': '/var/mail/cltbld', 14:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:43 INFO - 'MOZ_NO_REMOTE': '1', 14:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:43 INFO - 'NO_EM_RESTART': '1', 14:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:43 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:43 INFO - 'SHELL': '/bin/bash', 14:11:43 INFO - 'SHLVL': '1', 14:11:43 INFO - 'TERM': 'linux', 14:11:43 INFO - 'TMOUT': '86400', 14:11:43 INFO - 'USER': 'cltbld', 14:11:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457214805.853392-1532103523', 14:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:43 INFO - '_': '/tools/buildbot/bin/python'} 14:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:11:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:11:45 INFO - Installing collected packages: mozsystemmonitor 14:11:45 INFO - Running setup.py install for mozsystemmonitor 14:11:45 INFO - Successfully installed mozsystemmonitor 14:11:45 INFO - Cleaning up... 14:11:45 INFO - Return code: 0 14:11:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:11:45 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')]} 14:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:45 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')]} 14:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:45 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 0x7f7715ae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23676d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6920>, '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 0x23f7820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7cb0>, '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-1457214805.853392-1532103523', '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 14:11:45 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 14:11:45 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 14:11:45 INFO - Using env: {'DISPLAY': ':0', 14:11:45 INFO - 'HOME': '/home/cltbld', 14:11:45 INFO - 'LANG': 'en_US.UTF-8', 14:11:45 INFO - 'LANGUAGE': 'en_US:en', 14:11:45 INFO - 'LOGNAME': 'cltbld', 14:11:45 INFO - 'MAIL': '/var/mail/cltbld', 14:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:45 INFO - 'MOZ_NO_REMOTE': '1', 14:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:45 INFO - 'NO_EM_RESTART': '1', 14:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:45 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:45 INFO - 'SHELL': '/bin/bash', 14:11:45 INFO - 'SHLVL': '1', 14:11:45 INFO - 'TERM': 'linux', 14:11:45 INFO - 'TMOUT': '86400', 14:11:45 INFO - 'USER': 'cltbld', 14:11:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457214805.853392-1532103523', 14:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:45 INFO - '_': '/tools/buildbot/bin/python'} 14:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:46 INFO - Downloading/unpacking blobuploader==1.2.4 14:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:47 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:11:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:48 INFO - Downloading docopt-0.6.1.tar.gz 14:11:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:48 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:48 INFO - Running setup.py install for blobuploader 14:11:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:11:48 INFO - Running setup.py install for requests 14:11:49 INFO - Running setup.py install for docopt 14:11:49 INFO - Successfully installed blobuploader requests docopt 14:11:49 INFO - Cleaning up... 14:11:49 INFO - Return code: 0 14:11:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:11: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')]} 14:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:49 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 0x7f7715ae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23676d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6920>, '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 0x23f7820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7cb0>, '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-1457214805.853392-1532103523', '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 14:11:49 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 14:11:49 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 14:11:49 INFO - Using env: {'DISPLAY': ':0', 14:11:49 INFO - 'HOME': '/home/cltbld', 14:11:49 INFO - 'LANG': 'en_US.UTF-8', 14:11:49 INFO - 'LANGUAGE': 'en_US:en', 14:11:49 INFO - 'LOGNAME': 'cltbld', 14:11:49 INFO - 'MAIL': '/var/mail/cltbld', 14:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:49 INFO - 'MOZ_NO_REMOTE': '1', 14:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:49 INFO - 'NO_EM_RESTART': '1', 14:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:49 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:49 INFO - 'SHELL': '/bin/bash', 14:11:49 INFO - 'SHLVL': '1', 14:11:49 INFO - 'TERM': 'linux', 14:11:49 INFO - 'TMOUT': '86400', 14:11:49 INFO - 'USER': 'cltbld', 14:11:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457214805.853392-1532103523', 14:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:49 INFO - '_': '/tools/buildbot/bin/python'} 14:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:11:49 INFO - Running setup.py (path:/tmp/pip-T43OJf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:11:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:11:49 INFO - Running setup.py (path:/tmp/pip-zJoDnE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:11:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:11:49 INFO - Running setup.py (path:/tmp/pip-5z36wM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:11:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:11:49 INFO - Running setup.py (path:/tmp/pip-tNvT1L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:11:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:11:49 INFO - Running setup.py (path:/tmp/pip-JVFweL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:11:50 INFO - Running setup.py (path:/tmp/pip-SPoKYa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:11:50 INFO - Running setup.py (path:/tmp/pip-5vychl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:11:50 INFO - Running setup.py (path:/tmp/pip-K_qkoC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:11:50 INFO - Running setup.py (path:/tmp/pip-ol_JDl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:11:50 INFO - Running setup.py (path:/tmp/pip-da2JLW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:11:50 INFO - Running setup.py (path:/tmp/pip-D07Sxn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:11:50 INFO - Running setup.py (path:/tmp/pip-3yNBE0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:11:50 INFO - Running setup.py (path:/tmp/pip-QB8xte-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:11:50 INFO - Running setup.py (path:/tmp/pip-LA1AM0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:11:50 INFO - Running setup.py (path:/tmp/pip-zSRFuQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:11:50 INFO - Running setup.py (path:/tmp/pip-fWW2xF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:11:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:11:50 INFO - Running setup.py (path:/tmp/pip-RxqT1u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:11:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:50 INFO - Running setup.py install for manifestparser 14:11:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:11:51 INFO - Running setup.py install for mozcrash 14:11:51 INFO - Running setup.py install for mozdebug 14:11:51 INFO - Running setup.py install for mozdevice 14:11:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:11:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:11:51 INFO - Running setup.py install for mozfile 14:11:51 INFO - Running setup.py install for mozhttpd 14:11:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:11:51 INFO - Running setup.py install for mozinfo 14:11:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:11:51 INFO - Running setup.py install for mozInstall 14:11:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:11:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:11:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:11:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:11:51 INFO - Running setup.py install for mozleak 14:11:51 INFO - Running setup.py install for mozlog 14:11:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:11:51 INFO - Running setup.py install for moznetwork 14:11:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:11:52 INFO - Running setup.py install for mozprocess 14:11:52 INFO - Running setup.py install for mozprofile 14:11:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:11:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:11:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:11:52 INFO - Running setup.py install for mozrunner 14:11:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:11:52 INFO - Running setup.py install for mozscreenshot 14:11:52 INFO - Running setup.py install for moztest 14:11:52 INFO - Running setup.py install for mozversion 14:11:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:11:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:52 INFO - Cleaning up... 14:11:52 INFO - Return code: 0 14:11:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:11:52 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')]} 14:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:52 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')]} 14:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:52 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 0x7f7715ae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23676d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6920>, '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 0x23f7820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7cb0>, '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-1457214805.853392-1532103523', '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 14:11:52 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 14:11:52 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 14:11:52 INFO - Using env: {'DISPLAY': ':0', 14:11:52 INFO - 'HOME': '/home/cltbld', 14:11:52 INFO - 'LANG': 'en_US.UTF-8', 14:11:52 INFO - 'LANGUAGE': 'en_US:en', 14:11:52 INFO - 'LOGNAME': 'cltbld', 14:11:52 INFO - 'MAIL': '/var/mail/cltbld', 14:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:52 INFO - 'MOZ_NO_REMOTE': '1', 14:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:52 INFO - 'NO_EM_RESTART': '1', 14:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:52 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:52 INFO - 'SHELL': '/bin/bash', 14:11:52 INFO - 'SHLVL': '1', 14:11:52 INFO - 'TERM': 'linux', 14:11:52 INFO - 'TMOUT': '86400', 14:11:52 INFO - 'USER': 'cltbld', 14:11:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457214805.853392-1532103523', 14:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:52 INFO - '_': '/tools/buildbot/bin/python'} 14:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:11:52 INFO - Running setup.py (path:/tmp/pip-rhVBGp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:11:52 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)) 14:11:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:11:52 INFO - Running setup.py (path:/tmp/pip-7Tygop-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:11:53 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)) 14:11:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:11:53 INFO - Running setup.py (path:/tmp/pip-BY4SFu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:11:53 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)) 14:11:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:11:53 INFO - Running setup.py (path:/tmp/pip-cYHIf4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:11:53 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)) 14:11:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:11:53 INFO - Running setup.py (path:/tmp/pip-zsVgaf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:11:53 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)) 14:11:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:11:53 INFO - Running setup.py (path:/tmp/pip-MY3XLO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:11:53 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)) 14:11:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:11:53 INFO - Running setup.py (path:/tmp/pip-DgVhWR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:11:53 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)) 14:11:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:11:53 INFO - Running setup.py (path:/tmp/pip-FG5CT0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:11:53 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)) 14:11:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:11:53 INFO - Running setup.py (path:/tmp/pip-sKd56w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:11:53 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)) 14:11:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:11:53 INFO - Running setup.py (path:/tmp/pip-OksvN2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:11:53 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)) 14:11:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:11:53 INFO - Running setup.py (path:/tmp/pip-FSTo08-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:11:53 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)) 14:11:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:11:53 INFO - Running setup.py (path:/tmp/pip-rUQshH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:11:53 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)) 14:11:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:11:53 INFO - Running setup.py (path:/tmp/pip-0r6ExC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:11:53 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)) 14:11:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:11:53 INFO - Running setup.py (path:/tmp/pip-dVaraC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:11:53 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)) 14:11:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:11:53 INFO - Running setup.py (path:/tmp/pip-ib8fUX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:11:54 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)) 14:11:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:11:54 INFO - Running setup.py (path:/tmp/pip-uLyd1F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:11:54 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)) 14:11:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:11:54 INFO - Running setup.py (path:/tmp/pip-1ydS9b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:11:54 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)) 14:11:54 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)) 14:11:54 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)) 14:11:54 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)) 14:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:54 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)) 14:11:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:55 INFO - Downloading blessings-1.6.tar.gz 14:11:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:56 INFO - Installing collected packages: blessings 14:11:56 INFO - Running setup.py install for blessings 14:11:56 INFO - Successfully installed blessings 14:11:56 INFO - Cleaning up... 14:11:56 INFO - Return code: 0 14:11:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:11:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:11:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:11:56 INFO - Reading from file tmpfile_stdout 14:11:56 INFO - Current package versions: 14:11:56 INFO - argparse == 1.2.1 14:11:56 INFO - blessings == 1.6 14:11:56 INFO - blobuploader == 1.2.4 14:11:56 INFO - docopt == 0.6.1 14:11:56 INFO - manifestparser == 1.1 14:11:56 INFO - mozInstall == 1.12 14:11:56 INFO - mozcrash == 0.16 14:11:56 INFO - mozdebug == 0.1 14:11:56 INFO - mozdevice == 0.48 14:11:56 INFO - mozfile == 1.2 14:11:56 INFO - mozhttpd == 0.7 14:11:56 INFO - mozinfo == 0.9 14:11:56 INFO - mozleak == 0.1 14:11:56 INFO - mozlog == 3.1 14:11:56 INFO - moznetwork == 0.27 14:11:56 INFO - mozprocess == 0.22 14:11:56 INFO - mozprofile == 0.28 14:11:56 INFO - mozrunner == 6.11 14:11:56 INFO - mozscreenshot == 0.1 14:11:56 INFO - mozsystemmonitor == 0.0 14:11:56 INFO - moztest == 0.7 14:11:56 INFO - mozversion == 1.4 14:11:56 INFO - psutil == 3.1.1 14:11:56 INFO - requests == 1.2.3 14:11:56 INFO - wsgiref == 0.1.2 14:11:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:11: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')]} 14:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:56 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 0x7f7715ae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23676d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6920>, '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 0x23f7820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7cb0>, '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-1457214805.853392-1532103523', '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 14:11:56 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 14:11:56 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 14:11:56 INFO - Using env: {'DISPLAY': ':0', 14:11:56 INFO - 'HOME': '/home/cltbld', 14:11:56 INFO - 'LANG': 'en_US.UTF-8', 14:11:56 INFO - 'LANGUAGE': 'en_US:en', 14:11:56 INFO - 'LOGNAME': 'cltbld', 14:11:56 INFO - 'MAIL': '/var/mail/cltbld', 14:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:56 INFO - 'MOZ_NO_REMOTE': '1', 14:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:56 INFO - 'NO_EM_RESTART': '1', 14:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:56 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:56 INFO - 'SHELL': '/bin/bash', 14:11:56 INFO - 'SHLVL': '1', 14:11:56 INFO - 'TERM': 'linux', 14:11:56 INFO - 'TMOUT': '86400', 14:11:56 INFO - 'USER': 'cltbld', 14:11:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457214805.853392-1532103523', 14:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:56 INFO - '_': '/tools/buildbot/bin/python'} 14:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:56 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)) 14:11:56 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)) 14:11:56 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)) 14:11:56 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)) 14:11:56 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)) 14:11:56 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)) 14:11:56 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)) 14:11:56 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)) 14:11:56 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)) 14:11:56 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)) 14:11:56 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)) 14:11:56 INFO - Cleaning up... 14:11:56 INFO - Return code: 0 14:11:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:11: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')]} 14:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7715ae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23676d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6920>, '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 0x23f7820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7cb0>, '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-1457214805.853392-1532103523', '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 14:11: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', 'jsonschema'] in /builds/slave/test-pgo/build 14:11: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 jsonschema 14:11:56 INFO - Using env: {'DISPLAY': ':0', 14:11:56 INFO - 'HOME': '/home/cltbld', 14:11:56 INFO - 'LANG': 'en_US.UTF-8', 14:11:56 INFO - 'LANGUAGE': 'en_US:en', 14:11:56 INFO - 'LOGNAME': 'cltbld', 14:11:56 INFO - 'MAIL': '/var/mail/cltbld', 14:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:56 INFO - 'MOZ_NO_REMOTE': '1', 14:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:56 INFO - 'NO_EM_RESTART': '1', 14:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:56 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:56 INFO - 'SHELL': '/bin/bash', 14:11:56 INFO - 'SHLVL': '1', 14:11:56 INFO - 'TERM': 'linux', 14:11:56 INFO - 'TMOUT': '86400', 14:11:56 INFO - 'USER': 'cltbld', 14:11:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457214805.853392-1532103523', 14:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:56 INFO - '_': '/tools/buildbot/bin/python'} 14:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:56 INFO - Downloading/unpacking jsonschema 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:58 INFO - Downloading/unpacking functools32 (from jsonschema) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:58 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:58 INFO - warning: no files found matching '*.txt' 14:11:58 INFO - no previously-included directories found matching 'build' 14:11:58 INFO - no previously-included directories found matching 'dist' 14:11:58 INFO - no previously-included directories found matching '.git*' 14:11:58 INFO - Installing collected packages: jsonschema, functools32 14:11:59 INFO - Running setup.py install for functools32 14:11:59 INFO - warning: no files found matching '*.txt' 14:11:59 INFO - no previously-included directories found matching 'build' 14:11:59 INFO - no previously-included directories found matching 'dist' 14:11:59 INFO - no previously-included directories found matching '.git*' 14:11:59 INFO - Successfully installed jsonschema functools32 14:11:59 INFO - Cleaning up... 14:11:59 INFO - Return code: 0 14:11:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:59 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 0x7f7715ae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23676d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f6920>, '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 0x23f7820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7cb0>, '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-1457214805.853392-1532103523', '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 14:11:59 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 14:11:59 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 14:11:59 INFO - Using env: {'DISPLAY': ':0', 14:11:59 INFO - 'HOME': '/home/cltbld', 14:11:59 INFO - 'LANG': 'en_US.UTF-8', 14:11:59 INFO - 'LANGUAGE': 'en_US:en', 14:11:59 INFO - 'LOGNAME': 'cltbld', 14:11:59 INFO - 'MAIL': '/var/mail/cltbld', 14:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:59 INFO - 'MOZ_NO_REMOTE': '1', 14:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:59 INFO - 'NO_EM_RESTART': '1', 14:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:11:59 INFO - 'PWD': '/builds/slave/test-pgo', 14:11:59 INFO - 'SHELL': '/bin/bash', 14:11:59 INFO - 'SHLVL': '1', 14:11:59 INFO - 'TERM': 'linux', 14:11:59 INFO - 'TMOUT': '86400', 14:11:59 INFO - 'USER': 'cltbld', 14:11:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457214805.853392-1532103523', 14:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:59 INFO - '_': '/tools/buildbot/bin/python'} 14:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:59 INFO - Downloading/unpacking flake8 14:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:12:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:12:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:12:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:12:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:12:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:12:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:12:01 INFO - no previously-included directories found matching 'docs/_build' 14:12:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:12:01 INFO - Running setup.py install for pep8 14:12:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:12:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:12:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:12:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:12:02 INFO - no previously-included directories found matching 'docs/_build' 14:12:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:12:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:12:02 INFO - Cleaning up... 14:12:02 INFO - Return code: 0 14:12:02 INFO - Running post-action listener: _resource_record_post_action 14:12:02 INFO - Running post-action listener: _start_resource_monitoring 14:12:02 INFO - Starting resource monitoring. 14:12:02 INFO - ##### 14:12:02 INFO - ##### Running install step. 14:12:02 INFO - ##### 14:12:02 INFO - Running pre-action listener: _resource_record_pre_action 14:12:02 INFO - Running main action method: install 14:12:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:12:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:12:02 INFO - Reading from file tmpfile_stdout 14:12:02 INFO - Detecting whether we're running mozinstall >=1.0... 14:12:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:12:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:12:02 INFO - Reading from file tmpfile_stdout 14:12:02 INFO - Output received: 14:12:02 INFO - Usage: mozinstall [options] installer 14:12:02 INFO - Options: 14:12:02 INFO - -h, --help show this help message and exit 14:12:02 INFO - -d DEST, --destination=DEST 14:12:02 INFO - Directory to install application into. [default: 14:12:02 INFO - "/builds/slave/test-pgo"] 14:12:02 INFO - --app=APP Application being installed. [default: firefox] 14:12:02 INFO - mkdir: /builds/slave/test-pgo/build/application 14:12:02 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'] 14:12:02 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 14:12:18 INFO - Reading from file tmpfile_stdout 14:12:18 INFO - Output received: 14:12:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:12:18 INFO - Running post-action listener: _resource_record_post_action 14:12:18 INFO - ##### 14:12:18 INFO - ##### Running run-tests step. 14:12:18 INFO - ##### 14:12:18 INFO - Running pre-action listener: _resource_record_pre_action 14:12:18 INFO - Running main action method: run_tests 14:12:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:12:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:12:18 INFO - Python 2.7.3 14:12:18 INFO - Return code: 0 14:12:18 INFO - grabbing minidump binary from tooltool 14:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:18 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 0x23f6920>, '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 0x23f7820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:12:18 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 14:12:18 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 14:12:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:12:18 INFO - Return code: 0 14:12:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:12:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:12:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:12:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:12:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:12:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:12:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:12:19 INFO - Return code: 0 14:12:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LszUj8SUR9mC_jzwaB9htg/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_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:12:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LszUj8SUR9mC_jzwaB9htg/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_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:12:19 INFO - Using env: {'DISPLAY': ':0', 14:12:19 INFO - 'HOME': '/home/cltbld', 14:12:19 INFO - 'LANG': 'en_US.UTF-8', 14:12:19 INFO - 'LANGUAGE': 'en_US:en', 14:12:19 INFO - 'LOGNAME': 'cltbld', 14:12:19 INFO - 'MAIL': '/var/mail/cltbld', 14:12:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:12:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:19 INFO - 'MOZ_NO_REMOTE': '1', 14:12:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:19 INFO - 'NO_EM_RESTART': '1', 14:12:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:12:19 INFO - 'PWD': '/builds/slave/test-pgo', 14:12:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:12:19 INFO - 'SHELL': '/bin/bash', 14:12:19 INFO - 'SHLVL': '1', 14:12:19 INFO - 'TERM': 'linux', 14:12:19 INFO - 'TMOUT': '86400', 14:12:19 INFO - 'USER': 'cltbld', 14:12:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1457214805.853392-1532103523', 14:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:19 INFO - '_': '/tools/buildbot/bin/python'} 14:12:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LszUj8SUR9mC_jzwaB9htg/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_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:12:19 INFO - mozversion application_buildid: 20160305113006 14:12:19 INFO - mozversion application_changeset: b29add2c129122e4af8582cac68259c0cc96baec 14:12:19 INFO - mozversion application_display_name: Nightly 14:12:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:12:19 INFO - mozversion application_name: Firefox 14:12:19 INFO - mozversion application_remotingname: firefox 14:12:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:12:19 INFO - mozversion application_vendor: Mozilla 14:12:19 INFO - mozversion application_version: 47.0a1 14:12:19 INFO - mozversion platform_buildid: 20160305113006 14:12:19 INFO - mozversion platform_changeset: b29add2c129122e4af8582cac68259c0cc96baec 14:12:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:12:19 INFO - mozversion platform_version: 47.0a1 14:12:19 INFO - using testdate: 1457215939 14:12:19 INFO - actual date: 1457215939 14:12:19 INFO - starting webserver on 'localhost:43374' 14:12:19 INFO - SUITE-START | Running 2 tests 14:12:19 INFO - TEST-START | dromaeo_css 14:12:19 INFO - operating with platform_type : linux_ 14:12:19 INFO - Initialising browser for dromaeo_css test... 14:12:19 INFO - TEST-INFO | started process 18901 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkS4GR3/profile http://localhost:43374/getInfo.html) 14:12:23 INFO - PROCESS | 18901 | __metrics Screen width/height:1600/1200 14:12:23 INFO - PROCESS | 18901 | colorDepth:24 14:12:23 INFO - PROCESS | 18901 | Browser inner width/height: 1024/697 14:12:23 INFO - PROCESS | 18901 | __metrics 14:12:24 INFO - PROCESS | 18901 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:12:24 INFO - PROCESS | 18901 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 14:12:25 INFO - TEST-INFO | 18901: exit 0 14:12:25 INFO - Browser initialized. 14:12:25 INFO - Running cycle 1/1 for dromaeo_css test... 14:12:25 INFO - TEST-INFO | started process 18998 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkS4GR3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:36 INFO - PROCESS | 18998 | RSS: Main: 154996736 14:12:36 INFO - PROCESS | 18998 | 14:13:27 INFO - PROCESS | 18998 | 1457216007505 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] 14:15:36 INFO - PROCESS | 18998 | Cycle 1(1): loaded http://localhost:43374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43374/tests/dromaeo/cssquery-ext.html) 14:15:37 INFO - PROCESS | 18998 | RSS: Main: 245100544 14:15:37 INFO - PROCESS | 18998 | 14:18:39 INFO - PROCESS | 18998 | Cycle 1(1): loaded http://localhost:43374/tests/dromaeo/cssquery-ext.html (next: http://localhost:43374/tests/dromaeo/cssquery-jquery.html) 14:18:40 INFO - PROCESS | 18998 | RSS: Main: 236883968 14:18:40 INFO - PROCESS | 18998 | 14:21:42 INFO - PROCESS | 18998 | Cycle 1(1): loaded http://localhost:43374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43374/tests/dromaeo/cssquery-mootools.html) 14:21:42 INFO - PROCESS | 18998 | RSS: Main: 242495488 14:21:42 INFO - PROCESS | 18998 | 14:24:44 INFO - PROCESS | 18998 | Cycle 1(1): loaded http://localhost:43374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43374/tests/dromaeo/cssquery-prototype.html) 14:24:45 INFO - PROCESS | 18998 | RSS: Main: 219246592 14:24:45 INFO - PROCESS | 18998 | 14:27:47 INFO - PROCESS | 18998 | Cycle 1(1): loaded http://localhost:43374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43374/tests/dromaeo/cssquery-yui.html) 14:27:48 INFO - PROCESS | 18998 | RSS: Main: 212578304 14:27:48 INFO - PROCESS | 18998 | 14:30:51 INFO - PROCESS | 18998 | Cycle 1(1): loaded http://localhost:43374/tests/dromaeo/cssquery-yui.html (next: http://localhost:43374/tests/dromaeo/cssquery-dojo.html) 14:30:51 INFO - PROCESS | 18998 | RSS: Main: 265293824 14:30:51 INFO - PROCESS | 18998 | 14:30:51 INFO - PROCESS | 18998 | __start_tp_report 14:30:51 INFO - PROCESS | 18998 | _x_x_mozilla_page_load 14:30:51 INFO - PROCESS | 18998 | _x_x_mozilla_page_load_details 14:30:51 INFO - PROCESS | 18998 | |i|pagename|runs| 14:30:51 INFO - PROCESS | 18998 | |0;dojo.html;3120.4539205639007;3163;3206.711395974362;3214.083986063972;3239.352129574085;5084.618653600985;5106.41276253231;5117.257997590352;5136.640435169535;5169.948300516999;5100.693958362492;5133.82031628893;5139.306193663854;5141.717205553693;5177.508136727005;4579.335996280537;4589.747563883985;4592.242280023792;4660.883477913046;4711.104890070876;4652.74409907455;4716.339712440261;4718.693284936486;4724.338592597039;4767.928481072787;4592.839250626229;4636.768161591941;4683.508231635663;4693.460252071004;4769.308450274691;4681.602063824579;4683.531646835323;4688.062387522509;4693.577578017961;4730.195866702635;4677.204875171229;4681.438227412698;4686.578207961265;4691.7184968901975;4720.905581888343;4979.701217926936;5000;5016.799328026875;5114.539691427753;5126.128558145124;5391.919121213185;5396.379416367129;5397.784088636489;5402.297701298845;5403.621746477748;5402.297701298806;5405.108157154064;5407.594430417695;5409.540189083933;5442.102053161224;5102.081625307444;5134.871628209287;5151.201563757623;5210.036143313461;5217.113090774577;5474.753636086386;5479.6164268500825;5485.286912701324;5489.094299440628;5521.365043020024;5305.469453054741;5307.867303317448;5307.946920530822;5317.574594032545;5350.143976963667;5469.343678758574;5497.725113744297;5511.22842802008;5557.221988921554;5567.721613919288;5350.732463376816;5365.570754339644;5366.758495867617;5375.354957405137;5381.919271210935;5364.463553644682;5366.221897824794;5397.514223719884;5411.78352865881;5431.755570999315;4150.294449943517;4167.97916010418;4189.392538081961;4193.601607847249;4202.180574787948;3741.6071312511795;3755.6807671347697;3771.6039815819495;3776.4712940188397;3803.771773693532;4991.401031876126;5074.746262686851;5077.1876499759865;5125.461826508237;5194.532492075656;5510.283663123768;5511.58663100269;5531.170324451284;5536.363318218457;5539.446055394428;5117.257997590328;5180.922286165711;5186;5188.377394712658;5231.95360927816;4597.080583883237;4599.632029437637;4659.906801863944;4682.929756053662;4683.461401938821;5646.2377579027125;5664.291963504562;5667.574931880125;5673.8297851064535;5677.034904066319;5423.864403389947;5423.972880135574;5425.213344065168;5425.538829199562;5470.835874923759;5649.661020338793;5691.203231547669;5728.312602487562;5798.449147330997;5808.041673124057;5368.141097424549;5386.811461598825;5387.191921211849;5396.406395296436;5396.703181325065;5388.326459192601;5395.406505284494;5420.9186862197885;5428.70142142186;5441.102218133963;5332.840014799563;5359.812406565751;5373.9731301343245;5416.593755468277;5417.6478528895495;5268.367795864521;5268.6575372600655;5273.551748101301;5276.657017293864;5331.226972088948;5131.076406246912;5192.091384007859;5192.117340052276;5207.6875387476875;5209.47905209476;5328.49379308965;5357.330333708286;5374.247605335335;5392.433794451526;5408.13469844823;5239.580833533384;5248.422673505987;5254.816081437131;5255.290535777621;5256.947430525645 14:30:51 INFO - PROCESS | 18998 | |1;ext.html;522.9241759944811;547.2803263708224;549.8680316723987;575.5568212476393;599.1701493431599;27515.174544763664;28332.150035498944;36041.27917441649;36259.45610815833;36321.455178172284;39654.40518392227;39692.60307396925;40039.39940900889;40142.79928600353;40183;7391.928170415286;8540.615672294762;8739.956300218522;8754.649814007433;8756.343274254425;7449.88825167623;7582.279683430065;10455.634052808153;10717.249792514527;10745.355278683264;10364;10462.633807816728;10467.424291663956;10474.738131546734;10475.68572942809;10127.240456965721;10321.58713651453;10324.225683073724;10328.328658637165;10329.948350258239;10045.34705244164;10169.135623472013;10189.032041956003;10191.286609937308;10193.59225630974;40353.39469907925;40628.187436251406;40678;40752.59247407547;40808;3392.542006829071;3457.27397246576;3561.2521370512222;3970.662493688011;4252.298370768819;29815.850920745474;30662.38675226483;31028;31080.378392432252;31082.222944426343;3911.3546264866263;4043.0903046814524;4056.9391459128137;4102.917941641181;4152.522459917118;271478.999999998;272185.78142185626;272296;272506;272637;58868.705656471444;59090;59179.40820591739;59208.7039564808;59258.70370648119;63117;63248.683756580926;63343;63489.36510634927;63495.68252158802;14618.634534136732;14861.628459288388;14872.256387180598;14956;14957.775633365509;10134.594616215269;10232.53953572091;10255.128314093387;10263.9486802567;11055.889441105486;14635.845424378742;19517.804821951882;20058;20134.19463221484;20226.494337641383;7568.810779730551;7719.92280077192;7767.922320776833;7843.215678432111;7878.251566101211;897.7486303834937;956.364017928084;1031.9742006449899;1101.3336931156534;1140.4810811080938;29193.708062919522;29825;29934.360560810434;30035.249118771768;30286.69713302883;1044.4412239451856;1070.6306324318255;1112.2714621922491;1117.2067831839322;1123.7977164110375;15300.311485983157;15669.686606267811;15687.607809804618;15791.763123553155;15948.681026379407;389822;390424;395766;395942;396751;47938;47942.760286199045;48254.346010969035;48294.27558586624;48377;1211.618340222827;1333.093496422442;1373.7252549490142;1376.4975783839027;1432.1550285331705;25619.487610247317;27479.725202748516;27839.443211135258;29091.85454072716;29689.25776855596;44694.77652611716;44753.32870006887;44959.77520112378;45064.774676126406;45153.0969380604;239578;240792;241334;242820;243044;35483.82258088693;42202.577974219865;43004.784976074916;43416.34875476934;43654.78172609117;42711.7864410676;42748.5725142757;42840.571594284906;43080.845957702615;43589.346159808265;36261.45607815832;36411.63588364189;36776.26447471089;36822.8158859204;36956.26087478289;35076.29847402986;39266.214675705756;39817;40921.38617920674;41800.79099604482;35779.56881724806;36307.27385452329;36474.635253647124;36668.63331366652;36698.082547936516;30722.231944201572;32662.673373266913;33178.17054573655;33189.66810331962;33194.170145746546;24391;25203;25229.621555676313;25269.87365063163;25553.48893022092 14:30:51 INFO - PROCESS | 18998 | |2;jquery.html;341.79663100455235;346.4906587316644;350.8368608597002;352.89413176047196;353.6145601294588;16907.070111143898;17359.392421265242;17450.301987920484;18141.90929045356;18181.454556363296;10885.401302928336;11162.553497860075;16062.83937160628;16667.583310417245;16679.166041697896;4786.066716990188;4876.609871210295;4909.950900491003;4933.1860243059855;5369.19462080689;3677.4667673187373;5220.190870415092;5424.376196737367;5438.075527160372;5448.7548060337185;5404.054290499166;5416.025115479212;5419.458054194569;5421.83734487966;5446.836594902159;3725.795081270529;5171.276021357013;5285.312909321764;5381.946180538203;5382.407935127133;5233.136532472137;5248.5538729208065;5249.580033597303;5254.474552544753;5262.921056184122;12476.126671133025;12516.624501264976;12529;15370.077795332316;19211.903940480348;2450.3751543356507;2531.1773673556168;2609.7259787722396;2816.8732407041734;2924;9610.279229057849;9688.41869487833;11414.80144584815;12804.743905121939;12913.160644558073;1819.2359209132196;1872.5505878589177;1878.0891267735137;1892.328223480672;1920.9135588898394;60870.39129608736;61045.389546104416;63632;63833.68083159601;64206;10183.236257280734;10249.436281004468;10257.17942564593;10266.58933642646;10334.793304134026;13349.799753003712;13430;13476.460941562424;13502.594922152352;13525.932370338085;7205.908315188594;7401.00086488328;7403.518771279957;7490.400767938552;7527.209642987517;7118.86434069777;7212.062431883822;7257.709691612382;7302.744403945836;7330.486865919441;4431.977840110843;4471.306947423154;4498.077894031716;4573.336866154389;4609.239475486507;1818.6544556534216;1854.17489217297;1857.58204404008;1863.3105750872264;1868.9719654205198;855.1405837133641;923.2291036984193;953.5708930981086;978.9902100978899;1012.9594816207417;16038;16445.506634800975;16651.583710407336;16928.068956207528;17056.061916594706;918.7932715139174;938.7746940734174;952.9618815247451;959.8896126945351;968.3560432312433;9218.354715169873;9508.144267015863;9540.236781057498;9659.32384733062;9716.854247186298;355406;383591;388224;388754;398367;73251.63374183096;74129;74159;74243.25756742472;75116.24883751092;990.2573070197352;1003.448103543063;1006.1749365520203;1007.7279134633608;1042.0777611813598;14830.555083347517;14857.628559286104;15070.472533461276;15088.471903483325;15447.691046179238;33243;33285.50071748974;33711;34421.65578344184;34513.30973380568;45162.09675806531;46414;46494.53505464902;46812.29781553348;47589;7850.654800629622;7863.567503787347;7864.21357864209;7884.172161922916;8089.433739638169;8573.356998225283;10795.56817727282;11749.88250117488;12439.875601243872;12540.99672026254;10039.899601003897;10057.547410366697;10406.115480183966;10426.374417534973;10663;10689.57241710354;10731.785364292826;10788.730281742704;10840.349579025284;11049.011177988039;10256.230782691178;10507.211959102944;10512.526936287732;10513.737156571147;10827.296225745302;7762.805929851799;7786.727464538714;7851.60741962911;7852.842943140991;7976.20237976221;8275;10308;10821.837672435076;10825.783484330112;11017.394043327695 14:30:51 INFO - PROCESS | 18998 | |3;mootools.html;1359.6057143428407;1461.2693653173412;1489.515907330118;1683.2173039536622;1856.8978706171156;7599.658015389307;7746.806329841756;7779.961100194499;7783.727569535054;7805.297523222902;7590.658420371083;7686.654100565474;7777.650005749741;7790.18203088676;7796.415268854845;1965.8329042031444;2260.276711452336;2260.9886950565265;2301.723793144825;2315.583195024895;2222.5777102350503;2234.72065991751;2235.1729859951843;2235.3964429604;2236.7315922089374;2199.7800219977953;2313.1094528606523;2316.3282648032136;2318.8840557972035;2321.245595181564;2258.0516183203013;2277.487565297803;2311.9768802312014;2340.6723058771786;2343.0393538649073;2282.4750307429385;2291.954160916789;2299.5171014086895;2303.309007297804;2327.522857814144;7894.723684671067;7957.641906114239;7977.880331795028;7978.60106994648;7988.920110798876;4744.928826067612;4883.316335712968;4884.120858245515;4884.755762211875;4895.6083513318845;3044.4824379855477;3113.8131712097347;3123.250419899208;3131.045031265463;3163.9367212655848;971.0677749360623;981.1562056631292;984.7439665686901;1029.3103620574234;1036.2487196782347;10960.068394186505;11006.119510439146;11010.50452729629;11014.229003969645;11027.338359698444;4343.391925130484;4494.955050449519;4536.478304994902;4569.588737013684;4579.931301030487;9299.442033477877;9352.064793520729;9367.625294988124;9373.109554592304;9373.437593744397;4422.425084738963;4961.8511444656715;4970.8757281068265;4970.8757281068265;4973.950260497349;4430.047539778899;4447.510773814878;4470.575295346936;4474.127545128734;4496.460424749051;3671.7429779915683;3762.473253744478;3774.452704357853;3791.8862434127022;3807.562130354989;1237.3998610673816;1242.8570714367784;1246.2958428487875;1252.7557126360455;1256.4534427524056;1344.4151793969654;1364.3860262881742;1364.5360577403533;1371.739369519788;1391.193107997359;7592.582407967615;7673.846523069619;7676.53940763556;7693.269139431745;7695.961520192475;471.4931448692669;482.54640637801054;487.939007624047;488.9756408468941;489.8652870460652;5767.077267637158;5769.913451298234;5772.538196944234;5815.505682016991;5817.331006934172;9288.814223715488;9795.510224488748;9907.207423406111;9910.55402506889;9931.801363972825;9568.138867501959;9683.612655493702;9683.854742178873;9719.465429401309;9736.367136136128;7201.567905925661;7632.93138960546;7646.3882889368715;7706.730264440717;7715.807104822312;7089.432845372255;7095.929040709733;7107.431405487445;7152.964235178791;7160.283971602798;8500.14998500145;8508.14918508169;8535.95732021336;8538;8603.39776215684;8511.489310641382;8928.642854285756;8944.37389382737;8974.955125224333;9079.863802043106;6175.536834737323;6999.405050570758;7066.116735408074;7247.311505406978;7494.55032698018;7676.155622881367;7691.461597688108;7691.538507689556;7708.421868359784;7737.729179478916;6772.661366931732;6883;6923.792286231421;7016.1580610325045;7087.433005359662;6813.7955861324235;6838.076859623887;6917.584944903322;6955.756548520778;6980.511364204457;7174;7277.526960747535;7279.308465695751;7299.452541059548;7309.451791115581;6639.03733958583;6724.29394913527;6752.628605426552;6752.831179220559;6768.96615516939;6517.283098859217;6527.05357723137;6562.409383155348;6626.867462650816;6635.071090047494 14:30:51 INFO - PROCESS | 18998 | |4;prototype.html;319.77455893595015;325.55561658336364;329.2936650883854;335.30758982700723;336.9595648522178;5857.941420585793;5867.178594996704;5872.882542349156;5890.057590785475;5928.1404196391495;5807.477327040566;5827.155062515943;5827.184194212814;5835.212246346742;5841.707914604263;4353.7387756734615;4382.912341753163;4504;4512.458504979407;4514.322851572274;4460.955390446086;4495.190865644199;4497.730136191839;4506.7070640408265;4512.2329204035395;4307;4442.044960333527;4448.5773851484055;4458.4204053473;4458.821647134127;4387.276099443588;4468.530804265571;4470.731756094612;4476.216662084123;4490.146872094308;3960.920781584381;3970.1861118470642;3973.8013099345208;3978.264021156095;3990.3615421532704;5568.9443105568835;5569.275994120779;5570;5570.526505247059;5583.916241256385;5193.195054766479;5193.350831146106;5195.064888320101;5196.168613021936;5205.037068142406;6101.694915254219;6106.969465152691;6109.297430795471;6111.388861113853;6119.26568811741;4117.526484454296;4240.533541310484;4246.7027308088445;4248.617624413818;4389.582989615981;6373.107764912916;6419.229692436891;6444.742210311582;6447.097406363066;6454.19322584677;4345.369921361448;4349.521552629209;4350.260455722471;4351.195028919597;4351.216780979454;4407.096545208225;4407.140607581555;4412.294032954712;4412.602865742098;4416.53626369233;5096.082705113041;5118.820841270612;5120.308758317579;5123.38519377677;5126.846194614168;6055.061465472859;6183.227096612924;6196.132541444202;6207.844803879939;6218.098375735493;1546.049179754443;1554.1918202534619;1564.0615630621537;1564.2491604030129;1565.8590726834411;985.4333758089127;1001.4742260313394;1029.0327092532996;1050.2123407444417;1055.2191378380096;5769.423057694197;5789.768409263583;5876.353601103875;5876.882462350729;5878.059510478303;6289.088082228142;6289.40250676185;6292.811215663537;6302.432781049728;6306.148669929501;5874.383189765013;5875.764969401176;5877.94122058774;5878.676672783038;5880.176775251468;3373.3590617783034;3398.8130652814334;3400.0819778659625;3404.6254911959663;3405.9659403406145;6468.805935821839;6621.106150669694;6632.8673426531195;6633;6635.402813746786;6365.427111559982;6392.20097487814;6411;6418.069379939882;6418.935810641927;6609.537332386687;6611.66941652925;6613.3056029117215;6616.172978377703;6627.10534077903;6265.4361107500545;6320.367963203643;6336.841578960563;6338.778142765165;6345.492360611048;6032.245969253843;6176.4441200292185;6190.3190649029475;6203.06953956892;6208.81373558794;6599.505037122139;6616.172978377703;6619.66901654925;6623.238327592196;6627.801165965029;4301.268784306738;4316.158349121891;4318.265894797829;4320.200762858881;4331.97834010828;6258.061290806416;6258.436740693177;6258.43674069336;6263.404976527223;6265.937340626535;6092.177556029879;6097;6099.603525770811;6100.023996160593;6101.908471373022;5932.466078052996;6021.066734656135;6077.5745697802495;6092;6094.299155597163;5933.851653708519;5973.372795856372;5978.103284507359;5982;5992.250968628921;6108.175396321618;6109.022556390956;6112;6113.57204995646;6116.938830611637;5880.382559831156;5952.077427998667;5994.130851026664;6002.549808764447;6004.549658775697 14:30:51 INFO - PROCESS | 18998 | |5;yui.html;746;762.6186906546727;765.0971853213209;818.2063398503451;832.6086739232559;13794.10338328008;13972;13991.440342386306;14014.089084209532;14039.227842468687;13466.663333416669;13592.728145437086;13617.523386681469;13642.522511712092;13685.79471307931;661.7419206509466;835.0480452284401;845.8858054162702;849.5412477262271;857.1685465098844;857.7169534053747;860.3547339495378;862.0775769926181;862.2024627219828;862.3015357560365;899.2626046641757;904.3488688144525;904.39405598249;904.398574947659;904.8009437923646;683.135833171039;872.4285592936636;888.373696543935;893.307686542928;894.0344428017758;656.4485831901226;658.6278752504867;659.3834764495165;659.5416185750905;660.6234446365573;14027.929860350734;14042.859571404257;14072.22602756848;14104.71790564183;14122.646933826634;11638.301701897914;11687.883121168765;12498.562550310786;12941.094123411365;13007.609771706864;10642.09542188915;10770.138388928866;10784.946075269652;10805;10850.72873178169;3564.8574057037686;3601.171730501973;3612.349777040132;3649.8905032848793;3744.2698673758628;50554.49445505535;50807.745961270324;51351.486485135414;51557.74221128871;51944.480555193964;10086.49567521621;10099;10147.492625368703;10186.388816671024;10265.486725663686;17678.292868285123;17806.643867122842;17836.10819459022;17851.821481785017;17863.374781882572;7592.696292148363;7728.961355193301;7752.651130699132;7857.096433910174;7943;4298.935515967263;4410.647148228134;4440.511543730187;4520.660950428731;4615.446146462446;3137.654857965622;3163.0352742413324;3166.398384306974;3175.6030496187977;3179.554862319277;441.82989549023216;589.2869627750384;591.544510726738;591.9822405327847;595.0776296740036;663.320096900671;674.6424395070522;676.1210426445699;682.6143229075557;687.7695971849387;7986.560739159402;8114.391420643357;8303.750887473385;8334.833303333899;8491.787705307417;504.5282660712246;557.6347492392489;623.7473823101651;665.5274754923961;670.6847781542667;3817.694584433294;3828.3300422425964;3838.9232215355537;3883.2815929053218;3981.044549308145;52661.47338526642;53685;53743.731281344124;54193;54210;47413.76293118512;47542;47645;48713.269300960514;48803;43913.34129988053;44170;44725;45518;45667;7915.604219788872;7941;7982.680692772224;7993.480423772437;8142.674293028213;34529;34745.65254347424;35202.47196292006;35773.64226357703;36185;41347.793261033505;43725.344119837595;44489.332660010776;44521.55478445304;44572.55427445684;11360.54557817678;11434.42827858587;11673.766524669289;11687.240329378563;11736.178467507192;11533.308001519936;12268.325242111412;12606.117571769888;12615.432305546456;12877.549285775327;11689.88310116888;11907.583234586747;12060.276383417024;12068.879311207127;12184.939075304921;11469.254498457574;12164.878351216728;12438.253704777742;12536.122471426912;12646.430910609228;10535;11078.390688511887;11095.334279943228;11421.428928553372;11423.714407139556;9979.50102494887;9980.60077596888;10044;10091.596336146471;10357.896421035693;9224;9427.811443770948;9811.241547849144;10002.549885255326;10066.345687530287 14:30:51 INFO - PROCESS | 18998 | __end_tp_report 14:30:51 INFO - PROCESS | 18998 | __start_cc_report 14:30:51 INFO - PROCESS | 18998 | _x_x_mozilla_cycle_collect,770 14:30:51 INFO - PROCESS | 18998 | __end_cc_report 14:30:51 INFO - PROCESS | 18998 | __startTimestamp1457217051300__endTimestamp 14:30:51 INFO - PROCESS | 18998 | 14:30:51 INFO - PROCESS | 18998 | ------- Summary: start ------- 14:30:51 INFO - PROCESS | 18998 | Number of tests: 6 14:30:51 INFO - PROCESS | 18998 | 14:30:51 INFO - PROCESS | 18998 | [#0] dojo.html Cycles:165 Average:5074.94 Median:5254.82 stddev:538.87 (10.3%) stddev-sans-first:518.26 14:30:51 INFO - PROCESS | 18998 | Values: 3120.5 3163.0 3206.7 3214.1 3239.4 5084.6 5106.4 5117.3 5136.6 5169.9 5100.7 5133.8 5139.3 5141.7 5177.5 4579.3 4589.7 4592.2 4660.9 4711.1 4652.7 4716.3 4718.7 4724.3 4767.9 4592.8 4636.8 4683.5 4693.5 4769.3 4681.6 4683.5 4688.1 4693.6 4730.2 4677.2 4681.4 4686.6 4691.7 4720.9 4979.7 5000.0 5016.8 5114.5 5126.1 5391.9 5396.4 5397.8 5402.3 5403.6 5402.3 5405.1 5407.6 5409.5 5442.1 5102.1 5134.9 5151.2 5210.0 5217.1 5474.8 5479.6 5485.3 5489.1 5521.4 5305.5 5307.9 5307.9 5317.6 5350.1 5469.3 5497.7 5511.2 5557.2 5567.7 5350.7 5365.6 5366.8 5375.4 5381.9 5364.5 5366.2 5397.5 5411.8 5431.8 4150.3 4168.0 4189.4 4193.6 4202.2 3741.6 3755.7 3771.6 3776.5 3803.8 4991.4 5074.7 5077.2 5125.5 5194.5 5510.3 5511.6 5531.2 5536.4 5539.4 5117.3 5180.9 5186.0 5188.4 5232.0 4597.1 4599.6 4659.9 4682.9 4683.5 5646.2 5664.3 5667.6 5673.8 5677.0 5423.9 5424.0 5425.2 5425.5 5470.8 5649.7 5691.2 5728.3 5798.4 5808.0 5368.1 5386.8 5387.2 5396.4 5396.7 5388.3 5395.4 5420.9 5428.7 5441.1 5332.8 5359.8 5374.0 5416.6 5417.6 5268.4 5268.7 5273.6 5276.7 5331.2 5131.1 5192.1 5192.1 5207.7 5209.5 5328.5 5357.3 5374.2 5392.4 5408.1 5239.6 5248.4 5254.8 5255.3 5256.9 14:30:51 INFO - PROCESS | 18998 | 14:30:51 INFO - PROCESS | 18998 | [#1] ext.html Cycles:180 Average:47439.52 Median:35280.06 stddev:81240.68 (230.3%) stddev-sans-first:81392.21 14:30:51 INFO - PROCESS | 18998 | Values: 522.9 547.3 549.9 575.6 599.2 27515.2 28332.2 36041.3 36259.5 36321.5 39654.4 39692.6 40039.4 40142.8 40183.0 7391.9 8540.6 8740.0 8754.6 8756.3 7449.9 7582.3 10455.6 10717.2 10745.4 10364.0 10462.6 10467.4 10474.7 10475.7 10127.2 10321.6 10324.2 10328.3 10329.9 10045.3 10169.1 10189.0 10191.3 10193.6 40353.4 40628.2 40678.0 40752.6 40808.0 3392.5 3457.3 3561.3 3970.7 4252.3 29815.9 30662.4 31028.0 31080.4 31082.2 3911.4 4043.1 4056.9 4102.9 4152.5 271479.0 272185.8 272296.0 272506.0 272637.0 58868.7 59090.0 59179.4 59208.7 59258.7 63117.0 63248.7 63343.0 63489.4 63495.7 14618.6 14861.6 14872.3 14956.0 14957.8 10134.6 10232.5 10255.1 10263.9 11055.9 14635.8 19517.8 20058.0 20134.2 20226.5 7568.8 7719.9 7767.9 7843.2 7878.3 897.7 956.4 1032.0 1101.3 1140.5 29193.7 29825.0 29934.4 30035.2 30286.7 1044.4 1070.6 1112.3 1117.2 1123.8 15300.3 15669.7 15687.6 15791.8 15948.7 389822.0 390424.0 395766.0 395942.0 396751.0 47938.0 47942.8 48254.3 48294.3 48377.0 1211.6 1333.1 1373.7 1376.5 1432.2 25619.5 27479.7 27839.4 29091.9 29689.3 44694.8 44753.3 44959.8 45064.8 45153.1 239578.0 240792.0 241334.0 242820.0 243044.0 35483.8 42202.6 43004.8 43416.3 43654.8 42711.8 42748.6 42840.6 43080.8 43589.3 36261.5 36411.6 36776.3 36822.8 36956.3 35076.3 39266.2 39817.0 40921.4 41800.8 35779.6 36307.3 36474.6 36668.6 36698.1 30722.2 32662.7 33178.2 33189.7 33194.2 24391.0 25203.0 25229.6 25269.9 25553.5 14:30:51 INFO - PROCESS | 18998 | 14:30:51 INFO - PROCESS | 18998 | [#2] jquery.html Cycles:180 Average:23500.21 Median:177879.81 stddev:63064.53 (35.5%) stddev-sans-first:63217.47 14:30:51 INFO - PROCESS | 18998 | Values: 341.8 346.5 350.8 352.9 353.6 16907.1 17359.4 17450.3 18141.9 18181.5 10885.4 11162.6 16062.8 16667.6 16679.2 4786.1 4876.6 4910.0 4933.2 5369.2 3677.5 5220.2 5424.4 5438.1 5448.8 5404.1 5416.0 5419.5 5421.8 5446.8 3725.8 5171.3 5285.3 5381.9 5382.4 5233.1 5248.6 5249.6 5254.5 5262.9 12476.1 12516.6 12529.0 15370.1 19211.9 2450.4 2531.2 2609.7 2816.9 2924.0 9610.3 9688.4 11414.8 12804.7 12913.2 1819.2 1872.6 1878.1 1892.3 1920.9 60870.4 61045.4 63632.0 63833.7 64206.0 10183.2 10249.4 10257.2 10266.6 10334.8 13349.8 13430.0 13476.5 13502.6 13525.9 7205.9 7401.0 7403.5 7490.4 7527.2 7118.9 7212.1 7257.7 7302.7 7330.5 4432.0 4471.3 4498.1 4573.3 4609.2 1818.7 1854.2 1857.6 1863.3 1869.0 855.1 923.2 953.6 979.0 1013.0 16038.0 16445.5 16651.6 16928.1 17056.1 918.8 938.8 953.0 959.9 968.4 9218.4 9508.1 9540.2 9659.3 9716.9 355406.0 383591.0 388224.0 388754.0 398367.0 73251.6 74129.0 74159.0 74243.3 75116.2 990.3 1003.4 1006.2 1007.7 1042.1 14830.6 14857.6 15070.5 15088.5 15447.7 33243.0 33285.5 33711.0 34421.7 34513.3 45162.1 46414.0 46494.5 46812.3 47589.0 7850.7 7863.6 7864.2 7884.2 8089.4 8573.4 10795.6 11749.9 12439.9 12541.0 10039.9 10057.5 10406.1 10426.4 10663.0 10689.6 10731.8 10788.7 10840.3 11049.0 10256.2 10507.2 10512.5 10513.7 10827.3 7762.8 7786.7 7851.6 7852.8 7976.2 8275.0 10308.0 10821.8 10825.8 11017.4 14:30:51 INFO - PROCESS | 18998 | 14:30:51 INFO - PROCESS | 18998 | [#3] mootools.html Cycles:180 Average:5569.65 Median:6594.64 stddev:2924.79 (44.4%) stddev-sans-first:2915.87 14:30:51 INFO - PROCESS | 18998 | Values: 1359.6 1461.3 1489.5 1683.2 1856.9 7599.7 7746.8 7780.0 7783.7 7805.3 7590.7 7686.7 7777.7 7790.2 7796.4 1965.8 2260.3 2261.0 2301.7 2315.6 2222.6 2234.7 2235.2 2235.4 2236.7 2199.8 2313.1 2316.3 2318.9 2321.2 2258.1 2277.5 2312.0 2340.7 2343.0 2282.5 2292.0 2299.5 2303.3 2327.5 7894.7 7957.6 7977.9 7978.6 7988.9 4744.9 4883.3 4884.1 4884.8 4895.6 3044.5 3113.8 3123.3 3131.0 3163.9 971.1 981.2 984.7 1029.3 1036.2 10960.1 11006.1 11010.5 11014.2 11027.3 4343.4 4495.0 4536.5 4569.6 4579.9 9299.4 9352.1 9367.6 9373.1 9373.4 4422.4 4961.9 4970.9 4970.9 4974.0 4430.0 4447.5 4470.6 4474.1 4496.5 3671.7 3762.5 3774.5 3791.9 3807.6 1237.4 1242.9 1246.3 1252.8 1256.5 1344.4 1364.4 1364.5 1371.7 1391.2 7592.6 7673.8 7676.5 7693.3 7696.0 471.5 482.5 487.9 489.0 489.9 5767.1 5769.9 5772.5 5815.5 5817.3 9288.8 9795.5 9907.2 9910.6 9931.8 9568.1 9683.6 9683.9 9719.5 9736.4 7201.6 7632.9 7646.4 7706.7 7715.8 7089.4 7095.9 7107.4 7153.0 7160.3 8500.1 8508.1 8536.0 8538.0 8603.4 8511.5 8928.6 8944.4 8975.0 9079.9 6175.5 6999.4 7066.1 7247.3 7494.6 7676.2 7691.5 7691.5 7708.4 7737.7 6772.7 6883.0 6923.8 7016.2 7087.4 6813.8 6838.1 6917.6 6955.8 6980.5 7174.0 7277.5 7279.3 7299.5 7309.5 6639.0 6724.3 6752.6 6752.8 6769.0 6517.3 6527.1 6562.4 6626.9 6635.1 14:30:51 INFO - PROCESS | 18998 | 14:30:51 INFO - PROCESS | 18998 | [#4] prototype.html Cycles:180 Average:5136.87 Median:5876.06 stddev:1540.10 (26.2%) stddev-sans-first:1501.38 14:30:51 INFO - PROCESS | 18998 | Values: 319.8 325.6 329.3 335.3 337.0 5857.9 5867.2 5872.9 5890.1 5928.1 5807.5 5827.2 5827.2 5835.2 5841.7 4353.7 4382.9 4504.0 4512.5 4514.3 4461.0 4495.2 4497.7 4506.7 4512.2 4307.0 4442.0 4448.6 4458.4 4458.8 4387.3 4468.5 4470.7 4476.2 4490.1 3960.9 3970.2 3973.8 3978.3 3990.4 5568.9 5569.3 5570.0 5570.5 5583.9 5193.2 5193.4 5195.1 5196.2 5205.0 6101.7 6107.0 6109.3 6111.4 6119.3 4117.5 4240.5 4246.7 4248.6 4389.6 6373.1 6419.2 6444.7 6447.1 6454.2 4345.4 4349.5 4350.3 4351.2 4351.2 4407.1 4407.1 4412.3 4412.6 4416.5 5096.1 5118.8 5120.3 5123.4 5126.8 6055.1 6183.2 6196.1 6207.8 6218.1 1546.0 1554.2 1564.1 1564.2 1565.9 985.4 1001.5 1029.0 1050.2 1055.2 5769.4 5789.8 5876.4 5876.9 5878.1 6289.1 6289.4 6292.8 6302.4 6306.1 5874.4 5875.8 5877.9 5878.7 5880.2 3373.4 3398.8 3400.1 3404.6 3406.0 6468.8 6621.1 6632.9 6633.0 6635.4 6365.4 6392.2 6411.0 6418.1 6418.9 6609.5 6611.7 6613.3 6616.2 6627.1 6265.4 6320.4 6336.8 6338.8 6345.5 6032.2 6176.4 6190.3 6203.1 6208.8 6599.5 6616.2 6619.7 6623.2 6627.8 4301.3 4316.2 4318.3 4320.2 4332.0 6258.1 6258.4 6258.4 6263.4 6265.9 6092.2 6097.0 6099.6 6100.0 6101.9 5932.5 6021.1 6077.6 6092.0 6094.3 5933.9 5973.4 5978.1 5982.0 5992.3 6108.2 6109.0 6112.0 6113.6 6116.9 5880.4 5952.1 5994.1 6002.5 6004.5 14:30:51 INFO - PROCESS | 18998 | 14:30:51 INFO - PROCESS | 18998 | [#5] yui.html Cycles:180 Average:13734.97 Median:24290.32 stddev:15513.77 (63.9%) stddev-sans-first:15526.62 14:30:51 INFO - PROCESS | 18998 | Values: 746.0 762.6 765.1 818.2 832.6 13794.1 13972.0 13991.4 14014.1 14039.2 13466.7 13592.7 13617.5 13642.5 13685.8 661.7 835.0 845.9 849.5 857.2 857.7 860.4 862.1 862.2 862.3 899.3 904.3 904.4 904.4 904.8 683.1 872.4 888.4 893.3 894.0 656.4 658.6 659.4 659.5 660.6 14027.9 14042.9 14072.2 14104.7 14122.6 11638.3 11687.9 12498.6 12941.1 13007.6 10642.1 10770.1 10784.9 10805.0 10850.7 3564.9 3601.2 3612.3 3649.9 3744.3 50554.5 50807.7 51351.5 51557.7 51944.5 10086.5 10099.0 10147.5 10186.4 10265.5 17678.3 17806.6 17836.1 17851.8 17863.4 7592.7 7729.0 7752.7 7857.1 7943.0 4298.9 4410.6 4440.5 4520.7 4615.4 3137.7 3163.0 3166.4 3175.6 3179.6 441.8 589.3 591.5 592.0 595.1 663.3 674.6 676.1 682.6 687.8 7986.6 8114.4 8303.8 8334.8 8491.8 504.5 557.6 623.7 665.5 670.7 3817.7 3828.3 3838.9 3883.3 3981.0 52661.5 53685.0 53743.7 54193.0 54210.0 47413.8 47542.0 47645.0 48713.3 48803.0 43913.3 44170.0 44725.0 45518.0 45667.0 7915.6 7941.0 7982.7 7993.5 8142.7 34529.0 34745.7 35202.5 35773.6 36185.0 41347.8 43725.3 44489.3 44521.6 44572.6 11360.5 11434.4 11673.8 11687.2 11736.2 11533.3 12268.3 12606.1 12615.4 12877.5 11689.9 11907.6 12060.3 12068.9 12184.9 11469.3 12164.9 12438.3 12536.1 12646.4 10535.0 11078.4 11095.3 11421.4 11423.7 9979.5 9980.6 10044.0 10091.6 10357.9 9224.0 9427.8 9811.2 10002.5 10066.3 14:30:51 INFO - PROCESS | 18998 | -------- Summary: end -------- 14:30:51 INFO - PROCESS | 18998 | 14:30:52 INFO - TEST-INFO | 18998: exit 0 14:30:52 INFO - TEST-OK | dromaeo_css | took 1112299ms 14:30:52 INFO - TEST-START | kraken 14:30:52 INFO - operating with platform_type : linux_ 14:30:52 INFO - Initialising browser for kraken test... 14:30:52 INFO - TEST-INFO | started process 19184 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_p6JwQ/profile http://localhost:43374/getInfo.html) 14:30:55 INFO - PROCESS | 19184 | __metrics Screen width/height:1600/1200 14:30:55 INFO - PROCESS | 19184 | colorDepth:24 14:30:55 INFO - PROCESS | 19184 | Browser inner width/height: 1024/697 14:30:55 INFO - PROCESS | 19184 | __metrics 14:30:56 INFO - PROCESS | 19184 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:30:56 INFO - PROCESS | 19184 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 14:30:57 INFO - TEST-INFO | 19184: exit 0 14:30:57 INFO - Browser initialized. 14:30:57 INFO - Running cycle 1/1 for kraken test... 14:30:57 INFO - TEST-INFO | started process 19271 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_p6JwQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:08 INFO - PROCESS | 19271 | RSS: Main: 155271168 14:31:08 INFO - PROCESS | 19271 | 14:31:11 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43374/tests/kraken/driver.html?testName=audio-beat-detection) 14:31:12 INFO - PROCESS | 19271 | RSS: Main: 201105408 14:31:12 INFO - PROCESS | 19271 | 14:31:14 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43374/tests/kraken/driver.html?testName=audio-dft) 14:31:15 INFO - PROCESS | 19271 | RSS: Main: 188686336 14:31:15 INFO - PROCESS | 19271 | 14:31:18 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43374/tests/kraken/driver.html?testName=audio-fft) 14:31:18 INFO - PROCESS | 19271 | RSS: Main: 172085248 14:31:18 INFO - PROCESS | 19271 | 14:31:20 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43374/tests/kraken/driver.html?testName=audio-oscillator) 14:31:21 INFO - PROCESS | 19271 | RSS: Main: 173604864 14:31:21 INFO - PROCESS | 19271 | 14:31:23 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:31:24 INFO - PROCESS | 19271 | RSS: Main: 176623616 14:31:24 INFO - PROCESS | 19271 | 14:31:27 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43374/tests/kraken/driver.html?testName=imaging-darkroom) 14:31:27 INFO - PROCESS | 19271 | RSS: Main: 176676864 14:31:27 INFO - PROCESS | 19271 | 14:31:31 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43374/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:31 INFO - PROCESS | 19271 | RSS: Main: 176852992 14:31:31 INFO - PROCESS | 19271 | 14:31:34 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43374/tests/kraken/driver.html?testName=json-parse-financial) 14:31:35 INFO - PROCESS | 19271 | RSS: Main: 175972352 14:31:35 INFO - PROCESS | 19271 | 14:31:36 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:37 INFO - PROCESS | 19271 | RSS: Main: 187617280 14:31:37 INFO - PROCESS | 19271 | 14:31:39 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43374/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:39 INFO - PROCESS | 19271 | RSS: Main: 184156160 14:31:39 INFO - PROCESS | 19271 | 14:31:41 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:42 INFO - PROCESS | 19271 | RSS: Main: 196624384 14:31:42 INFO - PROCESS | 19271 | 14:31:44 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:45 INFO - PROCESS | 19271 | RSS: Main: 203984896 14:31:45 INFO - PROCESS | 19271 | 14:31:47 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:48 INFO - PROCESS | 19271 | RSS: Main: 202072064 14:31:48 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | Cycle 1(1): loaded http://localhost:43374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43374/tests/kraken/driver.html?testName=ai-astar) 14:31:50 INFO - PROCESS | 19271 | RSS: Main: 261787648 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | __start_tp_report 14:31:50 INFO - PROCESS | 19271 | _x_x_mozilla_page_load 14:31:50 INFO - PROCESS | 19271 | _x_x_mozilla_page_load_details 14:31:50 INFO - PROCESS | 19271 | |i|pagename|runs| 14:31:50 INFO - PROCESS | 19271 | |0;ai-astar;110;110;104;109;110;109;99;110;108;108 14:31:50 INFO - PROCESS | 19271 | |1;audio-beat-detection;165;128;151;164;128;154;150;130;174;127 14:31:50 INFO - PROCESS | 19271 | |2;audio-dft;161;160;160;159;161;162;159;163;161;161 14:31:50 INFO - PROCESS | 19271 | |3;audio-fft;74;71;116;93;76;72;77;124;99;72 14:31:50 INFO - PROCESS | 19271 | |4;audio-oscillator;94;93;138;93;93;99;152;92;93;145 14:31:50 INFO - PROCESS | 19271 | |5;imaging-gaussian-blur;117;117;116;117;117;118;117;117;117;116 14:31:50 INFO - PROCESS | 19271 | |6;imaging-darkroom;146;146;146;145;145;146;146;145;146;146 14:31:50 INFO - PROCESS | 19271 | |7;imaging-desaturate;96;96;96;96;95;95;96;96;96;95 14:31:50 INFO - PROCESS | 19271 | |8;json-parse-financial;58;57;57;56;56;57;56;66;53;56 14:31:50 INFO - PROCESS | 19271 | |9;json-stringify-tinderbox;67;68;66;66;67;67;69;66;67;66 14:31:50 INFO - PROCESS | 19271 | |10;stanford-crypto-aes;80;80;81;83;82;82;81;82;81;82 14:31:50 INFO - PROCESS | 19271 | |11;stanford-crypto-ccm;116;116;114;115;124;113;119;126;115;114 14:31:50 INFO - PROCESS | 19271 | |12;stanford-crypto-pbkdf2;160;140;145;150;161;140;151;147;149;149 14:31:50 INFO - PROCESS | 19271 | |13;stanford-crypto-sha256-iterative;71;72;71;69;68;71;71;68;67;69 14:31:50 INFO - PROCESS | 19271 | __end_tp_report 14:31:50 INFO - PROCESS | 19271 | __start_cc_report 14:31:50 INFO - PROCESS | 19271 | _x_x_mozilla_cycle_collect,1115 14:31:50 INFO - PROCESS | 19271 | __end_cc_report 14:31:50 INFO - PROCESS | 19271 | __startTimestamp1457217110338__endTimestamp 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | ------- Summary: start ------- 14:31:50 INFO - PROCESS | 19271 | Number of tests: 14 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#0] ai-astar Cycles:10 Average:107.70 Median:110.00 stddev:3.56 (3.2%) stddev-sans-first:3.68 14:31:50 INFO - PROCESS | 19271 | Values: 110.0 110.0 104.0 109.0 110.0 109.0 99.0 110.0 108.0 108.0 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:152.50 stddev:17.72 (11.6%) stddev-sans-first:17.57 14:31:50 INFO - PROCESS | 19271 | Values: 165.0 128.0 151.0 164.0 128.0 154.0 150.0 130.0 174.0 127.0 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 14:31:50 INFO - PROCESS | 19271 | Values: 161.0 160.0 160.0 159.0 161.0 162.0 159.0 163.0 161.0 161.0 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#3] audio-fft Cycles:10 Average:87.40 Median:75.00 stddev:19.68 (26.2%) stddev-sans-first:20.26 14:31:50 INFO - PROCESS | 19271 | Values: 74.0 71.0 116.0 93.0 76.0 72.0 77.0 124.0 99.0 72.0 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:93.00 stddev:25.00 (26.9%) stddev-sans-first:25.90 14:31:50 INFO - PROCESS | 19271 | Values: 94.0 93.0 138.0 93.0 93.0 99.0 152.0 92.0 93.0 145.0 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:31:50 INFO - PROCESS | 19271 | Values: 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 14:31:50 INFO - PROCESS | 19271 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:31:50 INFO - PROCESS | 19271 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:3.36 (5.9%) stddev-sans-first:3.55 14:31:50 INFO - PROCESS | 19271 | Values: 58.0 57.0 57.0 56.0 56.0 57.0 56.0 66.0 53.0 56.0 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 14:31:50 INFO - PROCESS | 19271 | Values: 67.0 68.0 66.0 66.0 67.0 67.0 69.0 66.0 67.0 66.0 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:82.00 stddev:0.97 (1.2%) stddev-sans-first:0.88 14:31:50 INFO - PROCESS | 19271 | Values: 80.0 80.0 81.0 83.0 82.0 82.0 81.0 82.0 81.0 82.0 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:116.00 stddev:4.44 (3.8%) stddev-sans-first:4.69 14:31:50 INFO - PROCESS | 19271 | Values: 116.0 116.0 114.0 115.0 124.0 113.0 119.0 126.0 115.0 114.0 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:149.50 stddev:7.08 (4.7%) stddev-sans-first:6.34 14:31:50 INFO - PROCESS | 19271 | Values: 160.0 140.0 145.0 150.0 161.0 140.0 151.0 147.0 149.0 149.0 14:31:50 INFO - PROCESS | 19271 | 14:31:50 INFO - PROCESS | 19271 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:71.00 stddev:1.70 (2.4%) stddev-sans-first:1.74 14:31:50 INFO - PROCESS | 19271 | Values: 71.0 72.0 71.0 69.0 68.0 71.0 71.0 68.0 67.0 69.0 14:31:50 INFO - PROCESS | 19271 | -------- Summary: end -------- 14:31:50 INFO - PROCESS | 19271 | 14:31:51 INFO - TEST-INFO | 19271: exit 0 14:31:51 INFO - TEST-OK | kraken | took 59243ms 14:31:51 INFO - SUITE-END | took 1171s 14:31:51 INFO - Completed test suite (00:19:31) 14:31:51 INFO - javascript benchmark 14:31:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3120.4539205639007, 3163.0, 3206.711395974362, 3214.083986063972, 3239.352129574085, 5084.618653600985, 5106.41276253231, 5117.257997590352, 5136.640435169535, 5169.948300516999, 5100.693958362492, 5133.82031628893, 5139.306193663854, 5141.717205553693, 5177.508136727005, 4579.335996280537, 4589.747563883985, 4592.242280023792, 4660.883477913046, 4711.104890070876, 4652.74409907455, 4716.339712440261, 4718.693284936486, 4724.338592597039, 4767.928481072787, 4592.839250626229, 4636.768161591941, 4683.508231635663, 4693.460252071004, 4769.308450274691, 4681.602063824579, 4683.531646835323, 4688.062387522509, 4693.577578017961, 4730.195866702635, 4677.204875171229, 4681.438227412698, 4686.578207961265, 4691.7184968901975, 4720.905581888343, 4979.701217926936, 5000.0, 5016.799328026875, 5114.539691427753, 5126.128558145124, 5391.919121213185, 5396.379416367129, 5397.784088636489, 5402.297701298845, 5403.621746477748, 5402.297701298806, 5405.108157154064, 5407.594430417695, 5409.540189083933, 5442.102053161224, 5102.081625307444, 5134.871628209287, 5151.201563757623, 5210.036143313461, 5217.113090774577, 5474.753636086386, 5479.6164268500825, 5485.286912701324, 5489.094299440628, 5521.365043020024, 5305.469453054741, 5307.867303317448, 5307.946920530822, 5317.574594032545, 5350.143976963667, 5469.343678758574, 5497.725113744297, 5511.22842802008, 5557.221988921554, 5567.721613919288, 5350.732463376816, 5365.570754339644, 5366.758495867617, 5375.354957405137, 5381.919271210935, 5364.463553644682, 5366.221897824794, 5397.514223719884, 5411.78352865881, 5431.755570999315, 4150.294449943517, 4167.97916010418, 4189.392538081961, 4193.601607847249, 4202.180574787948, 3741.6071312511795, 3755.6807671347697, 3771.6039815819495, 3776.4712940188397, 3803.771773693532, 4991.401031876126, 5074.746262686851, 5077.1876499759865, 5125.461826508237, 5194.532492075656, 5510.283663123768, 5511.58663100269, 5531.170324451284, 5536.363318218457, 5539.446055394428, 5117.257997590328, 5180.922286165711, 5186.0, 5188.377394712658, 5231.95360927816, 4597.080583883237, 4599.632029437637, 4659.906801863944, 4682.929756053662, 4683.461401938821, 5646.2377579027125, 5664.291963504562, 5667.574931880125, 5673.8297851064535, 5677.034904066319, 5423.864403389947, 5423.972880135574, 5425.213344065168, 5425.538829199562, 5470.835874923759, 5649.661020338793, 5691.203231547669, 5728.312602487562, 5798.449147330997, 5808.041673124057, 5368.141097424549, 5386.811461598825, 5387.191921211849, 5396.406395296436, 5396.703181325065, 5388.326459192601, 5395.406505284494, 5420.9186862197885, 5428.70142142186, 5441.102218133963, 5332.840014799563, 5359.812406565751, 5373.9731301343245, 5416.593755468277, 5417.6478528895495, 5268.367795864521, 5268.6575372600655, 5273.551748101301, 5276.657017293864, 5331.226972088948, 5131.076406246912, 5192.091384007859, 5192.117340052276, 5207.6875387476875, 5209.47905209476, 5328.49379308965, 5357.330333708286, 5374.247605335335, 5392.433794451526, 5408.13469844823, 5239.580833533384, 5248.422673505987, 5254.816081437131, 5255.290535777621, 5256.947430525645], "unit": "score", "name": "dojo.html", "value": 5041.865381231039}, {"lowerIsBetter": false, "replicates": [522.9241759944811, 547.2803263708224, 549.8680316723987, 575.5568212476393, 599.1701493431599, 27515.174544763664, 28332.150035498944, 36041.27917441649, 36259.45610815833, 36321.455178172284, 39654.40518392227, 39692.60307396925, 40039.39940900889, 40142.79928600353, 40183.0, 7391.928170415286, 8540.615672294762, 8739.956300218522, 8754.649814007433, 8756.343274254425, 7449.88825167623, 7582.279683430065, 10455.634052808153, 10717.249792514527, 10745.355278683264, 10364.0, 10462.633807816728, 10467.424291663956, 10474.738131546734, 10475.68572942809, 10127.240456965721, 10321.58713651453, 10324.225683073724, 10328.328658637165, 10329.948350258239, 10045.34705244164, 10169.135623472013, 10189.032041956003, 10191.286609937308, 10193.59225630974, 40353.39469907925, 40628.187436251406, 40678.0, 40752.59247407547, 40808.0, 3392.542006829071, 3457.27397246576, 3561.2521370512222, 3970.662493688011, 4252.298370768819, 29815.850920745474, 30662.38675226483, 31028.0, 31080.378392432252, 31082.222944426343, 3911.3546264866263, 4043.0903046814524, 4056.9391459128137, 4102.917941641181, 4152.522459917118, 271478.999999998, 272185.78142185626, 272296.0, 272506.0, 272637.0, 58868.705656471444, 59090.0, 59179.40820591739, 59208.7039564808, 59258.70370648119, 63117.0, 63248.683756580926, 63343.0, 63489.36510634927, 63495.68252158802, 14618.634534136732, 14861.628459288388, 14872.256387180598, 14956.0, 14957.775633365509, 10134.594616215269, 10232.53953572091, 10255.128314093387, 10263.9486802567, 11055.889441105486, 14635.845424378742, 19517.804821951882, 20058.0, 20134.19463221484, 20226.494337641383, 7568.810779730551, 7719.92280077192, 7767.922320776833, 7843.215678432111, 7878.251566101211, 897.7486303834937, 956.364017928084, 1031.9742006449899, 1101.3336931156534, 1140.4810811080938, 29193.708062919522, 29825.0, 29934.360560810434, 30035.249118771768, 30286.69713302883, 1044.4412239451856, 1070.6306324318255, 1112.2714621922491, 1117.2067831839322, 1123.7977164110375, 15300.311485983157, 15669.686606267811, 15687.607809804618, 15791.763123553155, 15948.681026379407, 389822.0, 390424.0, 395766.0, 395942.0, 396751.0, 47938.0, 47942.760286199045, 48254.346010969035, 48294.27558586624, 48377.0, 1211.618340222827, 1333.093496422442, 1373.7252549490142, 1376.4975783839027, 1432.1550285331705, 25619.487610247317, 27479.725202748516, 27839.443211135258, 29091.85454072716, 29689.25776855596, 44694.77652611716, 44753.32870006887, 44959.77520112378, 45064.774676126406, 45153.0969380604, 239578.0, 240792.0, 241334.0, 242820.0, 243044.0, 35483.82258088693, 42202.577974219865, 43004.784976074916, 43416.34875476934, 43654.78172609117, 42711.7864410676, 42748.5725142757, 42840.571594284906, 43080.845957702615, 43589.346159808265, 36261.45607815832, 36411.63588364189, 36776.26447471089, 36822.8158859204, 36956.26087478289, 35076.29847402986, 39266.214675705756, 39817.0, 40921.38617920674, 41800.79099604482, 35779.56881724806, 36307.27385452329, 36474.635253647124, 36668.63331366652, 36698.082547936516, 30722.231944201572, 32662.673373266913, 33178.17054573655, 33189.66810331962, 33194.170145746546, 24391.0, 25203.0, 25229.621555676313, 25269.87365063163, 25553.48893022092], "unit": "score", "name": "ext.html", "value": 18882.136839327915}, {"lowerIsBetter": false, "replicates": [341.79663100455235, 346.4906587316644, 350.8368608597002, 352.89413176047196, 353.6145601294588, 16907.070111143898, 17359.392421265242, 17450.301987920484, 18141.90929045356, 18181.454556363296, 10885.401302928336, 11162.553497860075, 16062.83937160628, 16667.583310417245, 16679.166041697896, 4786.066716990188, 4876.609871210295, 4909.950900491003, 4933.1860243059855, 5369.19462080689, 3677.4667673187373, 5220.190870415092, 5424.376196737367, 5438.075527160372, 5448.7548060337185, 5404.054290499166, 5416.025115479212, 5419.458054194569, 5421.83734487966, 5446.836594902159, 3725.795081270529, 5171.276021357013, 5285.312909321764, 5381.946180538203, 5382.407935127133, 5233.136532472137, 5248.5538729208065, 5249.580033597303, 5254.474552544753, 5262.921056184122, 12476.126671133025, 12516.624501264976, 12529.0, 15370.077795332316, 19211.903940480348, 2450.3751543356507, 2531.1773673556168, 2609.7259787722396, 2816.8732407041734, 2924.0, 9610.279229057849, 9688.41869487833, 11414.80144584815, 12804.743905121939, 12913.160644558073, 1819.2359209132196, 1872.5505878589177, 1878.0891267735137, 1892.328223480672, 1920.9135588898394, 60870.39129608736, 61045.389546104416, 63632.0, 63833.68083159601, 64206.0, 10183.236257280734, 10249.436281004468, 10257.17942564593, 10266.58933642646, 10334.793304134026, 13349.799753003712, 13430.0, 13476.460941562424, 13502.594922152352, 13525.932370338085, 7205.908315188594, 7401.00086488328, 7403.518771279957, 7490.400767938552, 7527.209642987517, 7118.86434069777, 7212.062431883822, 7257.709691612382, 7302.744403945836, 7330.486865919441, 4431.977840110843, 4471.306947423154, 4498.077894031716, 4573.336866154389, 4609.239475486507, 1818.6544556534216, 1854.17489217297, 1857.58204404008, 1863.3105750872264, 1868.9719654205198, 855.1405837133641, 923.2291036984193, 953.5708930981086, 978.9902100978899, 1012.9594816207417, 16038.0, 16445.506634800975, 16651.583710407336, 16928.068956207528, 17056.061916594706, 918.7932715139174, 938.7746940734174, 952.9618815247451, 959.8896126945351, 968.3560432312433, 9218.354715169873, 9508.144267015863, 9540.236781057498, 9659.32384733062, 9716.854247186298, 355406.0, 383591.0, 388224.0, 388754.0, 398367.0, 73251.63374183096, 74129.0, 74159.0, 74243.25756742472, 75116.24883751092, 990.2573070197352, 1003.448103543063, 1006.1749365520203, 1007.7279134633608, 1042.0777611813598, 14830.555083347517, 14857.628559286104, 15070.472533461276, 15088.471903483325, 15447.691046179238, 33243.0, 33285.50071748974, 33711.0, 34421.65578344184, 34513.30973380568, 45162.09675806531, 46414.0, 46494.53505464902, 46812.29781553348, 47589.0, 7850.654800629622, 7863.567503787347, 7864.21357864209, 7884.172161922916, 8089.433739638169, 8573.356998225283, 10795.56817727282, 11749.88250117488, 12439.875601243872, 12540.99672026254, 10039.899601003897, 10057.547410366697, 10406.115480183966, 10426.374417534973, 10663.0, 10689.57241710354, 10731.785364292826, 10788.730281742704, 10840.349579025284, 11049.011177988039, 10256.230782691178, 10507.211959102944, 10512.526936287732, 10513.737156571147, 10827.296225745302, 7762.805929851799, 7786.727464538714, 7851.60741962911, 7852.842943140991, 7976.20237976221, 8275.0, 10308.0, 10821.837672435076, 10825.783484330112, 11017.394043327695], "unit": "score", "name": "jquery.html", "value": 8204.562360482112}, {"lowerIsBetter": false, "replicates": [1359.6057143428407, 1461.2693653173412, 1489.515907330118, 1683.2173039536622, 1856.8978706171156, 7599.658015389307, 7746.806329841756, 7779.961100194499, 7783.727569535054, 7805.297523222902, 7590.658420371083, 7686.654100565474, 7777.650005749741, 7790.18203088676, 7796.415268854845, 1965.8329042031444, 2260.276711452336, 2260.9886950565265, 2301.723793144825, 2315.583195024895, 2222.5777102350503, 2234.72065991751, 2235.1729859951843, 2235.3964429604, 2236.7315922089374, 2199.7800219977953, 2313.1094528606523, 2316.3282648032136, 2318.8840557972035, 2321.245595181564, 2258.0516183203013, 2277.487565297803, 2311.9768802312014, 2340.6723058771786, 2343.0393538649073, 2282.4750307429385, 2291.954160916789, 2299.5171014086895, 2303.309007297804, 2327.522857814144, 7894.723684671067, 7957.641906114239, 7977.880331795028, 7978.60106994648, 7988.920110798876, 4744.928826067612, 4883.316335712968, 4884.120858245515, 4884.755762211875, 4895.6083513318845, 3044.4824379855477, 3113.8131712097347, 3123.250419899208, 3131.045031265463, 3163.9367212655848, 971.0677749360623, 981.1562056631292, 984.7439665686901, 1029.3103620574234, 1036.2487196782347, 10960.068394186505, 11006.119510439146, 11010.50452729629, 11014.229003969645, 11027.338359698444, 4343.391925130484, 4494.955050449519, 4536.478304994902, 4569.588737013684, 4579.931301030487, 9299.442033477877, 9352.064793520729, 9367.625294988124, 9373.109554592304, 9373.437593744397, 4422.425084738963, 4961.8511444656715, 4970.8757281068265, 4970.8757281068265, 4973.950260497349, 4430.047539778899, 4447.510773814878, 4470.575295346936, 4474.127545128734, 4496.460424749051, 3671.7429779915683, 3762.473253744478, 3774.452704357853, 3791.8862434127022, 3807.562130354989, 1237.3998610673816, 1242.8570714367784, 1246.2958428487875, 1252.7557126360455, 1256.4534427524056, 1344.4151793969654, 1364.3860262881742, 1364.5360577403533, 1371.739369519788, 1391.193107997359, 7592.582407967615, 7673.846523069619, 7676.53940763556, 7693.269139431745, 7695.961520192475, 471.4931448692669, 482.54640637801054, 487.939007624047, 488.9756408468941, 489.8652870460652, 5767.077267637158, 5769.913451298234, 5772.538196944234, 5815.505682016991, 5817.331006934172, 9288.814223715488, 9795.510224488748, 9907.207423406111, 9910.55402506889, 9931.801363972825, 9568.138867501959, 9683.612655493702, 9683.854742178873, 9719.465429401309, 9736.367136136128, 7201.567905925661, 7632.93138960546, 7646.3882889368715, 7706.730264440717, 7715.807104822312, 7089.432845372255, 7095.929040709733, 7107.431405487445, 7152.964235178791, 7160.283971602798, 8500.14998500145, 8508.14918508169, 8535.95732021336, 8538.0, 8603.39776215684, 8511.489310641382, 8928.642854285756, 8944.37389382737, 8974.955125224333, 9079.863802043106, 6175.536834737323, 6999.405050570758, 7066.116735408074, 7247.311505406978, 7494.55032698018, 7676.155622881367, 7691.461597688108, 7691.538507689556, 7708.421868359784, 7737.729179478916, 6772.661366931732, 6883.0, 6923.792286231421, 7016.1580610325045, 7087.433005359662, 6813.7955861324235, 6838.076859623887, 6917.584944903322, 6955.756548520778, 6980.511364204457, 7174.0, 7277.526960747535, 7279.308465695751, 7299.452541059548, 7309.451791115581, 6639.03733958583, 6724.29394913527, 6752.628605426552, 6752.831179220559, 6768.96615516939, 6517.283098859217, 6527.05357723137, 6562.409383155348, 6626.867462650816, 6635.071090047494], "unit": "score", "name": "mootools.html", "value": 4491.082309517554}, {"lowerIsBetter": false, "replicates": [319.77455893595015, 325.55561658336364, 329.2936650883854, 335.30758982700723, 336.9595648522178, 5857.941420585793, 5867.178594996704, 5872.882542349156, 5890.057590785475, 5928.1404196391495, 5807.477327040566, 5827.155062515943, 5827.184194212814, 5835.212246346742, 5841.707914604263, 4353.7387756734615, 4382.912341753163, 4504.0, 4512.458504979407, 4514.322851572274, 4460.955390446086, 4495.190865644199, 4497.730136191839, 4506.7070640408265, 4512.2329204035395, 4307.0, 4442.044960333527, 4448.5773851484055, 4458.4204053473, 4458.821647134127, 4387.276099443588, 4468.530804265571, 4470.731756094612, 4476.216662084123, 4490.146872094308, 3960.920781584381, 3970.1861118470642, 3973.8013099345208, 3978.264021156095, 3990.3615421532704, 5568.9443105568835, 5569.275994120779, 5570.0, 5570.526505247059, 5583.916241256385, 5193.195054766479, 5193.350831146106, 5195.064888320101, 5196.168613021936, 5205.037068142406, 6101.694915254219, 6106.969465152691, 6109.297430795471, 6111.388861113853, 6119.26568811741, 4117.526484454296, 4240.533541310484, 4246.7027308088445, 4248.617624413818, 4389.582989615981, 6373.107764912916, 6419.229692436891, 6444.742210311582, 6447.097406363066, 6454.19322584677, 4345.369921361448, 4349.521552629209, 4350.260455722471, 4351.195028919597, 4351.216780979454, 4407.096545208225, 4407.140607581555, 4412.294032954712, 4412.602865742098, 4416.53626369233, 5096.082705113041, 5118.820841270612, 5120.308758317579, 5123.38519377677, 5126.846194614168, 6055.061465472859, 6183.227096612924, 6196.132541444202, 6207.844803879939, 6218.098375735493, 1546.049179754443, 1554.1918202534619, 1564.0615630621537, 1564.2491604030129, 1565.8590726834411, 985.4333758089127, 1001.4742260313394, 1029.0327092532996, 1050.2123407444417, 1055.2191378380096, 5769.423057694197, 5789.768409263583, 5876.353601103875, 5876.882462350729, 5878.059510478303, 6289.088082228142, 6289.40250676185, 6292.811215663537, 6302.432781049728, 6306.148669929501, 5874.383189765013, 5875.764969401176, 5877.94122058774, 5878.676672783038, 5880.176775251468, 3373.3590617783034, 3398.8130652814334, 3400.0819778659625, 3404.6254911959663, 3405.9659403406145, 6468.805935821839, 6621.106150669694, 6632.8673426531195, 6633.0, 6635.402813746786, 6365.427111559982, 6392.20097487814, 6411.0, 6418.069379939882, 6418.935810641927, 6609.537332386687, 6611.66941652925, 6613.3056029117215, 6616.172978377703, 6627.10534077903, 6265.4361107500545, 6320.367963203643, 6336.841578960563, 6338.778142765165, 6345.492360611048, 6032.245969253843, 6176.4441200292185, 6190.3190649029475, 6203.06953956892, 6208.81373558794, 6599.505037122139, 6616.172978377703, 6619.66901654925, 6623.238327592196, 6627.801165965029, 4301.268784306738, 4316.158349121891, 4318.265894797829, 4320.200762858881, 4331.97834010828, 6258.061290806416, 6258.436740693177, 6258.43674069336, 6263.404976527223, 6265.937340626535, 6092.177556029879, 6097.0, 6099.603525770811, 6100.023996160593, 6101.908471373022, 5932.466078052996, 6021.066734656135, 6077.5745697802495, 6092.0, 6094.299155597163, 5933.851653708519, 5973.372795856372, 5978.103284507359, 5982.0, 5992.250968628921, 6108.175396321618, 6109.022556390956, 6112.0, 6113.57204995646, 6116.938830611637, 5880.382559831156, 5952.077427998667, 5994.130851026664, 6002.549808764447, 6004.549658775697], "unit": "score", "name": "prototype.html", "value": 4635.338273484035}, {"lowerIsBetter": false, "replicates": [746.0, 762.6186906546727, 765.0971853213209, 818.2063398503451, 832.6086739232559, 13794.10338328008, 13972.0, 13991.440342386306, 14014.089084209532, 14039.227842468687, 13466.663333416669, 13592.728145437086, 13617.523386681469, 13642.522511712092, 13685.79471307931, 661.7419206509466, 835.0480452284401, 845.8858054162702, 849.5412477262271, 857.1685465098844, 857.7169534053747, 860.3547339495378, 862.0775769926181, 862.2024627219828, 862.3015357560365, 899.2626046641757, 904.3488688144525, 904.39405598249, 904.398574947659, 904.8009437923646, 683.135833171039, 872.4285592936636, 888.373696543935, 893.307686542928, 894.0344428017758, 656.4485831901226, 658.6278752504867, 659.3834764495165, 659.5416185750905, 660.6234446365573, 14027.929860350734, 14042.859571404257, 14072.22602756848, 14104.71790564183, 14122.646933826634, 11638.301701897914, 11687.883121168765, 12498.562550310786, 12941.094123411365, 13007.609771706864, 10642.09542188915, 10770.138388928866, 10784.946075269652, 10805.0, 10850.72873178169, 3564.8574057037686, 3601.171730501973, 3612.349777040132, 3649.8905032848793, 3744.2698673758628, 50554.49445505535, 50807.745961270324, 51351.486485135414, 51557.74221128871, 51944.480555193964, 10086.49567521621, 10099.0, 10147.492625368703, 10186.388816671024, 10265.486725663686, 17678.292868285123, 17806.643867122842, 17836.10819459022, 17851.821481785017, 17863.374781882572, 7592.696292148363, 7728.961355193301, 7752.651130699132, 7857.096433910174, 7943.0, 4298.935515967263, 4410.647148228134, 4440.511543730187, 4520.660950428731, 4615.446146462446, 3137.654857965622, 3163.0352742413324, 3166.398384306974, 3175.6030496187977, 3179.554862319277, 441.82989549023216, 589.2869627750384, 591.544510726738, 591.9822405327847, 595.0776296740036, 663.320096900671, 674.6424395070522, 676.1210426445699, 682.6143229075557, 687.7695971849387, 7986.560739159402, 8114.391420643357, 8303.750887473385, 8334.833303333899, 8491.787705307417, 504.5282660712246, 557.6347492392489, 623.7473823101651, 665.5274754923961, 670.6847781542667, 3817.694584433294, 3828.3300422425964, 3838.9232215355537, 3883.2815929053218, 3981.044549308145, 52661.47338526642, 53685.0, 53743.731281344124, 54193.0, 54210.0, 47413.76293118512, 47542.0, 47645.0, 48713.269300960514, 48803.0, 43913.34129988053, 44170.0, 44725.0, 45518.0, 45667.0, 7915.604219788872, 7941.0, 7982.680692772224, 7993.480423772437, 8142.674293028213, 34529.0, 34745.65254347424, 35202.47196292006, 35773.64226357703, 36185.0, 41347.793261033505, 43725.344119837595, 44489.332660010776, 44521.55478445304, 44572.55427445684, 11360.54557817678, 11434.42827858587, 11673.766524669289, 11687.240329378563, 11736.178467507192, 11533.308001519936, 12268.325242111412, 12606.117571769888, 12615.432305546456, 12877.549285775327, 11689.88310116888, 11907.583234586747, 12060.276383417024, 12068.879311207127, 12184.939075304921, 11469.254498457574, 12164.878351216728, 12438.253704777742, 12536.122471426912, 12646.430910609228, 10535.0, 11078.390688511887, 11095.334279943228, 11421.428928553372, 11423.714407139556, 9979.50102494887, 9980.60077596888, 10044.0, 10091.596336146471, 10357.896421035693, 9224.0, 9427.811443770948, 9811.241547849144, 10002.549885255326, 10066.345687530287], "unit": "score", "name": "yui.html", "value": 6367.265967027687}], "name": "dromaeo_css", "value": 6852.577264574588}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 109.0, 110.0, 109.0, 99.0, 110.0, 108.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [165.0, 128.0, 151.0, 164.0, 128.0, 154.0, 150.0, 130.0, 174.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 159.0, 161.0, 162.0, 159.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 116.0, 93.0, 76.0, 72.0, 77.0, 124.0, 99.0, 72.0], "unit": "score", "name": "audio-fft", "value": 87.4}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 138.0, 93.0, 93.0, 99.0, 152.0, 92.0, 93.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 56.0, 56.0, 57.0, 56.0, 66.0, 53.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 66.0, 67.0, 67.0, 69.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 81.0, 83.0, 82.0, 82.0, 81.0, 82.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.4}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 114.0, 115.0, 124.0, 113.0, 119.0, 126.0, 115.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.2}, {"lowerIsBetter": true, "replicates": [160.0, 140.0, 145.0, 150.0, 161.0, 140.0, 151.0, 147.0, 149.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 69.0, 68.0, 71.0, 71.0, 68.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1512.0000000000005}]} 14:31:51 INFO - Return code: 0 14:31:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:31:51 INFO - # TBPL SUCCESS # 14:31:51 INFO - Running post-action listener: _resource_record_post_action 14:31:51 INFO - Running post-run listener: _resource_record_post_run 14:31:52 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538120192; Read time: 12; Write time: 479792 14:31:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240570368; Read time: 0; Write time: 260304 14:31:52 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297381888; Read time: 12; Write time: 219472 14:31:52 INFO - Running post-run listener: _upload_blobber_files 14:31:52 INFO - Blob upload gear active. 14:31:52 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:31:52 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 14:31:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:31:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:31:53 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:31:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:31:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:53 INFO - (blobuploader) - INFO - Done attempting. 14:31:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:31:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:31:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:54 INFO - (blobuploader) - INFO - Done attempting. 14:31:54 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:54 INFO - Return code: 0 14:31:54 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:31:54 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/580ed9c328fb513edec3478562d7b9a9fc3b0106d8479223b0e748302391f668343956e4cf3f5b97b6e588a1ff08a7b5c8b0211dce209a36230bf015db7d5ac7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6e1b873654a084a8567678eabcd97568966868eacd2e98a5c376da1f280d78c1ab726f04de9204b6e57c39c6e6a20735e664ee049888e20f3cfd0e27bd1c97d"} 14:31:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:31:54 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:31:54 INFO - Contents: 14:31:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/580ed9c328fb513edec3478562d7b9a9fc3b0106d8479223b0e748302391f668343956e4cf3f5b97b6e588a1ff08a7b5c8b0211dce209a36230bf015db7d5ac7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6e1b873654a084a8567678eabcd97568966868eacd2e98a5c376da1f280d78c1ab726f04de9204b6e57c39c6e6a20735e664ee049888e20f3cfd0e27bd1c97d"} 14:31:54 INFO - Running post-run listener: copy_logs_to_upload_dir 14:31:54 INFO - Copying logs to upload dir... 14:31:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:31:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.541741 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-05 14:31:54.474370) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-05 14:31:54.478160) ========= 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-1457214805.853392-1532103523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/580ed9c328fb513edec3478562d7b9a9fc3b0106d8479223b0e748302391f668343956e4cf3f5b97b6e588a1ff08a7b5c8b0211dce209a36230bf015db7d5ac7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6e1b873654a084a8567678eabcd97568966868eacd2e98a5c376da1f280d78c1ab726f04de9204b6e57c39c6e6a20735e664ee049888e20f3cfd0e27bd1c97d"} build_url:https://queue.taskcluster.net/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011446 build_url: 'https://queue.taskcluster.net/v1/task/LszUj8SUR9mC_jzwaB9htg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/580ed9c328fb513edec3478562d7b9a9fc3b0106d8479223b0e748302391f668343956e4cf3f5b97b6e588a1ff08a7b5c8b0211dce209a36230bf015db7d5ac7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6e1b873654a084a8567678eabcd97568966868eacd2e98a5c376da1f280d78c1ab726f04de9204b6e57c39c6e6a20735e664ee049888e20f3cfd0e27bd1c97d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-05 14:31:54.504053) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 14:31:54.504734) ========= 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-1457214805.853392-1532103523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-05 14:31:54.591118) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-05 14:31:54.591776) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-05 14:31:54.592323) ========= ========= Total master_lag: 0.37 =========