builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1456003273.69 results: success (0) buildid: 20160220083304 builduid: 7151419e859941eaabb7c5d353974746 revision: eff6731606da854ee031a06a64191484c09e72e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:13.692241) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:13.692682) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:13.693008) ========= 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=0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005465 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:13.712757) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:13.713055) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:13.754697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:13.755086) ========= 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=0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.039518 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:13.805930) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:13.809332) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:13.809763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:13.810102) ========= 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=0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-20 13:21:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.3M=0s 2016-02-20 13:21:14 (35.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159354 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:13.982020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:13.983791) ========= 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=0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.222805 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:14.220464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-20 13:21:14.221083) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eff6731606da854ee031a06a64191484c09e72e4 --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 eff6731606da854ee031a06a64191484c09e72e4 --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=0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-20 13:21:14,562 truncating revision to first 12 chars 2016-02-20 13:21:14,562 Setting DEBUG logging. 2016-02-20 13:21:14,562 attempt 1/10 2016-02-20 13:21:14,562 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eff6731606da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-20 13:21:15,466 unpacking tar archive at: fx-team-eff6731606da/testing/mozharness/ program finished with exit code 0 elapsedTime=1.178494 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-20 13:21:15.416295) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:15.417142) ========= echo eff6731606da854ee031a06a64191484c09e72e4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'eff6731606da854ee031a06a64191484c09e72e4'] 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=0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False eff6731606da854ee031a06a64191484c09e72e4 program finished with exit code 0 elapsedTime=0.004585 script_repo_revision: 'eff6731606da854ee031a06a64191484c09e72e4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:15.468900) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:15.469249) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-20 13:21:15.478889) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-02-20 13:21:15.479193) ========= /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=0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:21:15 INFO - MultiFileLogger online at 20160220 13:21:15 in /builds/slave/test-pgo 13:21:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:21:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:21:15 INFO - {'append_to_log': False, 13:21:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:21:15 INFO - 'blob_upload_branch': 'Fx-Team', 13:21:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:21:15 INFO - 'branch': 'Fx-Team', 13:21:15 INFO - 'buildbot_json_path': 'buildprops.json', 13:21:15 INFO - 'config_files': ('talos/linux_config.py',), 13:21:15 INFO - 'default_actions': ('clobber', 13:21:15 INFO - 'read-buildbot-config', 13:21:15 INFO - 'download-and-extract', 13:21:15 INFO - 'populate-webroot', 13:21:15 INFO - 'create-virtualenv', 13:21:15 INFO - 'install', 13:21:15 INFO - 'run-tests'), 13:21:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:21:15 INFO - 'download_minidump_stackwalk': True, 13:21:15 INFO - 'download_symbols': 'ondemand', 13:21:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:21:15 INFO - 'tooltool.py': '/tools/tooltool.py', 13:21:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:21:15 INFO - '/tools/misc-python/virtualenv.py')}, 13:21:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:21:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:21:15 INFO - 'installer_path': 'installer.exe', 13:21:15 INFO - 'log_level': 'info', 13:21:15 INFO - 'log_name': 'talos', 13:21:15 INFO - 'log_to_console': True, 13:21:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:21:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:21:15 INFO - 'opt_config_files': (), 13:21:15 INFO - 'pip_index': False, 13:21:15 INFO - 'sps_profile': False, 13:21:15 INFO - 'sps_profile_interval': 0, 13:21:15 INFO - 'suite': 'dromaeojs', 13:21:15 INFO - 'system_bits': '32', 13:21:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:21:15 INFO - 'title': 'talos-linux64-ix-029', 13:21:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:21:15 INFO - 'use_talos_json': True, 13:21:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:21:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:21:15 INFO - 'work_dir': 'build'} 13:21:15 INFO - ##### 13:21:15 INFO - ##### Running clobber step. 13:21:15 INFO - ##### 13:21:15 INFO - Running pre-action listener: _resource_record_pre_action 13:21:15 INFO - Running main action method: clobber 13:21:15 INFO - rmtree: /builds/slave/test-pgo/build 13:21:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:21:16 INFO - Running post-action listener: _resource_record_post_action 13:21:16 INFO - ##### 13:21:16 INFO - ##### Running read-buildbot-config step. 13:21:16 INFO - ##### 13:21:16 INFO - Running pre-action listener: _resource_record_pre_action 13:21:16 INFO - Running main action method: read_buildbot_config 13:21:16 INFO - Using buildbot properties: 13:21:16 INFO - { 13:21:16 INFO - "project": "", 13:21:16 INFO - "product": "firefox", 13:21:16 INFO - "script_repo_revision": "production", 13:21:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:21:16 INFO - "repository": "", 13:21:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:21:16 INFO - "buildid": "20160220083304", 13:21:16 INFO - "pgo_build": "True", 13:21:16 INFO - "basedir": "/builds/slave/test-pgo", 13:21:16 INFO - "buildnumber": 653, 13:21:16 INFO - "slavename": "talos-linux64-ix-029", 13:21:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:21:16 INFO - "platform": "ubuntu64_hw", 13:21:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:21:16 INFO - "branch": "fx-team", 13:21:16 INFO - "repo_path": "integration/fx-team", 13:21:16 INFO - "revision": "eff6731606da854ee031a06a64191484c09e72e4", 13:21:16 INFO - "stage_platform": "linux64-pgo", 13:21:16 INFO - "builduid": "7151419e859941eaabb7c5d353974746", 13:21:16 INFO - "slavebuilddir": "test" 13:21:16 INFO - } 13:21:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 13:21:16 INFO - Running post-action listener: _resource_record_post_action 13:21:16 INFO - ##### 13:21:16 INFO - ##### Running download-and-extract step. 13:21:16 INFO - ##### 13:21:16 INFO - Running pre-action listener: _resource_record_pre_action 13:21:16 INFO - Running main action method: download_and_extract 13:21:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:16 INFO - https://queue.taskcluster.net/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:21:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/test_packages.json 13:21:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/test_packages.json 13:21:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:21:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:21:17 INFO - Downloaded 1448 bytes. 13:21:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:21:17 INFO - Using the following test package requirements: 13:21:17 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 13:21:17 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:21:17 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:21:17 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:17 INFO - u'jsshell-linux-x86_64.zip'], 13:21:17 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:21:17 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 13:21:17 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:21:17 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:21:17 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:21:17 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 13:21:17 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:21:17 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:21:17 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')]} 13:21:17 INFO - https://queue.taskcluster.net/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 13:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 13:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/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 13:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/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 13:21:18 INFO - Downloaded 23349855 bytes. 13:21:18 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'] 13:21:18 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 13:21:19 INFO - Return code: 0 13:21:19 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 13:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:19 INFO - https://queue.taskcluster.net/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:21:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 13:21:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 13:21:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/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 13:21:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/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 13:21:21 INFO - Downloaded 23349855 bytes. 13:21:21 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'] 13:21:21 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 13:21:22 INFO - Return code: 0 13:21:22 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')]} 13:21:22 INFO - https://queue.taskcluster.net/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 13:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 13:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/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 13:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/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 13:21:23 INFO - Downloaded 10707015 bytes. 13:21:23 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'] 13:21:23 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 13:21:23 INFO - Return code: 0 13:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:23 INFO - https://queue.taskcluster.net/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:21:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 13:21:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 13:21:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/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 13:21:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3UwTgXJTNedjqKXM0k56A/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 13:21:24 INFO - Downloaded 56553278 bytes. 13:21:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 13:21:24 INFO - mkdir: /builds/slave/test-pgo/properties 13:21:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:21:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:21:24 INFO - Contents: 13:21:24 INFO - build_url:https://queue.taskcluster.net/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 13:21:25 INFO - Running post-action listener: _resource_record_post_action 13:21:25 INFO - Running post-action listener: set_extra_try_arguments 13:21:25 INFO - ##### 13:21:25 INFO - ##### Running populate-webroot step. 13:21:25 INFO - ##### 13:21:25 INFO - Running pre-action listener: _resource_record_pre_action 13:21:25 INFO - Running main action method: populate_webroot 13:21:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:21:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:21:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:21:25 INFO - '--tppagecycles', 13:21:25 INFO - '7'], 13:21:25 INFO - 'tests': ['tsvgm']}}, 13:21:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:21:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:21:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:21:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:21:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:21:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:21:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:25 INFO - 'talos_options': ['--e10s'], 13:21:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:25 INFO - 'tests': ['damp', 'tps']}, 13:21:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:25 INFO - 'talos_options': ['--e10s'], 13:21:25 INFO - 'tests': ['damp', 'tps']}, 13:21:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:21:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:21:25 INFO - 'other': {'tests': ['a11yr', 13:21:25 INFO - 'ts_paint', 13:21:25 INFO - 'tpaint', 13:21:25 INFO - 'sessionrestore', 13:21:25 INFO - 'sessionrestore_no_auto_restore']}, 13:21:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:21:25 INFO - 'tests': ['a11yr', 13:21:25 INFO - 'ts_paint', 13:21:25 INFO - 'tpaint', 13:21:25 INFO - 'sessionrestore', 13:21:25 INFO - 'sessionrestore_no_auto_restore']}, 13:21:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:21:25 INFO - 'tests': ['a11yr', 13:21:25 INFO - 'ts_paint', 13:21:25 INFO - 'tpaint', 13:21:25 INFO - 'sessionrestore', 13:21:25 INFO - 'sessionrestore_no_auto_restore']}, 13:21:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:21:25 INFO - 'tests': ['a11yr', 13:21:25 INFO - 'ts_paint', 13:21:25 INFO - 'tpaint', 13:21:25 INFO - 'sessionrestore', 13:21:25 INFO - 'sessionrestore_no_auto_restore']}, 13:21:25 INFO - 'other_l64': {'tests': ['a11yr', 13:21:25 INFO - 'ts_paint', 13:21:25 INFO - 'tpaint', 13:21:25 INFO - 'sessionrestore', 13:21:25 INFO - 'sessionrestore_no_auto_restore']}, 13:21:25 INFO - 'other_nol64': {'tests': ['a11yr', 13:21:25 INFO - 'ts_paint', 13:21:25 INFO - 'tpaint', 13:21:25 INFO - 'sessionrestore', 13:21:25 INFO - 'sessionrestore_no_auto_restore']}, 13:21:25 INFO - 'svgr': {'tests': ['tsvgx', 13:21:25 INFO - 'tsvgr_opacity', 13:21:25 INFO - 'tart', 13:21:25 INFO - 'tscrollx', 13:21:25 INFO - 'cart']}, 13:21:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:21:25 INFO - 'tests': ['tsvgx', 13:21:25 INFO - 'tsvgr_opacity', 13:21:25 INFO - 'tart', 13:21:25 INFO - 'tscrollx', 13:21:25 INFO - 'cart']}, 13:21:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:25 INFO - 'tests': ['tp5o']}, 13:21:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:25 INFO - 'talos_options': ['--e10s'], 13:21:25 INFO - 'tests': ['tp5o']}, 13:21:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:25 INFO - 'talos_options': ['--xperf_path', 13:21:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:25 INFO - 'tests': ['tp5n']}, 13:21:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:25 INFO - 'talos_options': ['--e10s', 13:21:25 INFO - '--xperf_path', 13:21:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:25 INFO - 'tests': ['tp5n']}}, 13:21:25 INFO - 'talos.zip': {'path': '', 13:21:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:21:25 INFO - Running post-action listener: _resource_record_post_action 13:21:25 INFO - ##### 13:21:25 INFO - ##### Running create-virtualenv step. 13:21:25 INFO - ##### 13:21:25 INFO - Running pre-action listener: _resource_record_pre_action 13:21:25 INFO - Running main action method: create_virtualenv 13:21:25 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:21:25 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 13:21:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:21:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:21:25 INFO - Using real prefix '/usr' 13:21:25 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:21:26 INFO - Installing distribute.............................................................................................................................................................................................done. 13:21:28 INFO - Installing pip.................done. 13:21:28 INFO - Return code: 0 13:21:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:21:28 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')]} 13:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:28 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')]} 13:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:28 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 0x7f173de43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9f8c0>, '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 0x1ca07c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca0c50>, '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': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', '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 13:21:28 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 13:21:28 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 13:21:28 INFO - Using env: {'DISPLAY': ':0', 13:21:28 INFO - 'HOME': '/home/cltbld', 13:21:28 INFO - 'LANG': 'en_US.UTF-8', 13:21:28 INFO - 'LANGUAGE': 'en_US:en', 13:21:28 INFO - 'LOGNAME': 'cltbld', 13:21:28 INFO - 'MAIL': '/var/mail/cltbld', 13:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:28 INFO - 'MOZ_NO_REMOTE': '1', 13:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:28 INFO - 'NO_EM_RESTART': '1', 13:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:21:28 INFO - 'PWD': '/builds/slave/test-pgo', 13:21:28 INFO - 'SHELL': '/bin/bash', 13:21:28 INFO - 'SHLVL': '1', 13:21:28 INFO - 'TERM': 'linux', 13:21:28 INFO - 'TMOUT': '86400', 13:21:28 INFO - 'USER': 'cltbld', 13:21:28 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', 13:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:28 INFO - '_': '/tools/buildbot/bin/python'} 13:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:28 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 13:21:28 INFO - Cleaning up... 13:21:28 INFO - Return code: 0 13:21:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:21:28 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')]} 13:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:28 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')]} 13:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:28 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 0x7f173de43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9f8c0>, '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 0x1ca07c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca0c50>, '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': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', '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 13:21:28 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 13:21:28 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 13:21:28 INFO - Using env: {'DISPLAY': ':0', 13:21:28 INFO - 'HOME': '/home/cltbld', 13:21:28 INFO - 'LANG': 'en_US.UTF-8', 13:21:28 INFO - 'LANGUAGE': 'en_US:en', 13:21:28 INFO - 'LOGNAME': 'cltbld', 13:21:28 INFO - 'MAIL': '/var/mail/cltbld', 13:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:28 INFO - 'MOZ_NO_REMOTE': '1', 13:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:28 INFO - 'NO_EM_RESTART': '1', 13:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:21:28 INFO - 'PWD': '/builds/slave/test-pgo', 13:21:28 INFO - 'SHELL': '/bin/bash', 13:21:28 INFO - 'SHLVL': '1', 13:21:28 INFO - 'TERM': 'linux', 13:21:28 INFO - 'TMOUT': '86400', 13:21:28 INFO - 'USER': 'cltbld', 13:21:28 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', 13:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:28 INFO - '_': '/tools/buildbot/bin/python'} 13:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:28 INFO - Downloading/unpacking psutil>=0.7.1 13:21:28 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 13:21:28 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 13:21:28 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 13:21:28 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 13:21:28 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 13:21:28 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 13:21:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:21:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:31 INFO - Installing collected packages: psutil 13:21:31 INFO - Running setup.py install for psutil 13:21:31 INFO - building 'psutil._psutil_linux' extension 13:21:31 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 13:21:31 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 13:21:31 INFO - building 'psutil._psutil_posix' extension 13:21:31 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 13:21:31 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 13:21:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:31 INFO - Successfully installed psutil 13:21:31 INFO - Cleaning up... 13:21:31 INFO - Return code: 0 13:21:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:21: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')]} 13:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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')]} 13:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:31 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 0x7f173de43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9f8c0>, '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 0x1ca07c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca0c50>, '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': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', '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 13:21:31 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 13:21:31 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 13:21:32 INFO - Using env: {'DISPLAY': ':0', 13:21:32 INFO - 'HOME': '/home/cltbld', 13:21:32 INFO - 'LANG': 'en_US.UTF-8', 13:21:32 INFO - 'LANGUAGE': 'en_US:en', 13:21:32 INFO - 'LOGNAME': 'cltbld', 13:21:32 INFO - 'MAIL': '/var/mail/cltbld', 13:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:32 INFO - 'MOZ_NO_REMOTE': '1', 13:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:32 INFO - 'NO_EM_RESTART': '1', 13:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:21:32 INFO - 'PWD': '/builds/slave/test-pgo', 13:21:32 INFO - 'SHELL': '/bin/bash', 13:21:32 INFO - 'SHLVL': '1', 13:21:32 INFO - 'TERM': 'linux', 13:21:32 INFO - 'TMOUT': '86400', 13:21:32 INFO - 'USER': 'cltbld', 13:21:32 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', 13:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:32 INFO - '_': '/tools/buildbot/bin/python'} 13:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:21:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:21:34 INFO - Installing collected packages: mozsystemmonitor 13:21:34 INFO - Running setup.py install for mozsystemmonitor 13:21:34 INFO - Successfully installed mozsystemmonitor 13:21:34 INFO - Cleaning up... 13:21:34 INFO - Return code: 0 13:21:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f173de43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9f8c0>, '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 0x1ca07c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca0c50>, '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': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', '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 13:21:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:21:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:21:34 INFO - Using env: {'DISPLAY': ':0', 13:21:34 INFO - 'HOME': '/home/cltbld', 13:21:34 INFO - 'LANG': 'en_US.UTF-8', 13:21:34 INFO - 'LANGUAGE': 'en_US:en', 13:21:34 INFO - 'LOGNAME': 'cltbld', 13:21:34 INFO - 'MAIL': '/var/mail/cltbld', 13:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:34 INFO - 'MOZ_NO_REMOTE': '1', 13:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:34 INFO - 'NO_EM_RESTART': '1', 13:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:21:34 INFO - 'PWD': '/builds/slave/test-pgo', 13:21:34 INFO - 'SHELL': '/bin/bash', 13:21:34 INFO - 'SHLVL': '1', 13:21:34 INFO - 'TERM': 'linux', 13:21:34 INFO - 'TMOUT': '86400', 13:21:34 INFO - 'USER': 'cltbld', 13:21:34 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', 13:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:34 INFO - '_': '/tools/buildbot/bin/python'} 13:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:34 INFO - Downloading/unpacking blobuploader==1.2.4 13:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:36 INFO - Downloading blobuploader-1.2.4.tar.gz 13:21:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:21:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:21:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:36 INFO - Downloading docopt-0.6.1.tar.gz 13:21:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:21:36 INFO - Installing collected packages: blobuploader, requests, docopt 13:21:36 INFO - Running setup.py install for blobuploader 13:21:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:21:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:21:37 INFO - Running setup.py install for requests 13:21:37 INFO - Running setup.py install for docopt 13:21:37 INFO - Successfully installed blobuploader requests docopt 13:21:37 INFO - Cleaning up... 13:21:37 INFO - Return code: 0 13:21:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:37 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 0x7f173de43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9f8c0>, '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 0x1ca07c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca0c50>, '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': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', '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 13:21:37 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 13:21:37 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 13:21:37 INFO - Using env: {'DISPLAY': ':0', 13:21:37 INFO - 'HOME': '/home/cltbld', 13:21:37 INFO - 'LANG': 'en_US.UTF-8', 13:21:37 INFO - 'LANGUAGE': 'en_US:en', 13:21:37 INFO - 'LOGNAME': 'cltbld', 13:21:37 INFO - 'MAIL': '/var/mail/cltbld', 13:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:37 INFO - 'MOZ_NO_REMOTE': '1', 13:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:37 INFO - 'NO_EM_RESTART': '1', 13:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:21:37 INFO - 'PWD': '/builds/slave/test-pgo', 13:21:37 INFO - 'SHELL': '/bin/bash', 13:21:37 INFO - 'SHLVL': '1', 13:21:37 INFO - 'TERM': 'linux', 13:21:37 INFO - 'TMOUT': '86400', 13:21:37 INFO - 'USER': 'cltbld', 13:21:37 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', 13:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:37 INFO - '_': '/tools/buildbot/bin/python'} 13:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:21:37 INFO - Running setup.py (path:/tmp/pip-SN0DRS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:21:37 INFO - Running setup.py (path:/tmp/pip-jaTPae-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:21:37 INFO - Running setup.py (path:/tmp/pip-oQSgLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:21:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:21:38 INFO - Running setup.py (path:/tmp/pip-_MJlKF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:21:38 INFO - Running setup.py (path:/tmp/pip-14axP6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:21:38 INFO - Running setup.py (path:/tmp/pip-X4CRGo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:21:38 INFO - Running setup.py (path:/tmp/pip-wzfVVa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:21:38 INFO - Running setup.py (path:/tmp/pip-1_NqIU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:21:38 INFO - Running setup.py (path:/tmp/pip-paihGV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:21:38 INFO - Running setup.py (path:/tmp/pip-EqqYBj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:21:38 INFO - Running setup.py (path:/tmp/pip-jkiqQo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:21:38 INFO - Running setup.py (path:/tmp/pip-EnQSrL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:21:38 INFO - Running setup.py (path:/tmp/pip-rBeOkN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:21:38 INFO - Running setup.py (path:/tmp/pip-QswY1b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:21:38 INFO - Running setup.py (path:/tmp/pip-aMN6wy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:21:38 INFO - Running setup.py (path:/tmp/pip-eJ63kF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:21:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:21:38 INFO - Running setup.py (path:/tmp/pip-a9vjuL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:21:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:21:39 INFO - Running setup.py install for manifestparser 13:21:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:21:39 INFO - Running setup.py install for mozcrash 13:21:39 INFO - Running setup.py install for mozdebug 13:21:39 INFO - Running setup.py install for mozdevice 13:21:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:21:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:21:39 INFO - Running setup.py install for mozfile 13:21:39 INFO - Running setup.py install for mozhttpd 13:21:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:21:39 INFO - Running setup.py install for mozinfo 13:21:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:21:39 INFO - Running setup.py install for mozInstall 13:21:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:21:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:21:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:21:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:21:39 INFO - Running setup.py install for mozleak 13:21:39 INFO - Running setup.py install for mozlog 13:21:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:21:40 INFO - Running setup.py install for moznetwork 13:21:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:21:40 INFO - Running setup.py install for mozprocess 13:21:40 INFO - Running setup.py install for mozprofile 13:21:40 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:21:40 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:21:40 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:21:40 INFO - Running setup.py install for mozrunner 13:21:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:21:40 INFO - Running setup.py install for mozscreenshot 13:21:40 INFO - Running setup.py install for moztest 13:21:40 INFO - Running setup.py install for mozversion 13:21:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:21:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:21:40 INFO - Cleaning up... 13:21:40 INFO - Return code: 0 13:21:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:21: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')]} 13:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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')]} 13:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:40 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 0x7f173de43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9f8c0>, '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 0x1ca07c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca0c50>, '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': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', '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 13:21:40 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 13:21:40 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 13:21:40 INFO - Using env: {'DISPLAY': ':0', 13:21:40 INFO - 'HOME': '/home/cltbld', 13:21:40 INFO - 'LANG': 'en_US.UTF-8', 13:21:40 INFO - 'LANGUAGE': 'en_US:en', 13:21:40 INFO - 'LOGNAME': 'cltbld', 13:21:40 INFO - 'MAIL': '/var/mail/cltbld', 13:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:40 INFO - 'MOZ_NO_REMOTE': '1', 13:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:40 INFO - 'NO_EM_RESTART': '1', 13:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:21:40 INFO - 'PWD': '/builds/slave/test-pgo', 13:21:40 INFO - 'SHELL': '/bin/bash', 13:21:40 INFO - 'SHLVL': '1', 13:21:40 INFO - 'TERM': 'linux', 13:21:40 INFO - 'TMOUT': '86400', 13:21:40 INFO - 'USER': 'cltbld', 13:21:40 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', 13:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:40 INFO - '_': '/tools/buildbot/bin/python'} 13:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:21:41 INFO - Running setup.py (path:/tmp/pip-7SAhHH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:21:41 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)) 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:21:41 INFO - Running setup.py (path:/tmp/pip-54h22I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:21:41 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)) 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:21:41 INFO - Running setup.py (path:/tmp/pip-aT10TQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:21:41 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)) 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:21:41 INFO - Running setup.py (path:/tmp/pip-FgPQTG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:21:41 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)) 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:21:41 INFO - Running setup.py (path:/tmp/pip-tHlYro-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:21:41 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)) 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:21:41 INFO - Running setup.py (path:/tmp/pip-xFTqUk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:21:41 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)) 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:21:41 INFO - Running setup.py (path:/tmp/pip-VIROjH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:21:41 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)) 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:21:41 INFO - Running setup.py (path:/tmp/pip-2p5Wh6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:21:41 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)) 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:21:41 INFO - Running setup.py (path:/tmp/pip-cARL0E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:21:41 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)) 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:21:41 INFO - Running setup.py (path:/tmp/pip-NdOZXF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:21:41 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)) 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:21:41 INFO - Running setup.py (path:/tmp/pip-USoUCS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:21:41 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)) 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:21:41 INFO - Running setup.py (path:/tmp/pip-0XDLTV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:21:41 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)) 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:21:41 INFO - Running setup.py (path:/tmp/pip-9VBHfp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:21:41 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)) 13:21:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:21:41 INFO - Running setup.py (path:/tmp/pip-A7ahcl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:21:42 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)) 13:21:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:21:42 INFO - Running setup.py (path:/tmp/pip-NeWdP6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:21:42 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)) 13:21:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:21:42 INFO - Running setup.py (path:/tmp/pip-cBPHlv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:21:42 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)) 13:21:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:21:42 INFO - Running setup.py (path:/tmp/pip-0Bvryk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:21:42 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)) 13:21:42 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)) 13:21:42 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)) 13:21:42 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)) 13:21:42 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)) 13:21:42 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)) 13:21:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:21:42 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 13:21:42 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 13:21:42 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 13:21:42 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 13:21:42 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 13:21:42 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 13:21:44 INFO - Downloading blessings-1.6.tar.gz 13:21:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:21:44 INFO - Installing collected packages: blessings 13:21:44 INFO - Running setup.py install for blessings 13:21:44 INFO - Successfully installed blessings 13:21:44 INFO - Cleaning up... 13:21:44 INFO - Return code: 0 13:21:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:21:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:21:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:21:44 INFO - Reading from file tmpfile_stdout 13:21:44 INFO - Current package versions: 13:21:44 INFO - argparse == 1.2.1 13:21:44 INFO - blessings == 1.6 13:21:44 INFO - blobuploader == 1.2.4 13:21:44 INFO - docopt == 0.6.1 13:21:44 INFO - manifestparser == 1.1 13:21:44 INFO - mozInstall == 1.12 13:21:44 INFO - mozcrash == 0.16 13:21:44 INFO - mozdebug == 0.1 13:21:44 INFO - mozdevice == 0.48 13:21:44 INFO - mozfile == 1.2 13:21:44 INFO - mozhttpd == 0.7 13:21:44 INFO - mozinfo == 0.9 13:21:44 INFO - mozleak == 0.1 13:21:44 INFO - mozlog == 3.1 13:21:44 INFO - moznetwork == 0.27 13:21:44 INFO - mozprocess == 0.22 13:21:44 INFO - mozprofile == 0.28 13:21:44 INFO - mozrunner == 6.11 13:21:44 INFO - mozscreenshot == 0.1 13:21:44 INFO - mozsystemmonitor == 0.0 13:21:44 INFO - moztest == 0.7 13:21:44 INFO - mozversion == 1.4 13:21:44 INFO - psutil == 3.1.1 13:21:44 INFO - requests == 1.2.3 13:21:44 INFO - wsgiref == 0.1.2 13:21:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f173de43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9f8c0>, '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 0x1ca07c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca0c50>, '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': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', '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 13:21:44 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 13:21:44 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 13:21:44 INFO - Using env: {'DISPLAY': ':0', 13:21:44 INFO - 'HOME': '/home/cltbld', 13:21:44 INFO - 'LANG': 'en_US.UTF-8', 13:21:44 INFO - 'LANGUAGE': 'en_US:en', 13:21:44 INFO - 'LOGNAME': 'cltbld', 13:21:44 INFO - 'MAIL': '/var/mail/cltbld', 13:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:44 INFO - 'MOZ_NO_REMOTE': '1', 13:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:44 INFO - 'NO_EM_RESTART': '1', 13:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:21:44 INFO - 'PWD': '/builds/slave/test-pgo', 13:21:44 INFO - 'SHELL': '/bin/bash', 13:21:44 INFO - 'SHLVL': '1', 13:21:44 INFO - 'TERM': 'linux', 13:21:44 INFO - 'TMOUT': '86400', 13:21:44 INFO - 'USER': 'cltbld', 13:21:44 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', 13:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:44 INFO - '_': '/tools/buildbot/bin/python'} 13:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:44 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)) 13:21:44 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)) 13:21:44 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)) 13:21:44 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)) 13:21:44 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)) 13:21:44 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)) 13:21:44 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)) 13:21:44 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)) 13:21:44 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)) 13:21:44 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)) 13:21:44 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)) 13:21:44 INFO - Cleaning up... 13:21:44 INFO - Return code: 0 13:21:44 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:44 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 0x7f173de43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9f8c0>, '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 0x1ca07c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca0c50>, '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': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', '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 13:21:44 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 13:21:44 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 13:21:44 INFO - Using env: {'DISPLAY': ':0', 13:21:44 INFO - 'HOME': '/home/cltbld', 13:21:44 INFO - 'LANG': 'en_US.UTF-8', 13:21:44 INFO - 'LANGUAGE': 'en_US:en', 13:21:44 INFO - 'LOGNAME': 'cltbld', 13:21:44 INFO - 'MAIL': '/var/mail/cltbld', 13:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:44 INFO - 'MOZ_NO_REMOTE': '1', 13:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:44 INFO - 'NO_EM_RESTART': '1', 13:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:21:44 INFO - 'PWD': '/builds/slave/test-pgo', 13:21:44 INFO - 'SHELL': '/bin/bash', 13:21:44 INFO - 'SHLVL': '1', 13:21:44 INFO - 'TERM': 'linux', 13:21:44 INFO - 'TMOUT': '86400', 13:21:44 INFO - 'USER': 'cltbld', 13:21:44 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', 13:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:44 INFO - '_': '/tools/buildbot/bin/python'} 13:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:44 INFO - Downloading/unpacking jsonschema 13:21:44 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 13:21:44 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 13:21:44 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 13:21:44 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 13:21:44 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 13:21:44 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 13:21:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:21:46 INFO - Downloading/unpacking functools32 (from jsonschema) 13:21: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 13:21: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 13:21: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 13:21: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 13:21: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 13:21: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 13:21:46 INFO - Downloading functools32-3.2.3-2.tar.gz 13:21:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:21:46 INFO - warning: no files found matching '*.txt' 13:21:46 INFO - no previously-included directories found matching 'build' 13:21:46 INFO - no previously-included directories found matching 'dist' 13:21:46 INFO - no previously-included directories found matching '.git*' 13:21:47 INFO - Installing collected packages: jsonschema, functools32 13:21:47 INFO - Running setup.py install for functools32 13:21:47 INFO - warning: no files found matching '*.txt' 13:21:47 INFO - no previously-included directories found matching 'build' 13:21:47 INFO - no previously-included directories found matching 'dist' 13:21:47 INFO - no previously-included directories found matching '.git*' 13:21:47 INFO - Successfully installed jsonschema functools32 13:21:47 INFO - Cleaning up... 13:21:47 INFO - Return code: 0 13:21:47 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:21:47 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')]} 13:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:47 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')]} 13:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:47 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 0x7f173de43f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c10670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9f8c0>, '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 0x1ca07c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca0c50>, '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': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', '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 13:21:47 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 13:21:47 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 13:21:47 INFO - Using env: {'DISPLAY': ':0', 13:21:47 INFO - 'HOME': '/home/cltbld', 13:21:47 INFO - 'LANG': 'en_US.UTF-8', 13:21:47 INFO - 'LANGUAGE': 'en_US:en', 13:21:47 INFO - 'LOGNAME': 'cltbld', 13:21:47 INFO - 'MAIL': '/var/mail/cltbld', 13:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:47 INFO - 'MOZ_NO_REMOTE': '1', 13:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:47 INFO - 'NO_EM_RESTART': '1', 13:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:21:47 INFO - 'PWD': '/builds/slave/test-pgo', 13:21:47 INFO - 'SHELL': '/bin/bash', 13:21:47 INFO - 'SHLVL': '1', 13:21:47 INFO - 'TERM': 'linux', 13:21:47 INFO - 'TMOUT': '86400', 13:21:47 INFO - 'USER': 'cltbld', 13:21:47 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', 13:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:47 INFO - '_': '/tools/buildbot/bin/python'} 13:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:47 INFO - Downloading/unpacking flake8 13:21:47 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 13:21:47 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 13:21:47 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 13:21:47 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 13:21:47 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 13:21:47 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 13:21:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:21:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:21:49 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 13:21:49 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 13:21:49 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 13:21:49 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 13:21:49 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 13:21:49 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 13:21:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:21:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:21:49 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 13:21:49 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 13:21:49 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 13:21:49 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 13:21:49 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 13:21:49 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 13:21:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:21:49 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 13:21:49 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 13:21:49 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 13:21:49 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 13:21:49 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 13:21:49 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 13:21:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:21:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:21:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:21:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:21:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:21:49 INFO - no previously-included directories found matching 'docs/_build' 13:21:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:21:50 INFO - Running setup.py install for pep8 13:21:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:21:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:21:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:21:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:21:50 INFO - no previously-included directories found matching 'docs/_build' 13:21:50 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:21:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:21:50 INFO - Cleaning up... 13:21:50 INFO - Return code: 0 13:21:50 INFO - Running post-action listener: _resource_record_post_action 13:21:50 INFO - Running post-action listener: _start_resource_monitoring 13:21:50 INFO - Starting resource monitoring. 13:21:50 INFO - ##### 13:21:50 INFO - ##### Running install step. 13:21:50 INFO - ##### 13:21:50 INFO - Running pre-action listener: _resource_record_pre_action 13:21:50 INFO - Running main action method: install 13:21:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:21:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:21:50 INFO - Reading from file tmpfile_stdout 13:21:50 INFO - Detecting whether we're running mozinstall >=1.0... 13:21:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:21:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:21:50 INFO - Reading from file tmpfile_stdout 13:21:50 INFO - Output received: 13:21:50 INFO - Usage: mozinstall [options] installer 13:21:50 INFO - Options: 13:21:50 INFO - -h, --help show this help message and exit 13:21:50 INFO - -d DEST, --destination=DEST 13:21:50 INFO - Directory to install application into. [default: 13:21:50 INFO - "/builds/slave/test-pgo"] 13:21:50 INFO - --app=APP Application being installed. [default: firefox] 13:21:50 INFO - mkdir: /builds/slave/test-pgo/build/application 13:21:50 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'] 13:21:50 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 13:22:06 INFO - Reading from file tmpfile_stdout 13:22:06 INFO - Output received: 13:22:06 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:22:06 INFO - Running post-action listener: _resource_record_post_action 13:22:06 INFO - ##### 13:22:06 INFO - ##### Running run-tests step. 13:22:06 INFO - ##### 13:22:06 INFO - Running pre-action listener: _resource_record_pre_action 13:22:06 INFO - Running main action method: run_tests 13:22:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:22:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:22:06 INFO - Python 2.7.3 13:22:06 INFO - Return code: 0 13:22:06 INFO - grabbing minidump binary from tooltool 13:22:06 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')]} 13:22:06 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 0x1c9f8c0>, '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 0x1ca07c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca0c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:22:06 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 13:22:06 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 13:22:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:22:06 INFO - Return code: 0 13:22:06 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:22:06 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:22:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:22:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:22:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:22:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:22:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:22:07 INFO - Return code: 0 13:22:07 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/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 13:22:07 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/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 13:22:07 INFO - Using env: {'DISPLAY': ':0', 13:22:07 INFO - 'HOME': '/home/cltbld', 13:22:07 INFO - 'LANG': 'en_US.UTF-8', 13:22:07 INFO - 'LANGUAGE': 'en_US:en', 13:22:07 INFO - 'LOGNAME': 'cltbld', 13:22:07 INFO - 'MAIL': '/var/mail/cltbld', 13:22:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:22:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:07 INFO - 'MOZ_NO_REMOTE': '1', 13:22:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:07 INFO - 'NO_EM_RESTART': '1', 13:22:07 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:22:07 INFO - 'PWD': '/builds/slave/test-pgo', 13:22:07 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:22:07 INFO - 'SHELL': '/bin/bash', 13:22:07 INFO - 'SHLVL': '1', 13:22:07 INFO - 'TERM': 'linux', 13:22:07 INFO - 'TMOUT': '86400', 13:22:07 INFO - 'USER': 'cltbld', 13:22:07 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819', 13:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:07 INFO - '_': '/tools/buildbot/bin/python'} 13:22:07 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/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 13:22:07 INFO - mozversion application_buildid: 20160220083304 13:22:07 INFO - mozversion application_changeset: eff6731606da854ee031a06a64191484c09e72e4 13:22:07 INFO - mozversion application_display_name: Nightly 13:22:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:22:07 INFO - mozversion application_name: Firefox 13:22:07 INFO - mozversion application_remotingname: firefox 13:22:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:22:07 INFO - mozversion application_vendor: Mozilla 13:22:07 INFO - mozversion application_version: 47.0a1 13:22:07 INFO - mozversion platform_buildid: 20160220083304 13:22:07 INFO - mozversion platform_changeset: eff6731606da854ee031a06a64191484c09e72e4 13:22:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:22:08 INFO - mozversion platform_version: 47.0a1 13:22:08 INFO - using testdate: 1456003327 13:22:08 INFO - actual date: 1456003327 13:22:08 INFO - starting webserver on 'localhost:59440' 13:22:08 INFO - SUITE-START | Running 2 tests 13:22:08 INFO - TEST-START | dromaeo_css 13:22:08 INFO - operating with platform_type : linux_ 13:22:08 INFO - Initialising browser for dromaeo_css test... 13:22:08 INFO - TEST-INFO | started process 4446 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyKC8LY/profile http://localhost:59440/getInfo.html) 13:22:11 INFO - PROCESS | 4446 | __metrics Screen width/height:1600/1200 13:22:11 INFO - PROCESS | 4446 | colorDepth:24 13:22:11 INFO - PROCESS | 4446 | Browser inner width/height: 1024/697 13:22:11 INFO - PROCESS | 4446 | __metrics 13:22:12 INFO - PROCESS | 4446 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:22:13 INFO - TEST-INFO | 4446: exit 0 13:22:13 INFO - Browser initialized. 13:22:13 INFO - Running cycle 1/1 for dromaeo_css test... 13:22:13 INFO - TEST-INFO | started process 4541 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyKC8LY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:22:25 INFO - PROCESS | 4541 | RSS: Main: 148144128 13:22:25 INFO - PROCESS | 4541 | 13:23:16 INFO - PROCESS | 4541 | 1456003396375 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] 13:25:24 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:59440/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59440/tests/dromaeo/cssquery-ext.html) 13:25:25 INFO - PROCESS | 4541 | RSS: Main: 211267584 13:25:25 INFO - PROCESS | 4541 | 13:28:27 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:59440/tests/dromaeo/cssquery-ext.html (next: http://localhost:59440/tests/dromaeo/cssquery-jquery.html) 13:28:27 INFO - PROCESS | 4541 | RSS: Main: 232157184 13:28:27 INFO - PROCESS | 4541 | 13:31:29 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:59440/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59440/tests/dromaeo/cssquery-mootools.html) 13:31:30 INFO - PROCESS | 4541 | RSS: Main: 225976320 13:31:30 INFO - PROCESS | 4541 | 13:34:32 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:59440/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59440/tests/dromaeo/cssquery-prototype.html) 13:34:32 INFO - PROCESS | 4541 | RSS: Main: 212832256 13:34:32 INFO - PROCESS | 4541 | 13:37:35 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:59440/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59440/tests/dromaeo/cssquery-yui.html) 13:37:35 INFO - PROCESS | 4541 | RSS: Main: 210075648 13:37:35 INFO - PROCESS | 4541 | 13:40:38 INFO - PROCESS | 4541 | Cycle 1(1): loaded http://localhost:59440/tests/dromaeo/cssquery-yui.html (next: http://localhost:59440/tests/dromaeo/cssquery-dojo.html) 13:40:38 INFO - PROCESS | 4541 | RSS: Main: 262627328 13:40:38 INFO - PROCESS | 4541 | 13:40:38 INFO - PROCESS | 4541 | __start_tp_report 13:40:38 INFO - PROCESS | 4541 | _x_x_mozilla_page_load 13:40:38 INFO - PROCESS | 4541 | _x_x_mozilla_page_load_details 13:40:38 INFO - PROCESS | 4541 | |i|pagename|runs| 13:40:38 INFO - PROCESS | 4541 | |0;dojo.html;3062.877484900604;3081.306705991151;3116;3132.420502207092;3156.0374085903795;4916.680415772972;4960.751962401879;4968.701877887329;5010.849674509762;5046.495350464952;4913.066517361708;4942.258661200822;4977.7262250576205;4984.077945580061;5006.224035274529;4507.4365704286965;4636.304554316855;4646.907061858761;4738.455077666061;4748.715077095368;4507.72953622782;4580.083983203356;4691.9765401172945;4731.716097034172;4824.4210694716685;4631.050634619912;4656.883577910546;4676.859694209179;4684.297355396684;4706.670533062687;4637.652176086774;4641.466231383401;4685;4700;4715.457722361938;4520.231560634667;4535.954640453586;4602.79287432063;4626.768661566942;4678.532146785328;4844.5155484451625;4852.902941941176;4856.757162141914;4864.489228631013;4916.557509824097;5181.300524429192;5412.377576578704;5415.1335786274;5418.810341638024;5421.322334708161;5242.082635538765;5302.390225124122;5318.149096144598;5319.813806516753;5358.517733404013;5083.288339632454;5109.5145961134;5118.564921981636;5145.922811157836;5156.742162891878;5397.892042159135;5489.478499542537;5533.08704063833;5583.664980101207;5609.943900561024;5300.946990530122;5323.0950738373795;5323.148296272578;5324.946750532445;5325.988062268157;5332.226827110047;5338.679679219182;5338.839834804962;5348.91976620351;5383.057964856134;5203.609729270244;5284.550813180923;5332.7067011313975;5334.626576139711;5373.892522149535;5368.194770784414;5399;5410.810621628224;5411.080116380225;5415.729213539307;4126.442930204384;4203.684723645739;4211.810468528924;4219.092895027584;4263.914721705549;3837.1174629834736;3840.5391353037257;3840.635139661728;3854.710896682704;3857.035741064734;5118;5118.283440318359;5121.897562048813;5128.205128205134;5131.589472842164;5322.547583455373;5361.946380536223;5426.701531415731;5431.728413579305;5461.290032295776;5036.471170527042;5070.7464626768515;5081.720505372166;5083.822066227664;5139.152039913372;4489.685721999429;4652.023075154256;4657.0918670858855;4669.649776266793;4693.741844198602;5634.633748806396;5650;5684.175794509855;5687.544996400278;5736.282964629421;5380.11228147367;5383.2463455117095;5416.295881535533;5417.864553386197;5417.945820541744;5423.5932305076485;5628.493435590816;5647.971760141173;5702.45826646468;5724.341700704473;5281;5310.362756469094;5315.3090098286975;5316.494932981361;5318.494742999409;5377.758000889891;5378.19327100938;5383.7846486140115;5386.057439948072;5432.239486471818;5121.487851214849;5241.89516209666;5325.254464374913;5354.4110147884485;5402;5214.243934629533;5261.316028916216;5261.605379596622;5282.8943421132135;5354.009508240988;5006.874828129326;5197.298364720866;5220.347456567929;5237.266782650356;5241.50205730455;5312.070387682217;5325.467453254643;5329.467053294639;5343.812966546152;5349.3848207455085;5120.3087583177285;5152.896942061213;5161.071007218737;5213.322268105122;5245.659032162897 13:40:38 INFO - PROCESS | 4541 | |1;ext.html;518.8650950752804;545.04072831816;551.9999999999998;554.1521472147613;573.1603201310081;35953.64046359536;36709.44935825961;36719.26561468769;36739.632603673956;36793.26413471729;40653;41354;41363.79318103405;41369.17261654765;41375.79312103435;8474.44916080456;8690.130986901291;8714.607842647096;8717.651293948235;8720.084391138935;8570.400071994964;8691.39160258782;8696.913030869673;8701.738947831544;8702.912970870273;8629.69796057138;8694.782630434227;8716.912830871705;8729.956350218241;8735.475871447734;8615.224629783319;8703.390762646617;8707.695230666895;8712.1287871213;8713.172248636401;8474.364422668325;8606.139386061406;8634;8635;8639.956800216021;37674;37772.24455510902;37888.81055594732;37908;38100.42849357262;3040.771942104351;3091.922701932447;3131.4363414585364;3149.118246890874;3193.7764356495054;29928.675162203304;30194.24514387158;30425.69574304273;30647.69352306493;31261.531077033862;3893.805309734502;3894.369448761036;4001.1197536541913;4021.698372622036;4034.9596504034876;337566;342121;342368.2881585601;342496;342704;56833;57634.423655762905;57673.94423585547;57724;57754.42245577575;58627.41372586305;59364.703176484705;59414.70292648595;59442;61376.693116535025;15095.245237738069;15352;15412.46056388021;15412.614684632974;15432.459863904709;11114.499847506882;11253.606123785628;11267.492962816694;11275.267107637977;11496;18523.907380463283;19988;20497.38507844767;21280;21281;7757.961210193913;7907.169747176578;7933.801654958672;8071.636776345079;8199.303059240032;970.7718686108759;982.8820541535061;991.0733464210986;993.6770549571419;1104.745908441063;28738.712612873605;29155.562666560018;29437.85281073581;29535.26161845928;30836.845815771227;995.6017592962728;999.14073896449;1006.5621454667244;1009.7273736091361;1112.2881355932209;14712.264386780618;16532.669346613002;16732.749008764877;16775.161241937854;16886.83113168877;429755;433102;437684;438564;439578;56357;57152.714236428554;57313.42686573164;57345;57349.426505735246;1289.0332250811891;1291.6770807298176;1304.5173285884284;1308.3196737696535;1323.7815760399426;29514.96697615573;30909.42682092582;31199.532007020367;31277.218069548442;31685.683143168273;46662.53337466582;47169.29246061243;47337.52662473331;47399.76300118477;47408.762956185;307567;311670;311868;312119;312702;31489.8425507871;32936.34127317488;33021.17447063747;33075;33155.83422082874;42263.7886810564;43726.56273437225;43886;44111.77944110259;44316.55683443124;36087.27825443529;37136;37359.43960840644;37609;38143;36262;36395.27209455743;37308.440373394966;37517.81241093886;37884.81057594695;35850.10374740548;36349.45475817812;36781.26437471289;36801;36875;31691.366172675956;32876.50685239676;33222;33379.33241335208;33538.32923341568;24901.252962411156;25040.749592503842;25421.74578254268;25529.489410212063;25630.615540767278 13:40:38 INFO - PROCESS | 4541 | |2;jquery.html;334.62856229585174;354.62586970745866;358.79010778694465;359.8308794866412;361.2612208034569;12902.870971290284;16499.83500164998;17215.913920430397;17615.11924403781;17621.55946101348;16131.919340403281;16669.24988375523;17420.39028633998;17471.213795379208;17471.91264043678;3983.9203215935663;5231.398389185245;5399.946000540003;5815.796447124351;6084.787032453865;5973.104034394853;6002.279726432834;6082.300535438415;6118.785842495514;6120.877582448348;5684.943150568503;5826.621269617462;6009.068594367858;6010.36891126432;6013.428724271209;5770.653760774346;5814.534837213034;5907.645541267516;6074.119252708377;6105.419985101408;5083.79664813407;5344.866378340534;5353.304070470814;5358.089124848785;5382.138857782736;13629.25039122848;13650.317484125853;15975.680486390207;20563.691544626843;20904.79095209059;2033.8169564739244;2113.3765539165984;2154.310620601408;2531.7594828491265;2570.306017375317;9764.023597640251;10134.695959121238;11054.949779770908;11265.60570380041;13581.049326547145;1863.506170864722;1881.0970734047596;1903.809619038099;1907.0845993922994;1910.6274276516085;60642.696786515786;65109;65767.67116164388;66313.66843165802;67366.66316668435;10337.896621033693;10351.63769268072;10416.635417760343;10457.215708821868;10513.57945682164;13108.606741797761;13470.595882123553;13526.661833454242;13546.119502232323;13585.864141358657;7301.707931682673;7312.890306645405;7349.853002939912;7433.070866141732;7551.697932082765;6408.231012278463;6943.89584156238;6966.1988871280455;7244.529105608224;7277.963610181915;4381.101874115862;4544.522825103382;4584.954150458453;4593;4595.931061034087;1854.6661600911966;1859.907004649762;1861.5799460701035;1887.9150438230313;1899.240303878432;767.4896194031019;849.5327569836566;850.4174640371366;860.7977125375531;953.02315126994;15320.770188447183;15852.841471585367;16162;16244.918775406048;16431.5892102696;894.8344556257114;914.4147745442922;925.3013974449248;937.5031233446148;940.8071345374182;7184;8563.357748168912;9151.581504866755;9712.417254964725;9786.657466988621;376350;376441;390074;400815;424222;71809.6409517949;74003.62998185083;74203;74356.62821685857;75061.99752009967;996.6013594562088;1000.6697789729371;1042.5360714481983;1048.905598496139;1051.3271506236015;14707.852921470649;14875.181864997528;14956.102633842005;14966.551003469913;15135.772963405338;31503.369932600763;32496.187595310308;32599.837000814845;32918.67081329156;33192.17019574434;43858.342124867515;44161.55838441703;44292.33561496516;44840;45885.31172032489;7903.486273392211;8059.677612895419;8116.553589552631;8146.674133034612;8212.137725538732;11009.449527523431;11928.821067683819;12124.211926224767;12296.75406491883;12353.135280530276;7285.380742636935;10313.174946004452;10524.545566959318;10748.032677059102;11084.334939903632;7805.5706936116785;10262.846057308998;10409.9479502602;10492.527836247235;10514;10291.33106348085;10810.621628243289;10835.187360947803;10859.619913302997;10899.455027248765;7735.071791385069;7893.09229438599;7919.564423956507;7925.960370198112;7941.682332706858;9467.905320946978;10065.144462720458;10583.417912014913;10866.239363244496;10949.616763413242 13:40:38 INFO - PROCESS | 4541 | |3;mootools.html;1359.9252041137734;1422.2959634980687;1448.5943935698;1618.8381161883806;1807.7921039080502;6836.4189043931265;7389.81525461863;7532.17146113927;7543.245675432454;7569.621518924052;7495.737649182266;7624.809379765508;7646.885296720554;7654.3111119999185;7658.425618078652;1918.6162767446497;2211.845170838042;2242.686023956643;2266.5580211858696;2271.0234599122373;2246.9887650561805;2297.8161747060194;2307.4346785037606;2314.2710046335433;2316.397736588482;2179;2199.59307528107;2202.0751284460566;2204.371754050096;2204.8236141108673;2146.399008277685;2174.13034786086;2230.5650398172284;2230.698855654482;2232.8102111320395;2178.0852042142337;2191.7589065202815;2200.6698995150696;2216.390492614528;2218.2901471529117;7692.076950765888;7757.72847950319;7759.146493885668;7772.455928085036;7782.610869456505;4470.597646211857;4598.793054312564;4623.514530974233;4630.953690463086;4636.698614590041;2883.5674648802637;2916.416716656656;2957.526795712697;3017.109952563977;3025.8638361273797;959.7600599850037;961.1781926452852;991.2417000994245;996.1930836022844;996.8903420623726;10454.52954617044;10491.947540262327;10498.685039448752;10504.212184086147;10520.158387328995;4039.5758445363404;4076.7553946763287;4127.607877251657;4180.101278225196;4181.60274773896;9054;9101.40840845343;9116.908830911738;9118.635254589875;9134.451932884049;4198.076423186894;4619.653525985565;4703.835365762182;4735.289706544046;4736.029114031684;4264.701470897069;4273.081287523198;4305.268104422255;4314.633256173261;4322.113966636832;3559.839807208682;3571.1072231942017;3582.247727977102;3618.2763447310117;3620.7465477416326;1078.7033565769477;1110.4669758515797;1124.6344937895053;1125.431657013203;1132.932024078558;1253.354522420954;1258.8237646729465;1286.7941129419248;1309.7576948264602;1310.1091257944688;7217.92782072183;7321.926780732231;7356.337929586363;7376.041114655168;7380.372668323145;1099.571167244775;1102.311055590256;1106.7067227184803;1108.2408550143177;1149.4884776274646;5386.461353864583;5389.461053894657;5432.728363581805;5435.266239057677;5442.265294185234;8675.869861952076;8827.117288271122;9014.504202268807;9195.816083678288;9217.631294748135;9185.081491850762;9211;9279.860802087975;9291.256699464027;9385.5307234638;7123.180834204029;7219.963900180465;7278.053852999182;7359.742409015659;7401;6952.478564107813;6996.720131194696;7034.015237866805;7040.964795176196;7066.540674856118;7931.493016326879;8299.834003319778;8311.293540049164;8449;8450.028246751703;8314.958425207835;8661.956690216508;8666.263367613823;8673.956630216808;8677.913220867711;6483.546151769331;6506.41442270198;6608.140941677743;6628.966855165693;6629.038789375417;7412.221716719667;7433.776986690408;7485.887711684438;7488.887666685113;7490.812729681584;6721.495887808336;6805.693743781443;6889.724411023503;6916.896246556205;7033.120859892513;6718.496112791658;6719.697613607497;6765.391114799691;6805.693743781443;6855.965720171367;6907.20567134786;6908.5509441886115;7040.612766297902;7089.503734738519;7090.787276381717;6271.874562508816;6334.429901308904;6340.080688300263;6360.109584658244;6370.74517019314;6535.901961470677;6589.4069533742195;6598.10925525048;6600.966995165186;6606.735730570724 13:40:38 INFO - PROCESS | 4541 | |4;prototype.html;332.1795165940128;334.2896345266309;336.789506558401;341.7232042045945;343.1250311705153;5671.149327600862;5812.215350927623;5816.360200377955;5824.2625965796005;5831.446012628799;5613.887722245553;5696.202531645563;5731.111677689964;5734.942650573504;5753.712314384275;4507.729536227828;4536.863894083166;4543.65922555808;4549.24937385331;4550.567696068868;4319.265724826787;4434.97782511087;4539.682222244444;4542.704724192917;4548.658850586203;4493.438320209973;4501.572350626685;4501.909961800762;4515.525869783674;4537.818487260505;4518.796654150555;4527.683062185648;4528.909421811545;4534.9319760203625;4545.954540454586;4011.6991225657903;4014.959850401517;4016.5581786003518;4020.0552870075508;4028.0735430850777;5510.504054635102;5565.499105080522;5575.972120139414;5585.162225666142;5601.719914004283;5232.6598771080135;5265.420803711589;5266.104762190437;5268.5521730652945;5282.550983166436;6144.477719393857;6150.938490615082;6154.938450615481;6156.692165391757;6158.3841615838055;4403.735775853459;4425.291953287491;4432.977835110836;4437.267850804646;4438.356438316426;6226.533010024266;6454.741810327581;6469.320721324288;6473.74105035798;6485.7405703772265;4382.846600368972;4397.07661391105;4406.647468202536;4407.581279778416;4414.448193975753;4435.933460998088;4439.800208990603;4447.177272204653;4449.599536041772;4451.844185453494;5157.432682404932;5160.432352441228;5162.354705661793;5162.45794191612;5164.92252616211;5978.850528736816;6067.787627433018;6228.408301211378;6231.532635052389;6236.469900058546;1506.1113942773816;1550.0312304809495;1556.4630202580092;1559.9220038998005;1561.2505997121445;1020.7039958412125;1024.7335692719946;1026.712520494263;1041.5052849896238;1042.5464922758472;5813.680247586423;5828.795992140254;5833.591648584558;5835.9708201458725;5873.588848780544;6265.4361107499635;6271.749130034838;6272.780452684134;6283.842903927347;6287.1512345832725;5825.242718446575;5826.388229235954;5827.184194212814;5828.12578113278;5830.38780928005;3306.454435018195;3408.3183363327435;3409.7783644063056;3411.334789716031;3411.8976430707116;6584.30864759203;6601.108850305147;6614.470842332602;6614.768483103068;6616.933830661728;6427.453666438405;6435.292117867031;6441.194850643669;6443.452306553995;6447.323031081763;6429.678516074177;6602.207735071822;6602.735890564323;6620.602763834186;6624.900626490607;6255.78104766331;6256.593321434092;6281.403266689657;6284.780032698834;6286.937130628635;6220.222472190976;6226.283977342482;6227.034809604518;6229.4393504584805;6231.065340198825;6538.967305163444;6618.7352505899225;6620.602763834186;6777.966110169417;6778.796636100925;4362.236608593547;4379.080393117481;4390.495093064211;4400.251957167226;4410.073884484166;6198.411150940653;6323.810285691437;6452;6456.160699109086;6463.709133088928;6250.812475625738;6257.217847769029;6258.030005349178;6267.905981410374;6273.341299163522;6257.186565746424;6257.624542527463;6260.812175634556;6263.935131027827;6267.811965641038;6039.456448919618;6128.662923539248;6152.723127459365;6165.537584681257;6168.660723660242;6229.657368844757;6260.593061450991;6264.31092579825;6273.498120150286;6276.9372306276355;6061.636301821728;6077.604955677867;6077.696115194134;6117.877642447037;6120.143179954899 13:40:38 INFO - PROCESS | 4541 | |5;yui.html;655.1352215076096;664.0570390046134;668.8963210702343;780.2041917244411;809.7368355284532;12717.364131793409;12865.485380584778;12876.484940602388;12892.742145157103;12911.160774549648;12012.519499220043;12202.267863928148;12226.083043771709;12228.816567751468;12231.69420764479;685.6674512861258;689.465664110316;802.4743792815715;810.5784991804244;832.6086739232582;826.305903041445;828.0146625515617;831.0359982420393;832.1678321678322;834.4367551902471;871.0331531999476;877.1097336203758;877.4779006491127;877.8507653698855;877.8858748362736;704.4857254204409;860.1699360117485;870.8780770692108;871.6121326009896;873.7859224489977;638.3743930947651;640.942315191635;643.0193954219806;643.4305639509068;643.6331291163991;12954;12965.61103166897;13049.217046977212;13087.738245235041;13119.540816071487;12982.675433114153;13209.339533023407;13365.732685346238;13385.866141338656;13404.396802143927;10799.298045627087;10830.945845270802;10869.782604347947;10989.890101098967;11009.339439633648;3575.928481430383;3657.4148136298063;3681.1533347329996;3705.2033812730124;3708.2398108387715;49414.50585494135;49423.75288123573;49560.256596151085;49603;49770.25344619834;10069.395836249849;10330.431826249478;10431.791364172826;10440.269181157246;10490.475476226158;17679.911600442174;17703.38038168658;17717.645647086985;17791.73312400315;17856.19647115883;7515.361194298436;7964.522128672298;8018.719344822904;8252.628631711588;8266.793330166794;4367.847125350598;4390.165868484977;4442.888927776831;4461.598456138898;4568.1548913451115;3052.4200401923563;3082.676318986519;3085.105319457377;3094.4275309067893;3105.767067469949;505.6612069913167;513.8175947538645;584.8245526342165;588.6173986908543;611.7767015039567;495.5960891873184;549.5383877542803;602.9186059881947;651.2900937977627;661.5699795133106;7775.183605721431;8050;8182.590870456454;8198.631061602242;8632.266257368194;615.4891440104702;622.4211483320555;623.8689875126183;638.4955884851008;641.425923798198;3833.9041523962123;3846.0201339948467;3900.4344370066183;4074.6129117733767;4148.149629325981;53665.46334536605;54170;54262;54755;54953.45046549563;47658.285125723145;48203.276950845764;49531.75234123806;50147.49852501501;50388;43324.350134748005;43713.34429983553;43737.34393984029;44025.55974440215;44324;8062.193780621891;8433.28317093054;8458.74623761288;8503.914960850312;8579.742607721779;32974.83512582422;33289.334213316084;33328.50007249845;33547.496787547716;33997.15007124842;41294;41673.37489937714;42032.15935681208;42846.35730464108;42931.570684292754;10509.106725928381;10671.839922401015;10776.245662803529;10877.129829613454;11197.44012799373;9817.852732209165;11609.30344179352;11673;11754.177207595387;12293;11013.174011949297;11402.714932126763;11610.303381797119;11646.94176529112;11674.416279186176;11065.612703555336;11332.6033588824;11500.137489688474;11522.596709115141;11820;11113.320672546193;11313.660590182308;11383.430828458379;11434.82847757301;11598.768024639292;9258.099470142122;9310.860337095084;9415.670451534437;9429.387089839138;9675.080867317594;8570.871436928575;9444.622215111318;9526.952365238129;9763.755906102404;10306.33008854452 13:40:38 INFO - PROCESS | 4541 | __end_tp_report 13:40:38 INFO - PROCESS | 4541 | __start_cc_report 13:40:38 INFO - PROCESS | 4541 | _x_x_mozilla_cycle_collect,729 13:40:38 INFO - PROCESS | 4541 | __end_cc_report 13:40:38 INFO - PROCESS | 4541 | __startTimestamp1456004438859__endTimestamp 13:40:38 INFO - PROCESS | 4541 | 13:40:38 INFO - PROCESS | 4541 | ------- Summary: start ------- 13:40:38 INFO - PROCESS | 4541 | Number of tests: 6 13:40:38 INFO - PROCESS | 4541 | 13:40:38 INFO - PROCESS | 4541 | [#0] dojo.html Cycles:165 Average:5025.32 Median:5203.61 stddev:528.24 (10.2%) stddev-sans-first:506.93 13:40:38 INFO - PROCESS | 4541 | Values: 3062.9 3081.3 3116.0 3132.4 3156.0 4916.7 4960.8 4968.7 5010.8 5046.5 4913.1 4942.3 4977.7 4984.1 5006.2 4507.4 4636.3 4646.9 4738.5 4748.7 4507.7 4580.1 4692.0 4731.7 4824.4 4631.1 4656.9 4676.9 4684.3 4706.7 4637.7 4641.5 4685.0 4700.0 4715.5 4520.2 4536.0 4602.8 4626.8 4678.5 4844.5 4852.9 4856.8 4864.5 4916.6 5181.3 5412.4 5415.1 5418.8 5421.3 5242.1 5302.4 5318.1 5319.8 5358.5 5083.3 5109.5 5118.6 5145.9 5156.7 5397.9 5489.5 5533.1 5583.7 5609.9 5300.9 5323.1 5323.1 5324.9 5326.0 5332.2 5338.7 5338.8 5348.9 5383.1 5203.6 5284.6 5332.7 5334.6 5373.9 5368.2 5399.0 5410.8 5411.1 5415.7 4126.4 4203.7 4211.8 4219.1 4263.9 3837.1 3840.5 3840.6 3854.7 3857.0 5118.0 5118.3 5121.9 5128.2 5131.6 5322.5 5361.9 5426.7 5431.7 5461.3 5036.5 5070.7 5081.7 5083.8 5139.2 4489.7 4652.0 4657.1 4669.6 4693.7 5634.6 5650.0 5684.2 5687.5 5736.3 5380.1 5383.2 5416.3 5417.9 5417.9 5423.6 5628.5 5648.0 5702.5 5724.3 5281.0 5310.4 5315.3 5316.5 5318.5 5377.8 5378.2 5383.8 5386.1 5432.2 5121.5 5241.9 5325.3 5354.4 5402.0 5214.2 5261.3 5261.6 5282.9 5354.0 5006.9 5197.3 5220.3 5237.3 5241.5 5312.1 5325.5 5329.5 5343.8 5349.4 5120.3 5152.9 5161.1 5213.3 5245.7 13:40:38 INFO - PROCESS | 4541 | 13:40:38 INFO - PROCESS | 4541 | [#1] ext.html Cycles:180 Average:52431.12 Median:37563.41 stddev:96626.18 (257.2%) stddev-sans-first:96818.64 13:40:38 INFO - PROCESS | 4541 | Values: 518.9 545.0 552.0 554.2 573.2 35953.6 36709.4 36719.3 36739.6 36793.3 40653.0 41354.0 41363.8 41369.2 41375.8 8474.4 8690.1 8714.6 8717.7 8720.1 8570.4 8691.4 8696.9 8701.7 8702.9 8629.7 8694.8 8716.9 8730.0 8735.5 8615.2 8703.4 8707.7 8712.1 8713.2 8474.4 8606.1 8634.0 8635.0 8640.0 37674.0 37772.2 37888.8 37908.0 38100.4 3040.8 3091.9 3131.4 3149.1 3193.8 29928.7 30194.2 30425.7 30647.7 31261.5 3893.8 3894.4 4001.1 4021.7 4035.0 337566.0 342121.0 342368.3 342496.0 342704.0 56833.0 57634.4 57673.9 57724.0 57754.4 58627.4 59364.7 59414.7 59442.0 61376.7 15095.2 15352.0 15412.5 15412.6 15432.5 11114.5 11253.6 11267.5 11275.3 11496.0 18523.9 19988.0 20497.4 21280.0 21281.0 7758.0 7907.2 7933.8 8071.6 8199.3 970.8 982.9 991.1 993.7 1104.7 28738.7 29155.6 29437.9 29535.3 30836.8 995.6 999.1 1006.6 1009.7 1112.3 14712.3 16532.7 16732.7 16775.2 16886.8 429755.0 433102.0 437684.0 438564.0 439578.0 56357.0 57152.7 57313.4 57345.0 57349.4 1289.0 1291.7 1304.5 1308.3 1323.8 29515.0 30909.4 31199.5 31277.2 31685.7 46662.5 47169.3 47337.5 47399.8 47408.8 307567.0 311670.0 311868.0 312119.0 312702.0 31489.8 32936.3 33021.2 33075.0 33155.8 42263.8 43726.6 43886.0 44111.8 44316.6 36087.3 37136.0 37359.4 37609.0 38143.0 36262.0 36395.3 37308.4 37517.8 37884.8 35850.1 36349.5 36781.3 36801.0 36875.0 31691.4 32876.5 33222.0 33379.3 33538.3 24901.3 25040.7 25421.7 25529.5 25630.6 13:40:38 INFO - PROCESS | 4541 | 13:40:38 INFO - PROCESS | 4541 | [#2] jquery.html Cycles:180 Average:23899.49 Median:376395.50 stddev:64781.21 (17.2%) stddev-sans-first:64938.77 13:40:38 INFO - PROCESS | 4541 | Values: 334.6 354.6 358.8 359.8 361.3 12902.9 16499.8 17215.9 17615.1 17621.6 16131.9 16669.2 17420.4 17471.2 17471.9 3983.9 5231.4 5399.9 5815.8 6084.8 5973.1 6002.3 6082.3 6118.8 6120.9 5684.9 5826.6 6009.1 6010.4 6013.4 5770.7 5814.5 5907.6 6074.1 6105.4 5083.8 5344.9 5353.3 5358.1 5382.1 13629.3 13650.3 15975.7 20563.7 20904.8 2033.8 2113.4 2154.3 2531.8 2570.3 9764.0 10134.7 11054.9 11265.6 13581.0 1863.5 1881.1 1903.8 1907.1 1910.6 60642.7 65109.0 65767.7 66313.7 67366.7 10337.9 10351.6 10416.6 10457.2 10513.6 13108.6 13470.6 13526.7 13546.1 13585.9 7301.7 7312.9 7349.9 7433.1 7551.7 6408.2 6943.9 6966.2 7244.5 7278.0 4381.1 4544.5 4585.0 4593.0 4595.9 1854.7 1859.9 1861.6 1887.9 1899.2 767.5 849.5 850.4 860.8 953.0 15320.8 15852.8 16162.0 16244.9 16431.6 894.8 914.4 925.3 937.5 940.8 7184.0 8563.4 9151.6 9712.4 9786.7 376350.0 376441.0 390074.0 400815.0 424222.0 71809.6 74003.6 74203.0 74356.6 75062.0 996.6 1000.7 1042.5 1048.9 1051.3 14707.9 14875.2 14956.1 14966.6 15135.8 31503.4 32496.2 32599.8 32918.7 33192.2 43858.3 44161.6 44292.3 44840.0 45885.3 7903.5 8059.7 8116.6 8146.7 8212.1 11009.4 11928.8 12124.2 12296.8 12353.1 7285.4 10313.2 10524.5 10748.0 11084.3 7805.6 10262.8 10409.9 10492.5 10514.0 10291.3 10810.6 10835.2 10859.6 10899.5 7735.1 7893.1 7919.6 7926.0 7941.7 9467.9 10065.1 10583.4 10866.2 10949.6 13:40:38 INFO - PROCESS | 4541 | 13:40:38 INFO - PROCESS | 4541 | [#3] mootools.html Cycles:180 Average:5372.23 Median:6494.98 stddev:2783.65 (42.9%) stddev-sans-first:2775.12 13:40:38 INFO - PROCESS | 4541 | Values: 1359.9 1422.3 1448.6 1618.8 1807.8 6836.4 7389.8 7532.2 7543.2 7569.6 7495.7 7624.8 7646.9 7654.3 7658.4 1918.6 2211.8 2242.7 2266.6 2271.0 2247.0 2297.8 2307.4 2314.3 2316.4 2179.0 2199.6 2202.1 2204.4 2204.8 2146.4 2174.1 2230.6 2230.7 2232.8 2178.1 2191.8 2200.7 2216.4 2218.3 7692.1 7757.7 7759.1 7772.5 7782.6 4470.6 4598.8 4623.5 4631.0 4636.7 2883.6 2916.4 2957.5 3017.1 3025.9 959.8 961.2 991.2 996.2 996.9 10454.5 10491.9 10498.7 10504.2 10520.2 4039.6 4076.8 4127.6 4180.1 4181.6 9054.0 9101.4 9116.9 9118.6 9134.5 4198.1 4619.7 4703.8 4735.3 4736.0 4264.7 4273.1 4305.3 4314.6 4322.1 3559.8 3571.1 3582.2 3618.3 3620.7 1078.7 1110.5 1124.6 1125.4 1132.9 1253.4 1258.8 1286.8 1309.8 1310.1 7217.9 7321.9 7356.3 7376.0 7380.4 1099.6 1102.3 1106.7 1108.2 1149.5 5386.5 5389.5 5432.7 5435.3 5442.3 8675.9 8827.1 9014.5 9195.8 9217.6 9185.1 9211.0 9279.9 9291.3 9385.5 7123.2 7220.0 7278.1 7359.7 7401.0 6952.5 6996.7 7034.0 7041.0 7066.5 7931.5 8299.8 8311.3 8449.0 8450.0 8315.0 8662.0 8666.3 8674.0 8677.9 6483.5 6506.4 6608.1 6629.0 6629.0 7412.2 7433.8 7485.9 7488.9 7490.8 6721.5 6805.7 6889.7 6916.9 7033.1 6718.5 6719.7 6765.4 6805.7 6856.0 6907.2 6908.6 7040.6 7089.5 7090.8 6271.9 6334.4 6340.1 6360.1 6370.7 6535.9 6589.4 6598.1 6601.0 6606.7 13:40:38 INFO - PROCESS | 4541 | 13:40:38 INFO - PROCESS | 4541 | [#4] prototype.html Cycles:180 Average:5176.91 Median:5825.82 stddev:1546.65 (26.5%) stddev-sans-first:1507.64 13:40:38 INFO - PROCESS | 4541 | Values: 332.2 334.3 336.8 341.7 343.1 5671.1 5812.2 5816.4 5824.3 5831.4 5613.9 5696.2 5731.1 5734.9 5753.7 4507.7 4536.9 4543.7 4549.2 4550.6 4319.3 4435.0 4539.7 4542.7 4548.7 4493.4 4501.6 4501.9 4515.5 4537.8 4518.8 4527.7 4528.9 4534.9 4546.0 4011.7 4015.0 4016.6 4020.1 4028.1 5510.5 5565.5 5576.0 5585.2 5601.7 5232.7 5265.4 5266.1 5268.6 5282.6 6144.5 6150.9 6154.9 6156.7 6158.4 4403.7 4425.3 4433.0 4437.3 4438.4 6226.5 6454.7 6469.3 6473.7 6485.7 4382.8 4397.1 4406.6 4407.6 4414.4 4435.9 4439.8 4447.2 4449.6 4451.8 5157.4 5160.4 5162.4 5162.5 5164.9 5978.9 6067.8 6228.4 6231.5 6236.5 1506.1 1550.0 1556.5 1559.9 1561.3 1020.7 1024.7 1026.7 1041.5 1042.5 5813.7 5828.8 5833.6 5836.0 5873.6 6265.4 6271.7 6272.8 6283.8 6287.2 5825.2 5826.4 5827.2 5828.1 5830.4 3306.5 3408.3 3409.8 3411.3 3411.9 6584.3 6601.1 6614.5 6614.8 6616.9 6427.5 6435.3 6441.2 6443.5 6447.3 6429.7 6602.2 6602.7 6620.6 6624.9 6255.8 6256.6 6281.4 6284.8 6286.9 6220.2 6226.3 6227.0 6229.4 6231.1 6539.0 6618.7 6620.6 6778.0 6778.8 4362.2 4379.1 4390.5 4400.3 4410.1 6198.4 6323.8 6452.0 6456.2 6463.7 6250.8 6257.2 6258.0 6267.9 6273.3 6257.2 6257.6 6260.8 6263.9 6267.8 6039.5 6128.7 6152.7 6165.5 6168.7 6229.7 6260.6 6264.3 6273.5 6276.9 6061.6 6077.6 6077.7 6117.9 6120.1 13:40:38 INFO - PROCESS | 4541 | 13:40:38 INFO - PROCESS | 4541 | [#5] yui.html Cycles:180 Average:13458.14 Median:44174.78 stddev:15328.91 (34.7%) stddev-sans-first:15341.76 13:40:38 INFO - PROCESS | 4541 | Values: 655.1 664.1 668.9 780.2 809.7 12717.4 12865.5 12876.5 12892.7 12911.2 12012.5 12202.3 12226.1 12228.8 12231.7 685.7 689.5 802.5 810.6 832.6 826.3 828.0 831.0 832.2 834.4 871.0 877.1 877.5 877.9 877.9 704.5 860.2 870.9 871.6 873.8 638.4 640.9 643.0 643.4 643.6 12954.0 12965.6 13049.2 13087.7 13119.5 12982.7 13209.3 13365.7 13385.9 13404.4 10799.3 10830.9 10869.8 10989.9 11009.3 3575.9 3657.4 3681.2 3705.2 3708.2 49414.5 49423.8 49560.3 49603.0 49770.3 10069.4 10330.4 10431.8 10440.3 10490.5 17679.9 17703.4 17717.6 17791.7 17856.2 7515.4 7964.5 8018.7 8252.6 8266.8 4367.8 4390.2 4442.9 4461.6 4568.2 3052.4 3082.7 3085.1 3094.4 3105.8 505.7 513.8 584.8 588.6 611.8 495.6 549.5 602.9 651.3 661.6 7775.2 8050.0 8182.6 8198.6 8632.3 615.5 622.4 623.9 638.5 641.4 3833.9 3846.0 3900.4 4074.6 4148.1 53665.5 54170.0 54262.0 54755.0 54953.5 47658.3 48203.3 49531.8 50147.5 50388.0 43324.4 43713.3 43737.3 44025.6 44324.0 8062.2 8433.3 8458.7 8503.9 8579.7 32974.8 33289.3 33328.5 33547.5 33997.2 41294.0 41673.4 42032.2 42846.4 42931.6 10509.1 10671.8 10776.2 10877.1 11197.4 9817.9 11609.3 11673.0 11754.2 12293.0 11013.2 11402.7 11610.3 11646.9 11674.4 11065.6 11332.6 11500.1 11522.6 11820.0 11113.3 11313.7 11383.4 11434.8 11598.8 9258.1 9310.9 9415.7 9429.4 9675.1 8570.9 9444.6 9527.0 9763.8 10306.3 13:40:38 INFO - PROCESS | 4541 | -------- Summary: end -------- 13:40:38 INFO - PROCESS | 4541 | 13:40:39 INFO - TEST-INFO | 4541: exit 0 13:40:39 INFO - TEST-OK | dromaeo_css | took 1111544ms 13:40:39 INFO - TEST-START | kraken 13:40:39 INFO - operating with platform_type : linux_ 13:40:39 INFO - Initialising browser for kraken test... 13:40:39 INFO - TEST-INFO | started process 4723 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoOplFj/profile http://localhost:59440/getInfo.html) 13:40:43 INFO - PROCESS | 4723 | __metrics Screen width/height:1600/1200 13:40:43 INFO - PROCESS | 4723 | colorDepth:24 13:40:43 INFO - PROCESS | 4723 | Browser inner width/height: 1024/697 13:40:43 INFO - PROCESS | 4723 | __metrics 13:40:44 INFO - PROCESS | 4723 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:40:45 INFO - TEST-INFO | 4723: exit 0 13:40:45 INFO - Browser initialized. 13:40:45 INFO - Running cycle 1/1 for kraken test... 13:40:45 INFO - TEST-INFO | started process 4805 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoOplFj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:40:56 INFO - PROCESS | 4805 | RSS: Main: 147574784 13:40:56 INFO - PROCESS | 4805 | 13:40:59 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59440/tests/kraken/driver.html?testName=audio-beat-detection) 13:40:59 INFO - PROCESS | 4805 | RSS: Main: 191524864 13:40:59 INFO - PROCESS | 4805 | 13:41:02 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59440/tests/kraken/driver.html?testName=audio-dft) 13:41:03 INFO - PROCESS | 4805 | RSS: Main: 179941376 13:41:03 INFO - PROCESS | 4805 | 13:41:06 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59440/tests/kraken/driver.html?testName=audio-fft) 13:41:06 INFO - PROCESS | 4805 | RSS: Main: 166277120 13:41:06 INFO - PROCESS | 4805 | 13:41:08 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59440/tests/kraken/driver.html?testName=audio-oscillator) 13:41:09 INFO - PROCESS | 4805 | RSS: Main: 167104512 13:41:09 INFO - PROCESS | 4805 | 13:41:11 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59440/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:41:12 INFO - PROCESS | 4805 | RSS: Main: 168755200 13:41:12 INFO - PROCESS | 4805 | 13:41:15 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59440/tests/kraken/driver.html?testName=imaging-darkroom) 13:41:15 INFO - PROCESS | 4805 | RSS: Main: 170881024 13:41:15 INFO - PROCESS | 4805 | 13:41:18 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59440/tests/kraken/driver.html?testName=imaging-desaturate) 13:41:19 INFO - PROCESS | 4805 | RSS: Main: 170102784 13:41:19 INFO - PROCESS | 4805 | 13:41:22 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59440/tests/kraken/driver.html?testName=json-parse-financial) 13:41:22 INFO - PROCESS | 4805 | RSS: Main: 170016768 13:41:22 INFO - PROCESS | 4805 | 13:41:24 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59440/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:41:25 INFO - PROCESS | 4805 | RSS: Main: 181780480 13:41:25 INFO - PROCESS | 4805 | 13:41:26 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59440/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:41:27 INFO - PROCESS | 4805 | RSS: Main: 177897472 13:41:27 INFO - PROCESS | 4805 | 13:41:29 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59440/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:41:30 INFO - PROCESS | 4805 | RSS: Main: 191930368 13:41:30 INFO - PROCESS | 4805 | 13:41:32 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:41:33 INFO - PROCESS | 4805 | RSS: Main: 198823936 13:41:33 INFO - PROCESS | 4805 | 13:41:35 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:41:36 INFO - PROCESS | 4805 | RSS: Main: 198918144 13:41:36 INFO - PROCESS | 4805 | 13:41:37 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:59440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59440/tests/kraken/driver.html?testName=ai-astar) 13:41:38 INFO - PROCESS | 4805 | RSS: Main: 260046848 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | __start_tp_report 13:41:38 INFO - PROCESS | 4805 | _x_x_mozilla_page_load 13:41:38 INFO - PROCESS | 4805 | _x_x_mozilla_page_load_details 13:41:38 INFO - PROCESS | 4805 | |i|pagename|runs| 13:41:38 INFO - PROCESS | 4805 | |0;ai-astar;110;112;107;111;113;113;100;112;111;112 13:41:38 INFO - PROCESS | 4805 | |1;audio-beat-detection;149;125;145;158;125;149;151;132;176;136 13:41:38 INFO - PROCESS | 4805 | |2;audio-dft;163;164;162;163;160;161;159;163;161;161 13:41:38 INFO - PROCESS | 4805 | |3;audio-fft;72;73;108;93;73;73;73;106;95;73 13:41:38 INFO - PROCESS | 4805 | |4;audio-oscillator;96;96;148;95;96;96;149;96;97;150 13:41:38 INFO - PROCESS | 4805 | |5;imaging-gaussian-blur;119;116;115;114;114;115;115;114;114;114 13:41:38 INFO - PROCESS | 4805 | |6;imaging-darkroom;146;144;146;146;145;145;146;145;145;146 13:41:38 INFO - PROCESS | 4805 | |7;imaging-desaturate;97;96;97;96;96;96;96;97;96;96 13:41:38 INFO - PROCESS | 4805 | |8;json-parse-financial;58;57;58;57;57;59;58;67;56;55 13:41:38 INFO - PROCESS | 4805 | |9;json-stringify-tinderbox;66;67;67;67;67;68;67;68;68;68 13:41:38 INFO - PROCESS | 4805 | |10;stanford-crypto-aes;81;90;82;84;82;81;89;81;89;83 13:41:38 INFO - PROCESS | 4805 | |11;stanford-crypto-ccm;123;116;124;122;117;119;116;124;124;120 13:41:38 INFO - PROCESS | 4805 | |12;stanford-crypto-pbkdf2;149;139;162;150;151;137;141;149;152;151 13:41:38 INFO - PROCESS | 4805 | |13;stanford-crypto-sha256-iterative;68;69;71;70;68;70;69;71;71;68 13:41:38 INFO - PROCESS | 4805 | __end_tp_report 13:41:38 INFO - PROCESS | 4805 | __start_cc_report 13:41:38 INFO - PROCESS | 4805 | _x_x_mozilla_cycle_collect,957 13:41:38 INFO - PROCESS | 4805 | __end_cc_report 13:41:38 INFO - PROCESS | 4805 | __startTimestamp1456004498179__endTimestamp 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | ------- Summary: start ------- 13:41:38 INFO - PROCESS | 4805 | Number of tests: 14 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#0] ai-astar Cycles:10 Average:110.10 Median:112.00 stddev:3.96 (3.5%) stddev-sans-first:4.20 13:41:38 INFO - PROCESS | 4805 | Values: 110.0 112.0 107.0 111.0 113.0 113.0 100.0 112.0 111.0 112.0 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:149.00 stddev:15.80 (10.6%) stddev-sans-first:16.68 13:41:38 INFO - PROCESS | 4805 | Values: 149.0 125.0 145.0 158.0 125.0 149.0 151.0 132.0 176.0 136.0 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.50 stddev:1.57 (1.0%) stddev-sans-first:1.59 13:41:38 INFO - PROCESS | 4805 | Values: 163.0 164.0 162.0 163.0 160.0 161.0 159.0 163.0 161.0 161.0 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#3] audio-fft Cycles:10 Average:83.90 Median:73.00 stddev:14.95 (20.5%) stddev-sans-first:15.22 13:41:38 INFO - PROCESS | 4805 | Values: 72.0 73.0 108.0 93.0 73.0 73.0 73.0 106.0 95.0 73.0 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#4] audio-oscillator Cycles:10 Average:111.90 Median:96.00 stddev:25.61 (26.7%) stddev-sans-first:26.51 13:41:38 INFO - PROCESS | 4805 | Values: 96.0 96.0 148.0 95.0 96.0 96.0 149.0 96.0 97.0 150.0 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.56 (1.4%) stddev-sans-first:0.73 13:41:38 INFO - PROCESS | 4805 | Values: 119.0 116.0 115.0 114.0 114.0 115.0 115.0 114.0 114.0 114.0 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 13:41:38 INFO - PROCESS | 4805 | Values: 146.0 144.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 13:41:38 INFO - PROCESS | 4805 | Values: 97.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:3.29 (5.7%) stddev-sans-first:3.49 13:41:38 INFO - PROCESS | 4805 | Values: 58.0 57.0 58.0 57.0 57.0 59.0 58.0 67.0 56.0 55.0 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 13:41:38 INFO - PROCESS | 4805 | Values: 66.0 67.0 67.0 67.0 67.0 68.0 67.0 68.0 68.0 68.0 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.50 stddev:3.68 (4.4%) stddev-sans-first:3.71 13:41:38 INFO - PROCESS | 4805 | Values: 81.0 90.0 82.0 84.0 82.0 81.0 89.0 81.0 89.0 83.0 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:122.50 stddev:3.34 (2.7%) stddev-sans-first:3.42 13:41:38 INFO - PROCESS | 4805 | Values: 123.0 116.0 124.0 122.0 117.0 119.0 116.0 124.0 124.0 120.0 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:150.50 stddev:7.36 (4.9%) stddev-sans-first:7.79 13:41:38 INFO - PROCESS | 4805 | Values: 149.0 139.0 162.0 150.0 151.0 137.0 141.0 149.0 152.0 151.0 13:41:38 INFO - PROCESS | 4805 | 13:41:38 INFO - PROCESS | 4805 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.27 (1.8%) stddev-sans-first:1.22 13:41:38 INFO - PROCESS | 4805 | Values: 68.0 69.0 71.0 70.0 68.0 70.0 69.0 71.0 71.0 68.0 13:41:38 INFO - PROCESS | 4805 | -------- Summary: end -------- 13:41:38 INFO - PROCESS | 4805 | 13:41:39 INFO - TEST-INFO | 4805: exit 0 13:41:39 INFO - TEST-OK | kraken | took 59505ms 13:41:39 INFO - SUITE-END | took 1171s 13:41:39 INFO - Completed test suite (00:19:31) 13:41:39 INFO - Working with test: dromaeo_css 13:41:39 INFO - Generating results file: dromaeo_css 13:41:39 INFO - Working with test: kraken 13:41:39 INFO - Generating results file: kraken 13:41:39 INFO - javascript benchmark 13:41:39 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:41:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 13:41:39 INFO - process_Request line: dromaeo_css 6815.68 graph.html#tests=[[72,64,35]] 13:41:39 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:41:39 INFO - process_Request line: kraken 1516.70 graph.html#tests=[[232,64,35]] 13:41:39 INFO - RETURN: dromaeo_css: 6815.68 13:41:39 INFO - RETURN: kraken: 1516.70 13:41:39 INFO - javascript benchmark 13:41:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3062.877484900604, 3081.306705991151, 3116.0, 3132.420502207092, 3156.0374085903795, 4916.680415772972, 4960.751962401879, 4968.701877887329, 5010.849674509762, 5046.495350464952, 4913.066517361708, 4942.258661200822, 4977.7262250576205, 4984.077945580061, 5006.224035274529, 4507.4365704286965, 4636.304554316855, 4646.907061858761, 4738.455077666061, 4748.715077095368, 4507.72953622782, 4580.083983203356, 4691.9765401172945, 4731.716097034172, 4824.4210694716685, 4631.050634619912, 4656.883577910546, 4676.859694209179, 4684.297355396684, 4706.670533062687, 4637.652176086774, 4641.466231383401, 4685.0, 4700.0, 4715.457722361938, 4520.231560634667, 4535.954640453586, 4602.79287432063, 4626.768661566942, 4678.532146785328, 4844.5155484451625, 4852.902941941176, 4856.757162141914, 4864.489228631013, 4916.557509824097, 5181.300524429192, 5412.377576578704, 5415.1335786274, 5418.810341638024, 5421.322334708161, 5242.082635538765, 5302.390225124122, 5318.149096144598, 5319.813806516753, 5358.517733404013, 5083.288339632454, 5109.5145961134, 5118.564921981636, 5145.922811157836, 5156.742162891878, 5397.892042159135, 5489.478499542537, 5533.08704063833, 5583.664980101207, 5609.943900561024, 5300.946990530122, 5323.0950738373795, 5323.148296272578, 5324.946750532445, 5325.988062268157, 5332.226827110047, 5338.679679219182, 5338.839834804962, 5348.91976620351, 5383.057964856134, 5203.609729270244, 5284.550813180923, 5332.7067011313975, 5334.626576139711, 5373.892522149535, 5368.194770784414, 5399.0, 5410.810621628224, 5411.080116380225, 5415.729213539307, 4126.442930204384, 4203.684723645739, 4211.810468528924, 4219.092895027584, 4263.914721705549, 3837.1174629834736, 3840.5391353037257, 3840.635139661728, 3854.710896682704, 3857.035741064734, 5118.0, 5118.283440318359, 5121.897562048813, 5128.205128205134, 5131.589472842164, 5322.547583455373, 5361.946380536223, 5426.701531415731, 5431.728413579305, 5461.290032295776, 5036.471170527042, 5070.7464626768515, 5081.720505372166, 5083.822066227664, 5139.152039913372, 4489.685721999429, 4652.023075154256, 4657.0918670858855, 4669.649776266793, 4693.741844198602, 5634.633748806396, 5650.0, 5684.175794509855, 5687.544996400278, 5736.282964629421, 5380.11228147367, 5383.2463455117095, 5416.295881535533, 5417.864553386197, 5417.945820541744, 5423.5932305076485, 5628.493435590816, 5647.971760141173, 5702.45826646468, 5724.341700704473, 5281.0, 5310.362756469094, 5315.3090098286975, 5316.494932981361, 5318.494742999409, 5377.758000889891, 5378.19327100938, 5383.7846486140115, 5386.057439948072, 5432.239486471818, 5121.487851214849, 5241.89516209666, 5325.254464374913, 5354.4110147884485, 5402.0, 5214.243934629533, 5261.316028916216, 5261.605379596622, 5282.8943421132135, 5354.009508240988, 5006.874828129326, 5197.298364720866, 5220.347456567929, 5237.266782650356, 5241.50205730455, 5312.070387682217, 5325.467453254643, 5329.467053294639, 5343.812966546152, 5349.3848207455085, 5120.3087583177285, 5152.896942061213, 5161.071007218737, 5213.322268105122, 5245.659032162897], "unit": "score", "name": "dojo.html", "value": 4993.359132935991}, {"lowerIsBetter": false, "replicates": [518.8650950752804, 545.04072831816, 551.9999999999998, 554.1521472147613, 573.1603201310081, 35953.64046359536, 36709.44935825961, 36719.26561468769, 36739.632603673956, 36793.26413471729, 40653.0, 41354.0, 41363.79318103405, 41369.17261654765, 41375.79312103435, 8474.44916080456, 8690.130986901291, 8714.607842647096, 8717.651293948235, 8720.084391138935, 8570.400071994964, 8691.39160258782, 8696.913030869673, 8701.738947831544, 8702.912970870273, 8629.69796057138, 8694.782630434227, 8716.912830871705, 8729.956350218241, 8735.475871447734, 8615.224629783319, 8703.390762646617, 8707.695230666895, 8712.1287871213, 8713.172248636401, 8474.364422668325, 8606.139386061406, 8634.0, 8635.0, 8639.956800216021, 37674.0, 37772.24455510902, 37888.81055594732, 37908.0, 38100.42849357262, 3040.771942104351, 3091.922701932447, 3131.4363414585364, 3149.118246890874, 3193.7764356495054, 29928.675162203304, 30194.24514387158, 30425.69574304273, 30647.69352306493, 31261.531077033862, 3893.805309734502, 3894.369448761036, 4001.1197536541913, 4021.698372622036, 4034.9596504034876, 337566.0, 342121.0, 342368.2881585601, 342496.0, 342704.0, 56833.0, 57634.423655762905, 57673.94423585547, 57724.0, 57754.42245577575, 58627.41372586305, 59364.703176484705, 59414.70292648595, 59442.0, 61376.693116535025, 15095.245237738069, 15352.0, 15412.46056388021, 15412.614684632974, 15432.459863904709, 11114.499847506882, 11253.606123785628, 11267.492962816694, 11275.267107637977, 11496.0, 18523.907380463283, 19988.0, 20497.38507844767, 21280.0, 21281.0, 7757.961210193913, 7907.169747176578, 7933.801654958672, 8071.636776345079, 8199.303059240032, 970.7718686108759, 982.8820541535061, 991.0733464210986, 993.6770549571419, 1104.745908441063, 28738.712612873605, 29155.562666560018, 29437.85281073581, 29535.26161845928, 30836.845815771227, 995.6017592962728, 999.14073896449, 1006.5621454667244, 1009.7273736091361, 1112.2881355932209, 14712.264386780618, 16532.669346613002, 16732.749008764877, 16775.161241937854, 16886.83113168877, 429755.0, 433102.0, 437684.0, 438564.0, 439578.0, 56357.0, 57152.714236428554, 57313.42686573164, 57345.0, 57349.426505735246, 1289.0332250811891, 1291.6770807298176, 1304.5173285884284, 1308.3196737696535, 1323.7815760399426, 29514.96697615573, 30909.42682092582, 31199.532007020367, 31277.218069548442, 31685.683143168273, 46662.53337466582, 47169.29246061243, 47337.52662473331, 47399.76300118477, 47408.762956185, 307567.0, 311670.0, 311868.0, 312119.0, 312702.0, 31489.8425507871, 32936.34127317488, 33021.17447063747, 33075.0, 33155.83422082874, 42263.7886810564, 43726.56273437225, 43886.0, 44111.77944110259, 44316.55683443124, 36087.27825443529, 37136.0, 37359.43960840644, 37609.0, 38143.0, 36262.0, 36395.27209455743, 37308.440373394966, 37517.81241093886, 37884.81057594695, 35850.10374740548, 36349.45475817812, 36781.26437471289, 36801.0, 36875.0, 31691.366172675956, 32876.50685239676, 33222.0, 33379.33241335208, 33538.32923341568, 24901.252962411156, 25040.749592503842, 25421.74578254268, 25529.489410212063, 25630.615540767278], "unit": "score", "name": "ext.html", "value": 18867.151036366144}, {"lowerIsBetter": false, "replicates": [334.62856229585174, 354.62586970745866, 358.79010778694465, 359.8308794866412, 361.2612208034569, 12902.870971290284, 16499.83500164998, 17215.913920430397, 17615.11924403781, 17621.55946101348, 16131.919340403281, 16669.24988375523, 17420.39028633998, 17471.213795379208, 17471.91264043678, 3983.9203215935663, 5231.398389185245, 5399.946000540003, 5815.796447124351, 6084.787032453865, 5973.104034394853, 6002.279726432834, 6082.300535438415, 6118.785842495514, 6120.877582448348, 5684.943150568503, 5826.621269617462, 6009.068594367858, 6010.36891126432, 6013.428724271209, 5770.653760774346, 5814.534837213034, 5907.645541267516, 6074.119252708377, 6105.419985101408, 5083.79664813407, 5344.866378340534, 5353.304070470814, 5358.089124848785, 5382.138857782736, 13629.25039122848, 13650.317484125853, 15975.680486390207, 20563.691544626843, 20904.79095209059, 2033.8169564739244, 2113.3765539165984, 2154.310620601408, 2531.7594828491265, 2570.306017375317, 9764.023597640251, 10134.695959121238, 11054.949779770908, 11265.60570380041, 13581.049326547145, 1863.506170864722, 1881.0970734047596, 1903.809619038099, 1907.0845993922994, 1910.6274276516085, 60642.696786515786, 65109.0, 65767.67116164388, 66313.66843165802, 67366.66316668435, 10337.896621033693, 10351.63769268072, 10416.635417760343, 10457.215708821868, 10513.57945682164, 13108.606741797761, 13470.595882123553, 13526.661833454242, 13546.119502232323, 13585.864141358657, 7301.707931682673, 7312.890306645405, 7349.853002939912, 7433.070866141732, 7551.697932082765, 6408.231012278463, 6943.89584156238, 6966.1988871280455, 7244.529105608224, 7277.963610181915, 4381.101874115862, 4544.522825103382, 4584.954150458453, 4593.0, 4595.931061034087, 1854.6661600911966, 1859.907004649762, 1861.5799460701035, 1887.9150438230313, 1899.240303878432, 767.4896194031019, 849.5327569836566, 850.4174640371366, 860.7977125375531, 953.02315126994, 15320.770188447183, 15852.841471585367, 16162.0, 16244.918775406048, 16431.5892102696, 894.8344556257114, 914.4147745442922, 925.3013974449248, 937.5031233446148, 940.8071345374182, 7184.0, 8563.357748168912, 9151.581504866755, 9712.417254964725, 9786.657466988621, 376350.0, 376441.0, 390074.0, 400815.0, 424222.0, 71809.6409517949, 74003.62998185083, 74203.0, 74356.62821685857, 75061.99752009967, 996.6013594562088, 1000.6697789729371, 1042.5360714481983, 1048.905598496139, 1051.3271506236015, 14707.852921470649, 14875.181864997528, 14956.102633842005, 14966.551003469913, 15135.772963405338, 31503.369932600763, 32496.187595310308, 32599.837000814845, 32918.67081329156, 33192.17019574434, 43858.342124867515, 44161.55838441703, 44292.33561496516, 44840.0, 45885.31172032489, 7903.486273392211, 8059.677612895419, 8116.553589552631, 8146.674133034612, 8212.137725538732, 11009.449527523431, 11928.821067683819, 12124.211926224767, 12296.75406491883, 12353.135280530276, 7285.380742636935, 10313.174946004452, 10524.545566959318, 10748.032677059102, 11084.334939903632, 7805.5706936116785, 10262.846057308998, 10409.9479502602, 10492.527836247235, 10514.0, 10291.33106348085, 10810.621628243289, 10835.187360947803, 10859.619913302997, 10899.455027248765, 7735.071791385069, 7893.09229438599, 7919.564423956507, 7925.960370198112, 7941.682332706858, 9467.905320946978, 10065.144462720458, 10583.417912014913, 10866.239363244496, 10949.616763413242], "unit": "score", "name": "jquery.html", "value": 8292.056505481007}, {"lowerIsBetter": false, "replicates": [1359.9252041137734, 1422.2959634980687, 1448.5943935698, 1618.8381161883806, 1807.7921039080502, 6836.4189043931265, 7389.81525461863, 7532.17146113927, 7543.245675432454, 7569.621518924052, 7495.737649182266, 7624.809379765508, 7646.885296720554, 7654.3111119999185, 7658.425618078652, 1918.6162767446497, 2211.845170838042, 2242.686023956643, 2266.5580211858696, 2271.0234599122373, 2246.9887650561805, 2297.8161747060194, 2307.4346785037606, 2314.2710046335433, 2316.397736588482, 2179.0, 2199.59307528107, 2202.0751284460566, 2204.371754050096, 2204.8236141108673, 2146.399008277685, 2174.13034786086, 2230.5650398172284, 2230.698855654482, 2232.8102111320395, 2178.0852042142337, 2191.7589065202815, 2200.6698995150696, 2216.390492614528, 2218.2901471529117, 7692.076950765888, 7757.72847950319, 7759.146493885668, 7772.455928085036, 7782.610869456505, 4470.597646211857, 4598.793054312564, 4623.514530974233, 4630.953690463086, 4636.698614590041, 2883.5674648802637, 2916.416716656656, 2957.526795712697, 3017.109952563977, 3025.8638361273797, 959.7600599850037, 961.1781926452852, 991.2417000994245, 996.1930836022844, 996.8903420623726, 10454.52954617044, 10491.947540262327, 10498.685039448752, 10504.212184086147, 10520.158387328995, 4039.5758445363404, 4076.7553946763287, 4127.607877251657, 4180.101278225196, 4181.60274773896, 9054.0, 9101.40840845343, 9116.908830911738, 9118.635254589875, 9134.451932884049, 4198.076423186894, 4619.653525985565, 4703.835365762182, 4735.289706544046, 4736.029114031684, 4264.701470897069, 4273.081287523198, 4305.268104422255, 4314.633256173261, 4322.113966636832, 3559.839807208682, 3571.1072231942017, 3582.247727977102, 3618.2763447310117, 3620.7465477416326, 1078.7033565769477, 1110.4669758515797, 1124.6344937895053, 1125.431657013203, 1132.932024078558, 1253.354522420954, 1258.8237646729465, 1286.7941129419248, 1309.7576948264602, 1310.1091257944688, 7217.92782072183, 7321.926780732231, 7356.337929586363, 7376.041114655168, 7380.372668323145, 1099.571167244775, 1102.311055590256, 1106.7067227184803, 1108.2408550143177, 1149.4884776274646, 5386.461353864583, 5389.461053894657, 5432.728363581805, 5435.266239057677, 5442.265294185234, 8675.869861952076, 8827.117288271122, 9014.504202268807, 9195.816083678288, 9217.631294748135, 9185.081491850762, 9211.0, 9279.860802087975, 9291.256699464027, 9385.5307234638, 7123.180834204029, 7219.963900180465, 7278.053852999182, 7359.742409015659, 7401.0, 6952.478564107813, 6996.720131194696, 7034.015237866805, 7040.964795176196, 7066.540674856118, 7931.493016326879, 8299.834003319778, 8311.293540049164, 8449.0, 8450.028246751703, 8314.958425207835, 8661.956690216508, 8666.263367613823, 8673.956630216808, 8677.913220867711, 6483.546151769331, 6506.41442270198, 6608.140941677743, 6628.966855165693, 6629.038789375417, 7412.221716719667, 7433.776986690408, 7485.887711684438, 7488.887666685113, 7490.812729681584, 6721.495887808336, 6805.693743781443, 6889.724411023503, 6916.896246556205, 7033.120859892513, 6718.496112791658, 6719.697613607497, 6765.391114799691, 6805.693743781443, 6855.965720171367, 6907.20567134786, 6908.5509441886115, 7040.612766297902, 7089.503734738519, 7090.787276381717, 6271.874562508816, 6334.429901308904, 6340.080688300263, 6360.109584658244, 6370.74517019314, 6535.901961470677, 6589.4069533742195, 6598.10925525048, 6600.966995165186, 6606.735730570724], "unit": "score", "name": "mootools.html", "value": 4418.8286578667985}, {"lowerIsBetter": false, "replicates": [332.1795165940128, 334.2896345266309, 336.789506558401, 341.7232042045945, 343.1250311705153, 5671.149327600862, 5812.215350927623, 5816.360200377955, 5824.2625965796005, 5831.446012628799, 5613.887722245553, 5696.202531645563, 5731.111677689964, 5734.942650573504, 5753.712314384275, 4507.729536227828, 4536.863894083166, 4543.65922555808, 4549.24937385331, 4550.567696068868, 4319.265724826787, 4434.97782511087, 4539.682222244444, 4542.704724192917, 4548.658850586203, 4493.438320209973, 4501.572350626685, 4501.909961800762, 4515.525869783674, 4537.818487260505, 4518.796654150555, 4527.683062185648, 4528.909421811545, 4534.9319760203625, 4545.954540454586, 4011.6991225657903, 4014.959850401517, 4016.5581786003518, 4020.0552870075508, 4028.0735430850777, 5510.504054635102, 5565.499105080522, 5575.972120139414, 5585.162225666142, 5601.719914004283, 5232.6598771080135, 5265.420803711589, 5266.104762190437, 5268.5521730652945, 5282.550983166436, 6144.477719393857, 6150.938490615082, 6154.938450615481, 6156.692165391757, 6158.3841615838055, 4403.735775853459, 4425.291953287491, 4432.977835110836, 4437.267850804646, 4438.356438316426, 6226.533010024266, 6454.741810327581, 6469.320721324288, 6473.74105035798, 6485.7405703772265, 4382.846600368972, 4397.07661391105, 4406.647468202536, 4407.581279778416, 4414.448193975753, 4435.933460998088, 4439.800208990603, 4447.177272204653, 4449.599536041772, 4451.844185453494, 5157.432682404932, 5160.432352441228, 5162.354705661793, 5162.45794191612, 5164.92252616211, 5978.850528736816, 6067.787627433018, 6228.408301211378, 6231.532635052389, 6236.469900058546, 1506.1113942773816, 1550.0312304809495, 1556.4630202580092, 1559.9220038998005, 1561.2505997121445, 1020.7039958412125, 1024.7335692719946, 1026.712520494263, 1041.5052849896238, 1042.5464922758472, 5813.680247586423, 5828.795992140254, 5833.591648584558, 5835.9708201458725, 5873.588848780544, 6265.4361107499635, 6271.749130034838, 6272.780452684134, 6283.842903927347, 6287.1512345832725, 5825.242718446575, 5826.388229235954, 5827.184194212814, 5828.12578113278, 5830.38780928005, 3306.454435018195, 3408.3183363327435, 3409.7783644063056, 3411.334789716031, 3411.8976430707116, 6584.30864759203, 6601.108850305147, 6614.470842332602, 6614.768483103068, 6616.933830661728, 6427.453666438405, 6435.292117867031, 6441.194850643669, 6443.452306553995, 6447.323031081763, 6429.678516074177, 6602.207735071822, 6602.735890564323, 6620.602763834186, 6624.900626490607, 6255.78104766331, 6256.593321434092, 6281.403266689657, 6284.780032698834, 6286.937130628635, 6220.222472190976, 6226.283977342482, 6227.034809604518, 6229.4393504584805, 6231.065340198825, 6538.967305163444, 6618.7352505899225, 6620.602763834186, 6777.966110169417, 6778.796636100925, 4362.236608593547, 4379.080393117481, 4390.495093064211, 4400.251957167226, 4410.073884484166, 6198.411150940653, 6323.810285691437, 6452.0, 6456.160699109086, 6463.709133088928, 6250.812475625738, 6257.217847769029, 6258.030005349178, 6267.905981410374, 6273.341299163522, 6257.186565746424, 6257.624542527463, 6260.812175634556, 6263.935131027827, 6267.811965641038, 6039.456448919618, 6128.662923539248, 6152.723127459365, 6165.537584681257, 6168.660723660242, 6229.657368844757, 6260.593061450991, 6264.31092579825, 6273.498120150286, 6276.9372306276355, 6061.636301821728, 6077.604955677867, 6077.696115194134, 6117.877642447037, 6120.143179954899], "unit": "score", "name": "prototype.html", "value": 4673.745179235273}, {"lowerIsBetter": false, "replicates": [655.1352215076096, 664.0570390046134, 668.8963210702343, 780.2041917244411, 809.7368355284532, 12717.364131793409, 12865.485380584778, 12876.484940602388, 12892.742145157103, 12911.160774549648, 12012.519499220043, 12202.267863928148, 12226.083043771709, 12228.816567751468, 12231.69420764479, 685.6674512861258, 689.465664110316, 802.4743792815715, 810.5784991804244, 832.6086739232582, 826.305903041445, 828.0146625515617, 831.0359982420393, 832.1678321678322, 834.4367551902471, 871.0331531999476, 877.1097336203758, 877.4779006491127, 877.8507653698855, 877.8858748362736, 704.4857254204409, 860.1699360117485, 870.8780770692108, 871.6121326009896, 873.7859224489977, 638.3743930947651, 640.942315191635, 643.0193954219806, 643.4305639509068, 643.6331291163991, 12954.0, 12965.61103166897, 13049.217046977212, 13087.738245235041, 13119.540816071487, 12982.675433114153, 13209.339533023407, 13365.732685346238, 13385.866141338656, 13404.396802143927, 10799.298045627087, 10830.945845270802, 10869.782604347947, 10989.890101098967, 11009.339439633648, 3575.928481430383, 3657.4148136298063, 3681.1533347329996, 3705.2033812730124, 3708.2398108387715, 49414.50585494135, 49423.75288123573, 49560.256596151085, 49603.0, 49770.25344619834, 10069.395836249849, 10330.431826249478, 10431.791364172826, 10440.269181157246, 10490.475476226158, 17679.911600442174, 17703.38038168658, 17717.645647086985, 17791.73312400315, 17856.19647115883, 7515.361194298436, 7964.522128672298, 8018.719344822904, 8252.628631711588, 8266.793330166794, 4367.847125350598, 4390.165868484977, 4442.888927776831, 4461.598456138898, 4568.1548913451115, 3052.4200401923563, 3082.676318986519, 3085.105319457377, 3094.4275309067893, 3105.767067469949, 505.6612069913167, 513.8175947538645, 584.8245526342165, 588.6173986908543, 611.7767015039567, 495.5960891873184, 549.5383877542803, 602.9186059881947, 651.2900937977627, 661.5699795133106, 7775.183605721431, 8050.0, 8182.590870456454, 8198.631061602242, 8632.266257368194, 615.4891440104702, 622.4211483320555, 623.8689875126183, 638.4955884851008, 641.425923798198, 3833.9041523962123, 3846.0201339948467, 3900.4344370066183, 4074.6129117733767, 4148.149629325981, 53665.46334536605, 54170.0, 54262.0, 54755.0, 54953.45046549563, 47658.285125723145, 48203.276950845764, 49531.75234123806, 50147.49852501501, 50388.0, 43324.350134748005, 43713.34429983553, 43737.34393984029, 44025.55974440215, 44324.0, 8062.193780621891, 8433.28317093054, 8458.74623761288, 8503.914960850312, 8579.742607721779, 32974.83512582422, 33289.334213316084, 33328.50007249845, 33547.496787547716, 33997.15007124842, 41294.0, 41673.37489937714, 42032.15935681208, 42846.35730464108, 42931.570684292754, 10509.106725928381, 10671.839922401015, 10776.245662803529, 10877.129829613454, 11197.44012799373, 9817.852732209165, 11609.30344179352, 11673.0, 11754.177207595387, 12293.0, 11013.174011949297, 11402.714932126763, 11610.303381797119, 11646.94176529112, 11674.416279186176, 11065.612703555336, 11332.6033588824, 11500.137489688474, 11522.596709115141, 11820.0, 11113.320672546193, 11313.660590182308, 11383.430828458379, 11434.82847757301, 11598.768024639292, 9258.099470142122, 9310.860337095084, 9415.670451534437, 9429.387089839138, 9675.080867317594, 8570.871436928575, 9444.622215111318, 9526.952365238129, 9763.755906102404, 10306.33008854452], "unit": "score", "name": "yui.html", "value": 6212.674580421321}], "name": "dromaeo_css", "value": 6815.675225803134}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 107.0, 111.0, 113.0, 113.0, 100.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [149.0, 125.0, 145.0, 158.0, 125.0, 149.0, 151.0, 132.0, 176.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 162.0, 163.0, 160.0, 161.0, 159.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 108.0, 93.0, 73.0, 73.0, 73.0, 106.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 148.0, 95.0, 96.0, 96.0, 149.0, 96.0, 97.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 111.9}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 115.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.0}, {"lowerIsBetter": true, "replicates": [146.0, 144.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 58.0, 57.0, 57.0, 59.0, 58.0, 67.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [81.0, 90.0, 82.0, 84.0, 82.0, 81.0, 89.0, 81.0, 89.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [123.0, 116.0, 124.0, 122.0, 117.0, 119.0, 116.0, 124.0, 124.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [149.0, 139.0, 162.0, 150.0, 151.0, 137.0, 141.0, 149.0, 152.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 71.0, 70.0, 68.0, 70.0, 69.0, 71.0, 71.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1516.6999999999998}]} 13:41:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1516.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6815.68"}}} 13:41:39 INFO - Return code: 0 13:41:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:41:39 INFO - # TBPL SUCCESS # 13:41:39 INFO - Running post-action listener: _resource_record_post_action 13:41:39 INFO - Running post-run listener: _resource_record_post_run 13:41:40 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 20480; Write bytes: 309166080; Read time: 48; Write time: 227528 13:41:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13930496; Read time: 0; Write time: 4368 13:41:40 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 20480; Write bytes: 295235584; Read time: 48; Write time: 223160 13:41:40 INFO - Running post-run listener: _upload_blobber_files 13:41:40 INFO - Blob upload gear active. 13:41:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:41:40 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 13:41:40 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'] 13:41:40 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 13:41:41 INFO - (blobuploader) - INFO - Open directory for files ... 13:41:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 13:41:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:41:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:41:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:41:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:41:41 INFO - (blobuploader) - INFO - Done attempting. 13:41:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:41:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:41:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:41:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:41:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:41:42 INFO - (blobuploader) - INFO - Done attempting. 13:41:42 INFO - (blobuploader) - INFO - Iteration through files over. 13:41:42 INFO - Return code: 0 13:41:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:41:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:41:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/640812fa534013ce65514e9eb27ee96a4289915ca12a5aec2d8a65c77697a0576a9a1ca39be83647e1d578c8c79145fe8157be0ab060eccde04fb87f8a25706e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/705b796df3681315043584eb7162cb0351105e702077725f73885ef01f8771381895384f56569fab4cc20f227e8fdb643530c1eec38e40c23f69bd8ce083c28f"} 13:41:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:41:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:41:42 INFO - Contents: 13:41:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/640812fa534013ce65514e9eb27ee96a4289915ca12a5aec2d8a65c77697a0576a9a1ca39be83647e1d578c8c79145fe8157be0ab060eccde04fb87f8a25706e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/705b796df3681315043584eb7162cb0351105e702077725f73885ef01f8771381895384f56569fab4cc20f227e8fdb643530c1eec38e40c23f69bd8ce083c28f"} 13:41:42 INFO - Running post-run listener: copy_logs_to_upload_dir 13:41:42 INFO - Copying logs to upload dir... 13:41:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:41:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.961521 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-02-20 13:41:42.456045) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-20 13:41:42.459704) ========= 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=0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819 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/640812fa534013ce65514e9eb27ee96a4289915ca12a5aec2d8a65c77697a0576a9a1ca39be83647e1d578c8c79145fe8157be0ab060eccde04fb87f8a25706e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/705b796df3681315043584eb7162cb0351105e702077725f73885ef01f8771381895384f56569fab4cc20f227e8fdb643530c1eec38e40c23f69bd8ce083c28f"} build_url:https://queue.taskcluster.net/v1/task/L3UwTgXJTNedjqKXM0k56A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/L3UwTgXJTNedjqKXM0k56A/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/640812fa534013ce65514e9eb27ee96a4289915ca12a5aec2d8a65c77697a0576a9a1ca39be83647e1d578c8c79145fe8157be0ab060eccde04fb87f8a25706e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/705b796df3681315043584eb7162cb0351105e702077725f73885ef01f8771381895384f56569fab4cc20f227e8fdb643530c1eec38e40c23f69bd8ce083c28f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-20 13:41:42.488577) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 13:41:42.488895) ========= 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=0274524eba3bdaad075c2247000001d4-1456003272.981361-308908819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 13:41:42.574041) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-20 13:41:42.574831) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-20 13:41:42.575565) ========= ========= Total master_lag: 0.23 =========