builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1455122133.16 results: success (0) buildid: 20160210053003 builduid: d8ae338810094d2f9a214bc9cfa44ea7 revision: b3acf53ea44057f28e7a5d8b0bdd3dcdcef42d83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.162079) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.162552) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.162849) ========= 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=df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004785 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.204717) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.204996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.236033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.236291) ========= 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=df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014696 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.282867) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.283137) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.283480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.284007) ========= 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=df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-10 08:35:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-02-10 08:35:33 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203268 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.499463) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.499776) ========= 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=df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.097542 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.609161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:33.609489) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b3acf53ea44057f28e7a5d8b0bdd3dcdcef42d83 --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 b3acf53ea44057f28e7a5d8b0bdd3dcdcef42d83 --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=df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-10 08:35:33,656 truncating revision to first 12 chars 2016-02-10 08:35:33,656 Setting DEBUG logging. 2016-02-10 08:35:33,656 attempt 1/10 2016-02-10 08:35:33,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b3acf53ea440?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 08:35:33,916 unpacking tar archive at: fx-team-b3acf53ea440/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547596 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:34.169893) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:34.170230) ========= echo b3acf53ea44057f28e7a5d8b0bdd3dcdcef42d83 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b3acf53ea44057f28e7a5d8b0bdd3dcdcef42d83'] 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=df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b3acf53ea44057f28e7a5d8b0bdd3dcdcef42d83 program finished with exit code 0 elapsedTime=0.003277 script_repo_revision: 'b3acf53ea44057f28e7a5d8b0bdd3dcdcef42d83' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:34.218494) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:34.218798) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 08:35:34.229527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-10 08:35:34.229822) ========= /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=df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:35:34 INFO - MultiFileLogger online at 20160210 08:35:34 in /builds/slave/test-pgo 08:35:34 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 08:35:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:35:34 INFO - {'append_to_log': False, 08:35:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:35:34 INFO - 'blob_upload_branch': 'Fx-Team', 08:35:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:35:34 INFO - 'branch': 'Fx-Team', 08:35:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:35:34 INFO - 'config_files': ('talos/linux_config.py',), 08:35:34 INFO - 'default_actions': ('clobber', 08:35:34 INFO - 'read-buildbot-config', 08:35:34 INFO - 'download-and-extract', 08:35:34 INFO - 'populate-webroot', 08:35:34 INFO - 'create-virtualenv', 08:35:34 INFO - 'install', 08:35:34 INFO - 'run-tests'), 08:35:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:35:34 INFO - 'download_minidump_stackwalk': True, 08:35:34 INFO - 'download_symbols': 'ondemand', 08:35:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:35:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:35:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:35:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:35:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:35:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:35:34 INFO - 'installer_path': 'installer.exe', 08:35:34 INFO - 'log_level': 'info', 08:35:34 INFO - 'log_name': 'talos', 08:35:34 INFO - 'log_to_console': True, 08:35:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:35:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:35:34 INFO - 'opt_config_files': (), 08:35:34 INFO - 'pip_index': False, 08:35:34 INFO - 'sps_profile': False, 08:35:34 INFO - 'sps_profile_interval': 0, 08:35:34 INFO - 'suite': 'dromaeojs', 08:35:34 INFO - 'system_bits': '32', 08:35:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:35:34 INFO - 'title': 'talos-linux64-ix-021', 08:35:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:35:34 INFO - 'use_talos_json': True, 08:35:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:35:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:35:34 INFO - 'work_dir': 'build'} 08:35:34 INFO - ##### 08:35:34 INFO - ##### Running clobber step. 08:35:34 INFO - ##### 08:35:34 INFO - Running pre-action listener: _resource_record_pre_action 08:35:34 INFO - Running main action method: clobber 08:35:34 INFO - rmtree: /builds/slave/test-pgo/build 08:35:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:35:40 INFO - Running post-action listener: _resource_record_post_action 08:35:40 INFO - ##### 08:35:40 INFO - ##### Running read-buildbot-config step. 08:35:40 INFO - ##### 08:35:40 INFO - Running pre-action listener: _resource_record_pre_action 08:35:40 INFO - Running main action method: read_buildbot_config 08:35:40 INFO - Using buildbot properties: 08:35:40 INFO - { 08:35:40 INFO - "project": "", 08:35:40 INFO - "product": "firefox", 08:35:40 INFO - "script_repo_revision": "production", 08:35:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:35:40 INFO - "repository": "", 08:35:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:35:40 INFO - "buildid": "20160210053003", 08:35:40 INFO - "pgo_build": "True", 08:35:40 INFO - "basedir": "/builds/slave/test-pgo", 08:35:40 INFO - "buildnumber": 933, 08:35:40 INFO - "slavename": "talos-linux64-ix-021", 08:35:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:35:40 INFO - "platform": "ubuntu64_hw", 08:35:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:35:40 INFO - "branch": "fx-team", 08:35:40 INFO - "repo_path": "integration/fx-team", 08:35:40 INFO - "revision": "b3acf53ea44057f28e7a5d8b0bdd3dcdcef42d83", 08:35:40 INFO - "stage_platform": "linux64-pgo", 08:35:40 INFO - "builduid": "d8ae338810094d2f9a214bc9cfa44ea7", 08:35:40 INFO - "slavebuilddir": "test" 08:35:40 INFO - } 08:35:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 08:35:40 INFO - Running post-action listener: _resource_record_post_action 08:35:40 INFO - ##### 08:35:40 INFO - ##### Running download-and-extract step. 08:35:40 INFO - ##### 08:35:40 INFO - Running pre-action listener: _resource_record_pre_action 08:35:40 INFO - Running main action method: download_and_extract 08:35:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:35: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')]} 08:35:40 INFO - https://queue.taskcluster.net/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:35:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/test_packages.json 08:35:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/test_packages.json 08:35:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:35:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:35:41 INFO - Downloaded 1448 bytes. 08:35:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:35:41 INFO - Using the following test package requirements: 08:35:41 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:35:41 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:35:41 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:35:41 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:41 INFO - u'jsshell-linux-x86_64.zip'], 08:35:41 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:35:41 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:35:41 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:35:41 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:35:41 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:35:41 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:35:41 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:41 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:35:41 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:41 INFO - https://queue.taskcluster.net/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:35:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:35:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:35:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/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 08:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/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 08:35:44 INFO - Downloaded 23290212 bytes. 08:35:44 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'] 08:35:44 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 08:35:45 INFO - Return code: 0 08:35:45 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 08:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:45 INFO - https://queue.taskcluster.net/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:35:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:35:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:35:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/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 08:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/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 08:35:48 INFO - Downloaded 23290212 bytes. 08:35:48 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'] 08:35:48 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 08:35:54 INFO - Return code: 0 08:35:54 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')]} 08:35:54 INFO - https://queue.taskcluster.net/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:35:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:35:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:35:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/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 08:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/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 08:35:55 INFO - Downloaded 10706547 bytes. 08:35:55 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'] 08:35:55 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 08:35:56 INFO - Return code: 0 08:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:56 INFO - https://queue.taskcluster.net/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:35:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:35:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:35:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/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 08:35:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJBxp5qOToKou7wdpBAc5g/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 08:35:57 INFO - Downloaded 56386341 bytes. 08:35:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:35:57 INFO - mkdir: /builds/slave/test-pgo/properties 08:35:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:35:57 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:35:57 INFO - Contents: 08:35:57 INFO - build_url:https://queue.taskcluster.net/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:35:58 INFO - Running post-action listener: _resource_record_post_action 08:35:58 INFO - Running post-action listener: set_extra_try_arguments 08:35:58 INFO - ##### 08:35:58 INFO - ##### Running populate-webroot step. 08:35:58 INFO - ##### 08:35:58 INFO - Running pre-action listener: _resource_record_pre_action 08:35:58 INFO - Running main action method: populate_webroot 08:35:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:35:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:35:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:35:58 INFO - '--tppagecycles', 08:35:58 INFO - '7'], 08:35:58 INFO - 'tests': ['tsvgm']}}, 08:35:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:35:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:35:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:35:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:35:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:35:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:35:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:58 INFO - 'talos_options': ['--e10s'], 08:35:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:58 INFO - 'tests': ['damp', 'tps']}, 08:35:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:58 INFO - 'talos_options': ['--e10s'], 08:35:58 INFO - 'tests': ['damp', 'tps']}, 08:35:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:35:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:35:58 INFO - 'other': {'tests': ['a11yr', 08:35:58 INFO - 'ts_paint', 08:35:58 INFO - 'tpaint', 08:35:58 INFO - 'sessionrestore', 08:35:58 INFO - 'sessionrestore_no_auto_restore']}, 08:35:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:35:58 INFO - 'tests': ['a11yr', 08:35:58 INFO - 'ts_paint', 08:35:58 INFO - 'tpaint', 08:35:58 INFO - 'sessionrestore', 08:35:58 INFO - 'sessionrestore_no_auto_restore']}, 08:35:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:35:58 INFO - 'tests': ['a11yr', 08:35:58 INFO - 'ts_paint', 08:35:58 INFO - 'tpaint', 08:35:58 INFO - 'sessionrestore', 08:35:58 INFO - 'sessionrestore_no_auto_restore']}, 08:35:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:35:58 INFO - 'tests': ['a11yr', 08:35:58 INFO - 'ts_paint', 08:35:58 INFO - 'tpaint', 08:35:58 INFO - 'sessionrestore', 08:35:58 INFO - 'sessionrestore_no_auto_restore']}, 08:35:58 INFO - 'other_l64': {'tests': ['a11yr', 08:35:58 INFO - 'ts_paint', 08:35:58 INFO - 'tpaint', 08:35:58 INFO - 'sessionrestore', 08:35:58 INFO - 'sessionrestore_no_auto_restore']}, 08:35:58 INFO - 'other_nol64': {'tests': ['a11yr', 08:35:58 INFO - 'ts_paint', 08:35:58 INFO - 'tpaint', 08:35:58 INFO - 'sessionrestore', 08:35:58 INFO - 'sessionrestore_no_auto_restore']}, 08:35:58 INFO - 'svgr': {'tests': ['tsvgx', 08:35:58 INFO - 'tsvgr_opacity', 08:35:58 INFO - 'tart', 08:35:58 INFO - 'tscrollx', 08:35:58 INFO - 'cart']}, 08:35:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:35:58 INFO - 'tests': ['tsvgx', 08:35:58 INFO - 'tsvgr_opacity', 08:35:58 INFO - 'tart', 08:35:58 INFO - 'tscrollx', 08:35:58 INFO - 'cart']}, 08:35:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:58 INFO - 'tests': ['tp5o']}, 08:35:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:58 INFO - 'talos_options': ['--e10s'], 08:35:58 INFO - 'tests': ['tp5o']}, 08:35:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:58 INFO - 'talos_options': ['--xperf_path', 08:35:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:58 INFO - 'tests': ['tp5n']}, 08:35:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:58 INFO - 'talos_options': ['--e10s', 08:35:58 INFO - '--xperf_path', 08:35:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:58 INFO - 'tests': ['tp5n']}}, 08:35:58 INFO - 'talos.zip': {'path': '', 08:35:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:35:58 INFO - Running post-action listener: _resource_record_post_action 08:35:58 INFO - ##### 08:35:58 INFO - ##### Running create-virtualenv step. 08:35:58 INFO - ##### 08:35:58 INFO - Running pre-action listener: _resource_record_pre_action 08:35:58 INFO - Running main action method: create_virtualenv 08:35:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:35:58 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 08:35:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:35:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:35:58 INFO - Using real prefix '/usr' 08:35:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:35:58 INFO - Installing distribute.............................................................................................................................................................................................done. 08:36:04 INFO - Installing pip.................done. 08:36:04 INFO - Return code: 0 08:36:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:36:04 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')]} 08:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:04 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')]} 08:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:04 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 0x7f0c27c84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1416670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a58c0>, '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 0x14a67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a6c50>, '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': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', '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 08:36:04 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 08:36:04 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 08:36:04 INFO - Using env: {'DISPLAY': ':0', 08:36:04 INFO - 'HOME': '/home/cltbld', 08:36:04 INFO - 'LANG': 'en_US.UTF-8', 08:36:04 INFO - 'LANGUAGE': 'en_US:en', 08:36:04 INFO - 'LOGNAME': 'cltbld', 08:36:04 INFO - 'MAIL': '/var/mail/cltbld', 08:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:04 INFO - 'MOZ_NO_REMOTE': '1', 08:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:04 INFO - 'NO_EM_RESTART': '1', 08:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:36:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:36:04 INFO - 'SHELL': '/bin/bash', 08:36:04 INFO - 'SHLVL': '1', 08:36:04 INFO - 'TERM': 'linux', 08:36:04 INFO - 'TMOUT': '86400', 08:36:04 INFO - 'USER': 'cltbld', 08:36:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', 08:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:04 INFO - '_': '/tools/buildbot/bin/python'} 08:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:06 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 08:36:06 INFO - Cleaning up... 08:36:06 INFO - Return code: 0 08:36:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:36: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')]} 08:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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')]} 08:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:06 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 0x7f0c27c84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1416670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a58c0>, '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 0x14a67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a6c50>, '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': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', '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 08:36:06 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 08:36:06 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 08:36:06 INFO - Using env: {'DISPLAY': ':0', 08:36:06 INFO - 'HOME': '/home/cltbld', 08:36:06 INFO - 'LANG': 'en_US.UTF-8', 08:36:06 INFO - 'LANGUAGE': 'en_US:en', 08:36:06 INFO - 'LOGNAME': 'cltbld', 08:36:06 INFO - 'MAIL': '/var/mail/cltbld', 08:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:06 INFO - 'MOZ_NO_REMOTE': '1', 08:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:06 INFO - 'NO_EM_RESTART': '1', 08:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:36:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:36:06 INFO - 'SHELL': '/bin/bash', 08:36:06 INFO - 'SHLVL': '1', 08:36:06 INFO - 'TERM': 'linux', 08:36:06 INFO - 'TMOUT': '86400', 08:36:06 INFO - 'USER': 'cltbld', 08:36:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', 08:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:06 INFO - '_': '/tools/buildbot/bin/python'} 08:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:07 INFO - Downloading/unpacking psutil>=0.7.1 08:36:07 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 08:36:07 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 08:36:07 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 08:36:07 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 08:36:07 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 08:36:07 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 08:36:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:36:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:09 INFO - Installing collected packages: psutil 08:36:09 INFO - Running setup.py install for psutil 08:36:09 INFO - building 'psutil._psutil_linux' extension 08:36:09 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 08:36:10 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 08:36:10 INFO - building 'psutil._psutil_posix' extension 08:36:10 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 08:36:11 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 08:36:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:11 INFO - Successfully installed psutil 08:36:11 INFO - Cleaning up... 08:36:11 INFO - Return code: 0 08:36:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:11 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 0x7f0c27c84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1416670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a58c0>, '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 0x14a67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a6c50>, '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': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', '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 08:36:11 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 08:36:11 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 08:36:11 INFO - Using env: {'DISPLAY': ':0', 08:36:11 INFO - 'HOME': '/home/cltbld', 08:36:11 INFO - 'LANG': 'en_US.UTF-8', 08:36:11 INFO - 'LANGUAGE': 'en_US:en', 08:36:11 INFO - 'LOGNAME': 'cltbld', 08:36:11 INFO - 'MAIL': '/var/mail/cltbld', 08:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:11 INFO - 'MOZ_NO_REMOTE': '1', 08:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:11 INFO - 'NO_EM_RESTART': '1', 08:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:36:11 INFO - 'PWD': '/builds/slave/test-pgo', 08:36:11 INFO - 'SHELL': '/bin/bash', 08:36:11 INFO - 'SHLVL': '1', 08:36:11 INFO - 'TERM': 'linux', 08:36:11 INFO - 'TMOUT': '86400', 08:36:11 INFO - 'USER': 'cltbld', 08:36:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', 08:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:11 INFO - '_': '/tools/buildbot/bin/python'} 08:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:36:11 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 08:36:11 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 08:36:11 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 08:36:11 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 08:36:11 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 08:36:11 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 08:36:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:36:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:36:13 INFO - Installing collected packages: mozsystemmonitor 08:36:13 INFO - Running setup.py install for mozsystemmonitor 08:36:13 INFO - Successfully installed mozsystemmonitor 08:36:13 INFO - Cleaning up... 08:36:13 INFO - Return code: 0 08:36:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:13 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 0x7f0c27c84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1416670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a58c0>, '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 0x14a67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a6c50>, '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': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', '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 08:36:13 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 08:36:13 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 08:36:13 INFO - Using env: {'DISPLAY': ':0', 08:36:13 INFO - 'HOME': '/home/cltbld', 08:36:13 INFO - 'LANG': 'en_US.UTF-8', 08:36:13 INFO - 'LANGUAGE': 'en_US:en', 08:36:13 INFO - 'LOGNAME': 'cltbld', 08:36:13 INFO - 'MAIL': '/var/mail/cltbld', 08:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:13 INFO - 'MOZ_NO_REMOTE': '1', 08:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:13 INFO - 'NO_EM_RESTART': '1', 08:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:36:13 INFO - 'PWD': '/builds/slave/test-pgo', 08:36:13 INFO - 'SHELL': '/bin/bash', 08:36:13 INFO - 'SHLVL': '1', 08:36:13 INFO - 'TERM': 'linux', 08:36:13 INFO - 'TMOUT': '86400', 08:36:13 INFO - 'USER': 'cltbld', 08:36:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', 08:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:13 INFO - '_': '/tools/buildbot/bin/python'} 08:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:13 INFO - Downloading/unpacking blobuploader==1.2.4 08:36:13 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 08:36:13 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 08:36:13 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 08:36:13 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 08:36:13 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 08:36:13 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 08:36:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:36:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:36:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:36:15 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 08:36:15 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 08:36:15 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 08:36:15 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 08:36:15 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 08:36:15 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 08:36:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:36:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:36:16 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 08:36:16 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 08:36:16 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 08:36:16 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 08:36:16 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 08:36:16 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 08:36:16 INFO - Downloading docopt-0.6.1.tar.gz 08:36:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:36:16 INFO - Installing collected packages: blobuploader, requests, docopt 08:36:16 INFO - Running setup.py install for blobuploader 08:36:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:36:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:36:16 INFO - Running setup.py install for requests 08:36:16 INFO - Running setup.py install for docopt 08:36:16 INFO - Successfully installed blobuploader requests docopt 08:36:16 INFO - Cleaning up... 08:36:16 INFO - Return code: 0 08:36:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:36: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')]} 08:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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')]} 08:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:16 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 0x7f0c27c84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1416670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a58c0>, '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 0x14a67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a6c50>, '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': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', '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 08:36:16 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 08:36:16 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 08:36:16 INFO - Using env: {'DISPLAY': ':0', 08:36:16 INFO - 'HOME': '/home/cltbld', 08:36:16 INFO - 'LANG': 'en_US.UTF-8', 08:36:16 INFO - 'LANGUAGE': 'en_US:en', 08:36:16 INFO - 'LOGNAME': 'cltbld', 08:36:16 INFO - 'MAIL': '/var/mail/cltbld', 08:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:16 INFO - 'MOZ_NO_REMOTE': '1', 08:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:16 INFO - 'NO_EM_RESTART': '1', 08:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:36:16 INFO - 'PWD': '/builds/slave/test-pgo', 08:36:16 INFO - 'SHELL': '/bin/bash', 08:36:16 INFO - 'SHLVL': '1', 08:36:16 INFO - 'TERM': 'linux', 08:36:16 INFO - 'TMOUT': '86400', 08:36:16 INFO - 'USER': 'cltbld', 08:36:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', 08:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:16 INFO - '_': '/tools/buildbot/bin/python'} 08:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:36:17 INFO - Running setup.py (path:/tmp/pip-YkJh6d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:36:17 INFO - Running setup.py (path:/tmp/pip-qsFYkd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:36:17 INFO - Running setup.py (path:/tmp/pip-xlks5l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:36:17 INFO - Running setup.py (path:/tmp/pip-HV5jsR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:36:17 INFO - Running setup.py (path:/tmp/pip-12dGYq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:36:17 INFO - Running setup.py (path:/tmp/pip-xqYQZM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:36:17 INFO - Running setup.py (path:/tmp/pip-0fPBws-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:36:17 INFO - Running setup.py (path:/tmp/pip-NMI1oQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:36:17 INFO - Running setup.py (path:/tmp/pip-Cmoqvh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:36:17 INFO - Running setup.py (path:/tmp/pip-gmSCNW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:36:17 INFO - Running setup.py (path:/tmp/pip-4gUpUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:36:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:36:17 INFO - Running setup.py (path:/tmp/pip-ObzW0a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:36:18 INFO - Running setup.py (path:/tmp/pip-s71CAo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:36:18 INFO - Running setup.py (path:/tmp/pip-PQg6Qp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:36:18 INFO - Running setup.py (path:/tmp/pip-HxiNpa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:36:18 INFO - Running setup.py (path:/tmp/pip-n_MC2s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:36:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:36:18 INFO - Running setup.py (path:/tmp/pip-k6BUBs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:36:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:36:18 INFO - Running setup.py install for manifestparser 08:36:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:36:18 INFO - Running setup.py install for mozcrash 08:36:18 INFO - Running setup.py install for mozdebug 08:36:18 INFO - Running setup.py install for mozdevice 08:36:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:36:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:36:18 INFO - Running setup.py install for mozfile 08:36:18 INFO - Running setup.py install for mozhttpd 08:36:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:36:18 INFO - Running setup.py install for mozinfo 08:36:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:36:19 INFO - Running setup.py install for mozInstall 08:36:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:36:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:36:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:36:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:36:19 INFO - Running setup.py install for mozleak 08:36:19 INFO - Running setup.py install for mozlog 08:36:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:36:19 INFO - Running setup.py install for moznetwork 08:36:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:36:19 INFO - Running setup.py install for mozprocess 08:36:19 INFO - Running setup.py install for mozprofile 08:36:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:36:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:36:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:36:19 INFO - Running setup.py install for mozrunner 08:36:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:36:19 INFO - Running setup.py install for mozscreenshot 08:36:19 INFO - Running setup.py install for moztest 08:36:20 INFO - Running setup.py install for mozversion 08:36:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:36:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:36:20 INFO - Cleaning up... 08:36:20 INFO - Return code: 0 08:36:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:20 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 0x7f0c27c84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1416670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a58c0>, '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 0x14a67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a6c50>, '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': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', '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 08:36:20 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 08:36:20 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 08:36:20 INFO - Using env: {'DISPLAY': ':0', 08:36:20 INFO - 'HOME': '/home/cltbld', 08:36:20 INFO - 'LANG': 'en_US.UTF-8', 08:36:20 INFO - 'LANGUAGE': 'en_US:en', 08:36:20 INFO - 'LOGNAME': 'cltbld', 08:36:20 INFO - 'MAIL': '/var/mail/cltbld', 08:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:20 INFO - 'MOZ_NO_REMOTE': '1', 08:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:20 INFO - 'NO_EM_RESTART': '1', 08:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:36:20 INFO - 'PWD': '/builds/slave/test-pgo', 08:36:20 INFO - 'SHELL': '/bin/bash', 08:36:20 INFO - 'SHLVL': '1', 08:36:20 INFO - 'TERM': 'linux', 08:36:20 INFO - 'TMOUT': '86400', 08:36:20 INFO - 'USER': 'cltbld', 08:36:20 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', 08:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:20 INFO - '_': '/tools/buildbot/bin/python'} 08:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:36:20 INFO - Running setup.py (path:/tmp/pip-mhNQKO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:36:20 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)) 08:36:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:36:20 INFO - Running setup.py (path:/tmp/pip-o8YgmI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:36:20 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)) 08:36:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:36:20 INFO - Running setup.py (path:/tmp/pip-tghS8q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:36:20 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)) 08:36:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:36:20 INFO - Running setup.py (path:/tmp/pip-gt0u82-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:36:20 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)) 08:36:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:36:20 INFO - Running setup.py (path:/tmp/pip-OsGhH9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:36:20 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)) 08:36:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:36:20 INFO - Running setup.py (path:/tmp/pip-RuiJfx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:36:20 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)) 08:36:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:36:20 INFO - Running setup.py (path:/tmp/pip-vrFcmB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:36:20 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)) 08:36:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:36:20 INFO - Running setup.py (path:/tmp/pip-JiSDEq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:36:20 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)) 08:36:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:36:20 INFO - Running setup.py (path:/tmp/pip-w7mulp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:36:20 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)) 08:36:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:36:21 INFO - Running setup.py (path:/tmp/pip-qlg6ae-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:36:21 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)) 08:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:36:21 INFO - Running setup.py (path:/tmp/pip-xkGEzE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:36:21 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)) 08:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:36:21 INFO - Running setup.py (path:/tmp/pip-cYJYEC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:36:21 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)) 08:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:36:21 INFO - Running setup.py (path:/tmp/pip-xcDEO6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:36:21 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)) 08:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:36:21 INFO - Running setup.py (path:/tmp/pip-Q8X3KX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:36:21 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)) 08:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:36:21 INFO - Running setup.py (path:/tmp/pip-OgPUep-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:36:21 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)) 08:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:36:21 INFO - Running setup.py (path:/tmp/pip-hBjWt9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:36:21 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)) 08:36:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:36:21 INFO - Running setup.py (path:/tmp/pip-UuXPNI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:36:21 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)) 08:36:21 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)) 08:36:21 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)) 08:36:21 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)) 08:36:21 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)) 08:36:21 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)) 08:36:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:23 INFO - Downloading blessings-1.6.tar.gz 08:36:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:36:23 INFO - Installing collected packages: blessings 08:36:23 INFO - Running setup.py install for blessings 08:36:23 INFO - Successfully installed blessings 08:36:23 INFO - Cleaning up... 08:36:23 INFO - Return code: 0 08:36:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:36:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:36:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:36:23 INFO - Reading from file tmpfile_stdout 08:36:23 INFO - Current package versions: 08:36:23 INFO - argparse == 1.2.1 08:36:23 INFO - blessings == 1.6 08:36:23 INFO - blobuploader == 1.2.4 08:36:23 INFO - docopt == 0.6.1 08:36:23 INFO - manifestparser == 1.1 08:36:23 INFO - mozInstall == 1.12 08:36:23 INFO - mozcrash == 0.16 08:36:23 INFO - mozdebug == 0.1 08:36:23 INFO - mozdevice == 0.48 08:36:23 INFO - mozfile == 1.2 08:36:23 INFO - mozhttpd == 0.7 08:36:23 INFO - mozinfo == 0.9 08:36:23 INFO - mozleak == 0.1 08:36:23 INFO - mozlog == 3.1 08:36:23 INFO - moznetwork == 0.27 08:36:23 INFO - mozprocess == 0.22 08:36:23 INFO - mozprofile == 0.28 08:36:23 INFO - mozrunner == 6.11 08:36:23 INFO - mozscreenshot == 0.1 08:36:23 INFO - mozsystemmonitor == 0.0 08:36:23 INFO - moztest == 0.7 08:36:23 INFO - mozversion == 1.4 08:36:23 INFO - psutil == 3.1.1 08:36:23 INFO - requests == 1.2.3 08:36:23 INFO - wsgiref == 0.1.2 08:36:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:36: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')]} 08:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36: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')]} 08:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:23 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 0x7f0c27c84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1416670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a58c0>, '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 0x14a67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a6c50>, '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': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', '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 08:36:23 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 08:36:23 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 08:36:23 INFO - Using env: {'DISPLAY': ':0', 08:36:23 INFO - 'HOME': '/home/cltbld', 08:36:23 INFO - 'LANG': 'en_US.UTF-8', 08:36:23 INFO - 'LANGUAGE': 'en_US:en', 08:36:23 INFO - 'LOGNAME': 'cltbld', 08:36:23 INFO - 'MAIL': '/var/mail/cltbld', 08:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:23 INFO - 'MOZ_NO_REMOTE': '1', 08:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:23 INFO - 'NO_EM_RESTART': '1', 08:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:36:23 INFO - 'PWD': '/builds/slave/test-pgo', 08:36:23 INFO - 'SHELL': '/bin/bash', 08:36:23 INFO - 'SHLVL': '1', 08:36:23 INFO - 'TERM': 'linux', 08:36:23 INFO - 'TMOUT': '86400', 08:36:23 INFO - 'USER': 'cltbld', 08:36:23 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', 08:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:23 INFO - '_': '/tools/buildbot/bin/python'} 08:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:24 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)) 08:36:24 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)) 08:36:24 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)) 08:36:24 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)) 08:36:24 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)) 08:36:24 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)) 08:36:24 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)) 08:36:24 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)) 08:36:24 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)) 08:36:24 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)) 08:36:24 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)) 08:36:24 INFO - Cleaning up... 08:36:24 INFO - Return code: 0 08:36:24 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:36:24 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')]} 08:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:24 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')]} 08:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:24 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 0x7f0c27c84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1416670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a58c0>, '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 0x14a67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a6c50>, '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': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', '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 08:36:24 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 08:36:24 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 08:36:24 INFO - Using env: {'DISPLAY': ':0', 08:36:24 INFO - 'HOME': '/home/cltbld', 08:36:24 INFO - 'LANG': 'en_US.UTF-8', 08:36:24 INFO - 'LANGUAGE': 'en_US:en', 08:36:24 INFO - 'LOGNAME': 'cltbld', 08:36:24 INFO - 'MAIL': '/var/mail/cltbld', 08:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:24 INFO - 'MOZ_NO_REMOTE': '1', 08:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:24 INFO - 'NO_EM_RESTART': '1', 08:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:36:24 INFO - 'PWD': '/builds/slave/test-pgo', 08:36:24 INFO - 'SHELL': '/bin/bash', 08:36:24 INFO - 'SHLVL': '1', 08:36:24 INFO - 'TERM': 'linux', 08:36:24 INFO - 'TMOUT': '86400', 08:36:24 INFO - 'USER': 'cltbld', 08:36:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', 08:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:24 INFO - '_': '/tools/buildbot/bin/python'} 08:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:24 INFO - Downloading/unpacking jsonschema 08:36:24 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 08:36:24 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 08:36:24 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 08:36:24 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 08:36:24 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 08:36:24 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 08:36:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:36:26 INFO - Downloading/unpacking functools32 (from jsonschema) 08:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:36:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:36:26 INFO - warning: no files found matching '*.txt' 08:36:26 INFO - no previously-included directories found matching 'build' 08:36:26 INFO - no previously-included directories found matching 'dist' 08:36:26 INFO - no previously-included directories found matching '.git*' 08:36:26 INFO - Installing collected packages: jsonschema, functools32 08:36:26 INFO - Running setup.py install for functools32 08:36:26 INFO - warning: no files found matching '*.txt' 08:36:26 INFO - no previously-included directories found matching 'build' 08:36:26 INFO - no previously-included directories found matching 'dist' 08:36:26 INFO - no previously-included directories found matching '.git*' 08:36:26 INFO - Successfully installed jsonschema functools32 08:36:26 INFO - Cleaning up... 08:36:26 INFO - Return code: 0 08:36:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:26 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 0x7f0c27c84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1416670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a58c0>, '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 0x14a67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a6c50>, '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': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', '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 08:36:26 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 08:36:26 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 08:36:26 INFO - Using env: {'DISPLAY': ':0', 08:36:26 INFO - 'HOME': '/home/cltbld', 08:36:26 INFO - 'LANG': 'en_US.UTF-8', 08:36:26 INFO - 'LANGUAGE': 'en_US:en', 08:36:26 INFO - 'LOGNAME': 'cltbld', 08:36:26 INFO - 'MAIL': '/var/mail/cltbld', 08:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:26 INFO - 'MOZ_NO_REMOTE': '1', 08:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:26 INFO - 'NO_EM_RESTART': '1', 08:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:36:26 INFO - 'PWD': '/builds/slave/test-pgo', 08:36:26 INFO - 'SHELL': '/bin/bash', 08:36:26 INFO - 'SHLVL': '1', 08:36:26 INFO - 'TERM': 'linux', 08:36:26 INFO - 'TMOUT': '86400', 08:36:26 INFO - 'USER': 'cltbld', 08:36:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', 08:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:26 INFO - '_': '/tools/buildbot/bin/python'} 08:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:26 INFO - Downloading/unpacking flake8 08:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:36:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:36:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:36:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:36:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:36:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:36:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:36:29 INFO - no previously-included directories found matching 'docs/_build' 08:36:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:36:29 INFO - Running setup.py install for pep8 08:36:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:36:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:36:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:36:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:36:29 INFO - no previously-included directories found matching 'docs/_build' 08:36:29 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:36:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:36:29 INFO - Cleaning up... 08:36:29 INFO - Return code: 0 08:36:29 INFO - Running post-action listener: _resource_record_post_action 08:36:29 INFO - Running post-action listener: _start_resource_monitoring 08:36:29 INFO - Starting resource monitoring. 08:36:29 INFO - ##### 08:36:29 INFO - ##### Running install step. 08:36:29 INFO - ##### 08:36:29 INFO - Running pre-action listener: _resource_record_pre_action 08:36:29 INFO - Running main action method: install 08:36:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:36:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:36:29 INFO - Reading from file tmpfile_stdout 08:36:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:36:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:36:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:36:29 INFO - Reading from file tmpfile_stdout 08:36:29 INFO - Output received: 08:36:29 INFO - Usage: mozinstall [options] installer 08:36:29 INFO - Options: 08:36:29 INFO - -h, --help show this help message and exit 08:36:29 INFO - -d DEST, --destination=DEST 08:36:29 INFO - Directory to install application into. [default: 08:36:29 INFO - "/builds/slave/test-pgo"] 08:36:29 INFO - --app=APP Application being installed. [default: firefox] 08:36:29 INFO - mkdir: /builds/slave/test-pgo/build/application 08:36:29 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'] 08:36:29 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 08:36:45 INFO - Reading from file tmpfile_stdout 08:36:45 INFO - Output received: 08:36:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:36:45 INFO - Running post-action listener: _resource_record_post_action 08:36:45 INFO - ##### 08:36:45 INFO - ##### Running run-tests step. 08:36:45 INFO - ##### 08:36:45 INFO - Running pre-action listener: _resource_record_pre_action 08:36:45 INFO - Running main action method: run_tests 08:36:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:36:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:36:45 INFO - Python 2.7.3 08:36:45 INFO - Return code: 0 08:36:45 INFO - grabbing minidump binary from tooltool 08:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:45 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 0x14a58c0>, '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 0x14a67c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a6c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:36:45 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 08:36:45 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 08:36:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:36:46 INFO - Return code: 0 08:36:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:36:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:36:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:36:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:36:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:36:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:36:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:36:47 INFO - Return code: 0 08:36:47 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/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 08:36:47 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/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 08:36:47 INFO - Using env: {'DISPLAY': ':0', 08:36:47 INFO - 'HOME': '/home/cltbld', 08:36:47 INFO - 'LANG': 'en_US.UTF-8', 08:36:47 INFO - 'LANGUAGE': 'en_US:en', 08:36:47 INFO - 'LOGNAME': 'cltbld', 08:36:47 INFO - 'MAIL': '/var/mail/cltbld', 08:36:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:36:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:47 INFO - 'MOZ_NO_REMOTE': '1', 08:36:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:47 INFO - 'NO_EM_RESTART': '1', 08:36:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:36:47 INFO - 'PWD': '/builds/slave/test-pgo', 08:36:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:36:47 INFO - 'SHELL': '/bin/bash', 08:36:47 INFO - 'SHLVL': '1', 08:36:47 INFO - 'TERM': 'linux', 08:36:47 INFO - 'TMOUT': '86400', 08:36:47 INFO - 'USER': 'cltbld', 08:36:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687', 08:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:47 INFO - '_': '/tools/buildbot/bin/python'} 08:36:47 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/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 08:36:47 INFO - mozversion application_buildid: 20160210053003 08:36:47 INFO - mozversion application_changeset: b3acf53ea44057f28e7a5d8b0bdd3dcdcef42d83 08:36:47 INFO - mozversion application_display_name: Nightly 08:36:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:36:47 INFO - mozversion application_name: Firefox 08:36:47 INFO - mozversion application_remotingname: firefox 08:36:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:36:47 INFO - mozversion application_vendor: Mozilla 08:36:47 INFO - mozversion application_version: 47.0a1 08:36:47 INFO - mozversion platform_buildid: 20160210053003 08:36:47 INFO - mozversion platform_changeset: b3acf53ea44057f28e7a5d8b0bdd3dcdcef42d83 08:36:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:36:47 INFO - mozversion platform_version: 47.0a1 08:36:47 INFO - using testdate: 1455122207 08:36:47 INFO - actual date: 1455122207 08:36:47 INFO - starting webserver on 'localhost:54428' 08:36:47 INFO - SUITE-START | Running 2 tests 08:36:47 INFO - TEST-START | dromaeo_css 08:36:47 INFO - operating with platform_type : linux_ 08:36:47 INFO - Initialising browser for dromaeo_css test... 08:36:47 INFO - TEST-INFO | started process 3309 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpobWjwg/profile http://localhost:54428/getInfo.html) 08:36:54 INFO - PROCESS | 3309 | __metrics Screen width/height:1600/1200 08:36:54 INFO - PROCESS | 3309 | colorDepth:24 08:36:54 INFO - PROCESS | 3309 | Browser inner width/height: 1024/697 08:36:54 INFO - PROCESS | 3309 | __metrics 08:36:55 INFO - PROCESS | 3309 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:36:56 INFO - TEST-INFO | 3309: exit 0 08:36:56 INFO - Browser initialized. 08:36:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:36:56 INFO - TEST-INFO | started process 3401 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpobWjwg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:08 INFO - PROCESS | 3401 | RSS: Main: 153346048 08:37:08 INFO - PROCESS | 3401 | 08:37:59 INFO - PROCESS | 3401 | 1455122279857 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] 08:40:08 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:54428/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54428/tests/dromaeo/cssquery-ext.html) 08:40:09 INFO - PROCESS | 3401 | RSS: Main: 228868096 08:40:09 INFO - PROCESS | 3401 | 08:43:12 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:54428/tests/dromaeo/cssquery-ext.html (next: http://localhost:54428/tests/dromaeo/cssquery-jquery.html) 08:43:12 INFO - PROCESS | 3401 | RSS: Main: 244387840 08:43:12 INFO - PROCESS | 3401 | 08:46:14 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:54428/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54428/tests/dromaeo/cssquery-mootools.html) 08:46:15 INFO - PROCESS | 3401 | RSS: Main: 239886336 08:46:15 INFO - PROCESS | 3401 | 08:49:17 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:54428/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54428/tests/dromaeo/cssquery-prototype.html) 08:49:17 INFO - PROCESS | 3401 | RSS: Main: 218349568 08:49:17 INFO - PROCESS | 3401 | 08:52:20 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:54428/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54428/tests/dromaeo/cssquery-yui.html) 08:52:20 INFO - PROCESS | 3401 | RSS: Main: 220418048 08:52:20 INFO - PROCESS | 3401 | 08:55:23 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:54428/tests/dromaeo/cssquery-yui.html (next: http://localhost:54428/tests/dromaeo/cssquery-dojo.html) 08:55:23 INFO - PROCESS | 3401 | RSS: Main: 296771584 08:55:23 INFO - PROCESS | 3401 | 08:55:23 INFO - PROCESS | 3401 | __start_tp_report 08:55:23 INFO - PROCESS | 3401 | _x_x_mozilla_page_load 08:55:23 INFO - PROCESS | 3401 | _x_x_mozilla_page_load_details 08:55:23 INFO - PROCESS | 3401 | |i|pagename|runs| 08:55:23 INFO - PROCESS | 3401 | |0;dojo.html;3139;3153.3062726200237;3183.0928185467133;3191.409589225992;3225.096972847602;5145.459726728691;5166;5179.8446046618565;5206.5574426173725;5305.522502974732;5298.09932311508;5344.22508736233;5353.357597088355;5363.195520671901;5371.462853714636;4721.527847215269;4774.188387974053;4895.461499235082;4933.284673722308;4945.936623625919;4637.605803506689;4889.462159162489;4920.065187614359;4921.532454416824;4931.802727890898;4677.719336839784;4802.471728109905;4858.975705121487;4880.341153944243;4880.731559764212;4797.18447863864;4802.4957379475;4811.542903424169;4829.95170048302;4864.659473836833;4722.055588882203;4782.426108866958;4801.18379875422;4813.9890622969215;4837.129316722989;5069.138246498104;5105.566026887719;5118.155504341779;5121.590272778206;5126.71803050832;5644.435556444323;5679.488846003838;5696.316442026942;5749.971250143764;5750.913736293959;5630.915536266959;5631.63394379364;5643.351014633328;5649.0396632572565;5652.9152062719095;5216.243644671501;5247.763850626693;5253.842384728464;5257.579393648499;5293.682379057192;5792.362840087587;5883.058710606282;5888.263967004124;5888.676122813201;5933.614315069507;5560.332760068737;5570.080936645408;5602.691851948182;5609.635373700697;5614.1859430382365;5427.375851777097;5549.889002219933;5672.631278966854;5696.3733989261145;5708.086706127;5726.112452569859;5732.3121225453215;5739.139129130664;5747.339056008613;5753.626014309057;5714.514266287329;5734.082546792493;5740.827775166752;5742.684152371659;5745.68398738065;4331.566843315643;4369.80335884886;4400.559944005574;4434.977825110854;4446.399736035659;3908.4332771748504;3911.647951684305;3914.4715463412645;3946.408038794204;3975.20495900821;5240.213967904769;5299.814506492255;5321.521063104339;5324.04167249891;5337.199420087018;5511.476409741148;5592.720363981784;5711.571632127607;5765.1928729977835;5780;5230.686158830483;5306.734663266821;5331.973340133274;5333.493318134771;5335.706536140472;4779.95220047802;4921.064997650435;4921.335619691367;4923.335349727812;4926.75366231687;5924.496417804448;5947.5539334550085;5973.462388384979;5985.910211346746;6042;5661.2923384576925;5663;5667.121596152603;5673.205751194753;5689.687067211343;5760.711964401847;5849.824505264849;5862.794802181903;5924.407559244041;5937.643741375358;5666;5731.541476681939;5733.684647344436;5736.225609542658;5791.507721843691;5709;5718.428157184248;5721.542276617777;5723.914141287801;5724.599278050663;5344.118220493575;5426.864328391822;5512.310961129859;5574.9442505574425;5596.1605759136455;5646.265985421869;5649.68926709035;5653.152027195789;5657.943420565906;5665.546756259407;5499.285092937893;5560.527355174855;5564.02629539837;5566.332040155207;5571.693556854412;5408.215808707794;5502.449755024466;5605.383407825055;5628;5646.35066967304;5538.833834984957;5541.141123125922;5545;5550.4449555044175;5550.972245138749 08:55:23 INFO - PROCESS | 3401 | |1;ext.html;522.474912712724;529.8913722686849;535.7348112684222;548.5447078924493;550.900837849187;28207.576886346695;28657.713422865763;28833.711662883365;28843.42313153741;28867;29208.415831683353;36446.27107457849;37635;37666.43500347497;37749;8540.829183416328;8541.95729021354;8552.102029286929;8556.144385561456;8556.144385561456;8330.62512186953;8598.699045533407;8638.049814520398;8639.827203455927;8643.0924752901;8425.873611895795;8506.617202225914;8592.957035214815;8616.396852220347;8683.869741953877;8471.745847624581;8597.914020859775;8668.566571671392;8680.218780309802;8689;8680.08859069795;8716.956415217883;8787.868181977276;8791.428557143765;8792.736217913473;39632.20735585301;39643;39983.20033599341;39983.20033599341;40132.59867401318;3422.093145316493;3422.435298175798;3492.7185191830276;3653.8355773990234;3664.193877346979;28591.28521786951;28672.856635716897;28921.276968075756;30040.098797036124;30040.8497957511;3673.9081522961874;3723.8138093095235;3754.755940863835;3789.488419063419;3843.8270277837287;271348;272962;273204.999999998;273596;273626;53740.73129634405;53818;61164.69417652972;61622.69188654028;61638;70950;72145;72273.63863180755;72317;72370.63814680892;15587.766183507256;15920.283587238602;15929.920350398406;15931.761023584655;15940.362385504683;11352.205345625727;12186.878131218575;12215.450304736309;12362.75274494505;12557.874421255854;19763.703544446846;20199.39401817948;20254.088566014565;20273.898630506752;20300;7881.645325960346;8158.551279679675;8260.669573217125;8304.750857474286;8364.832703346021;999.1008092716613;1047.1256500821746;1076.1659713721772;1077.0737166037202;1157.398152960456;28582.141410909677;28974.71025289762;29346.413071738447;31145.68854311473;31577.210569735482;1067.4609322292192;1068.3056013591229;1121.2543658467027;1155.174050553858;1158.959436419738;14210;14635.414583416545;14667.559973200821;14687.485937992118;14747.483838065617;473148;475137;477036;477824;478792;51567;51943.74028129835;52117.73941130346;52163;52217.7389113052;1279.4818098670053;1373.3545233740126;1376.7315373502272;1381.3990913952464;1419.9219042952736;27986.160415187576;29054.564181537717;29444.852775736843;29992.85003574968;30093.69906300909;40699.79650101731;40830.183396332504;40882.59117408788;41425;42081.78959105185;187311.06344468734;188049;191405;191476;193305;31059.37881242408;31278.37443251168;31990.68009319877;32098.19754506156;32148.517772232968;42285;42447;42959;43201.13597727965;43337.69986900398;35233;35633.28733425265;35958.26611594151;36742;37249;27346.179614611592;30314.696853031186;35337;37477.43783843299;37601.62398376091;33702;34017.14957126092;34193.829030854686;34263.31473370469;34277.314453710285;28722;29653.40693186081;30559.847200764743;30914;30916.22709432282;23448.531029378977;23743.643845342678;23745.168919087748;23799.64300535459;26450.735492644828 08:55:23 INFO - PROCESS | 3401 | |2;jquery.html;362.8856910073327;367.1518791591424;367.86756767563674;373.63943794238565;374.77326217638347;16483.175841207936;17077.23152458139;17379.91310043451;17602.11989400531;17631.823681763177;16771.66456670866;17042.318307267724;17555.82444175558;17615.383461578847;17673.381431649894;5398.973005134969;5405.567554595633;5523.6685798851995;5533.806316778893;5535.308086489189;4993.800247990076;5571.247881536002;5617.269754931853;5617.466340697627;5622.606417550773;4034.536028356747;4184.3305071188615;5340.62615616907;5457.836264912039;5468.343798744157;5769.855753606173;5954.46409823118;6007.549433792461;6009.06859436788;6009.128676341949;5236.633435659505;5313.362396512443;5339.866503337409;5340.839774806762;5341.172118321666;15597.688046239125;19373.225070997145;19398.4180474586;19415.22339106434;20389.388318350473;2234.7988681018787;2328.8006676561586;2334.0430423526273;2341.988290058556;2342.390978345625;12837.29394883281;13054.347282635925;13098.2141071536;13316.533921312708;13662.863371366258;1925.2491528303972;1948;1956.3152896486258;1996.6505861474184;2050.620635182496;56832;57659.71170144164;58290.41709582935;59033.704831475996;59971.10043349397;9903.356281841658;10055.547500362502;10248.333858299187;10287.742806429898;10352.482375881176;13185.73628527424;13312.800307995389;13332.73334533304;13364.264965426995;13383.130096543693;7770.456068075294;7794.10367807698;7805.68777248915;7818;7866.213378662088;7666.080070391477;7671.194524574951;7674.961625191839;7700.306972372401;7727.150013498511;6091.208142941389;6122.081687746873;6178.351273116348;6179.443850053427;6184.628922264678;1795.4703362508092;1801.7297405389033;1816.6548355812354;1820.981790182081;1823.0975667044634;420.5563130896872;828.3083625172927;949.620151939216;962.2446379591987;1013.0274936061317;9253;10640.521176547074;11240.662780116609;11302.717432064264;11406.429678516208;481.0547274605417;489.32228863024966;503.14465408805177;507.60660488122;508.7411891203047;6159.23009623797;6433.453156481752;9754.170895473964;9925.106740393256;9990.850137247948;536892;537625;542020;557218;560741;45488;50012.74993625009;74928.87606685904;76038.61980690171;77369.613151935;1182.3792508932706;1194.8506436695413;1195.3222194575765;1196.037190061991;1200.6158029430674;15622.375104996128;15733.370665173265;15846.683066338379;16026.519204423887;16034.518964431085;34432;34639;34657.13357166091;35305.47041794426;35656.82171589125;44356;45879.31181032221;49652.25521617106;50898;51073.23390149076;7686.769396918102;7737.1102323233545;7779.222077792176;7794.337481314152;7948.8807667883875;9182.494962776844;11310.038646714793;11376.203665743318;11680.649580512598;11876.287422754662;9672.661456848977;9906.405615663083;9955.153811926068;9955.950220248853;10238.283320167517;9781.559829807533;9993.250506212209;10132.66948601811;10202.132660382435;10246.59013639476;7278.599677017814;9460.668876589287;9877.851832222379;10058.597656093674;10120.696379108638;7753.573553454614;7757.573333466714;7845.490043147177;7949.1255961843;8020.318272946864;9324.487153206368;10468.162546996375;10503.94748026255;10593.89406105929;10645 08:55:23 INFO - PROCESS | 3401 | |3;mootools.html;1347.4542810161888;1499.910005399676;1513.7199618070654;1680.5462525118219;1814.6370725854824;7049.929500704998;7512.774616761499;7643;7707.537547747125;7713.537187768738;7536.736214232503;7762.029746281715;7776.222377762221;7779.688812447495;7788.883166752503;2011.386527109231;2052.7844576319494;2285.725712914444;2316.073570571776;2345.2729653807287;2365.597848365773;2372.3476044087843;2377.8335516513853;2379.762023797624;2380.321608341623;2278.3734473019886;2343.2267351773958;2346.941326466835;2347.565700345433;2350.8471949323325;2303.5738388398117;2337.55586438577;2365.73976862545;2367.419982104378;2368.064614477289;2322.5935461294207;2339.777721116491;2366.171839856054;2387.8447900886385;2392.9042838286446;7749.573773442458;7772.766816995442;7781.922180778233;7788.493747906368;7797.883031754528;4976.800927962877;4992.276119962585;5014;5054.216596427523;5087.923681144785;3151.7321027712674;3162.383335249627;3248.7238584720326;3270.721988630969;3285.786423882464;1016.654337525245;1021.5607288865784;1037.444966942682;1050.2018465965843;1064.966982027432;10944.288621239593;11018.338899665965;11018.559257629686;11048.779024419466;11051.17116216279;4482.75344856036;4609.608183304456;4613.6770426070525;4618.1918164321105;4624.352590637313;9335.953320233355;9337.766555836159;9346.177495388334;9348.532573371303;9364.391314564667;4958.752062396866;4987.127252730757;4999.3000979862845;5000.599952003831;5001.274815151783;4572.611328037087;4577.130345234395;4608.423947006624;4640.6751527393435;4641.559051890065;3516.6659167379057;3759.436084587334;3786.072412258959;3849.210911763138;3851.114243723959;1207.541134368934;1226.4607917064027;1231.0151878497165;1237.4431505822415;1252.3738130934532;1344.2405041151717;1354.6816498122932;1358.9660258493616;1368.0697125954446;1377.5798381493742;7375.926240737524;7477.439192060618;7494.475386722877;7496.212897645669;7666.578338191453;1143.3940011793763;1157.9652610421701;1160.878107798686;1182.8757980411933;1183.3018519073787;5806.82579522615;5832;5859.560532960045;5870.178175055496;5923.141144534018;9198.126178013077;9592.95203523978;9593.808123837623;9747.853782193273;9757.658481953098;9610.711678649512;9626.422414655142;9632.47021413829;9639.084286992724;9644.855327170098;7291.817704557428;7434.665440055102;7550.131734850453;7550.35821955129;7752.7286544971785;7122.074130363227;7136.036635054201;7146.785596432115;7179.138503379419;7188.101487314086;8426.368022398467;8535.3598480113;8622.741317760478;8728.563571821256;8937.73186804397;8629.309655227442;8780.517071561126;8948.284137268873;9081.182693557612;9127.269818414643;6156.138140660221;6930.237673855771;6990.720371185299;7087.68105435267;7113.146422429135;7298.671559779928;7458.254174582498;7487.064116985377;7499.850003000019;7513.2862378074;6827.48793840454;7159.248278930846;7200.71197152129;7270.309320614533;7295.270472952662;6896.689648965708;7047.612381319077;7079;7134.250903655042;7138.428925686037;6927.861442771217;7030.753923612649;7037.437005039687;7058.25888281723;7086.929130708627;6400.45596124316;6437.259715132633;6554.57395269325;6583.0454584086;6583.901241481477;6548.47612191014;6593.076969224217;6634.336566343327;6638.20341559016;6640.136782218281 08:55:24 INFO - PROCESS | 3401 | |4;prototype.html;333.6480013585666;333.85143611093065;337.3287158554477;342.3649130862252;345.1870844161997;5714.657120572769;5817.214676018736;5822.65064096154;5847.473727364536;5874.471297583216;5570.442955704428;5726.971365143178;5761.1358296255585;5764.942350576493;5774.307083150017;4506.797194126256;4507.166174257764;4519.796609152596;4521.412216411862;4531.388262584542;4329.913401731964;4368.606825385715;4488.394066800989;4512.0975804839;4523.6607254455885;4473.66447516436;4473.753943533105;4474.261746811772;4481.4846292676275;4485.192665320241;4476.328550717386;4480.910381792379;4481.574250446202;4503.909921801545;4508.233600287959;3985.501812273466;3987.1626958338784;3988.581198974095;3995.360742281221;3997.300472417315;5421.83734487962;5558.082916318803;5577.274954255961;5588.720563971826;5601.943980560224;5168.8449346519665;5168.974155129238;5173.3016042834115;5173.508516690908;5173.948260517384;5951.821445356603;6177.598456100384;6219.34696856828;6220.782272620437;6224.284207316171;4208.179405016023;4291.0774183550375;4291.506476755182;4295.871123866289;4341.609255167018;6358.551957496351;6465.579737317059;6485.93514064858;6489.09152718615;6490.643014634194;4398.164348773723;4412.536683648235;4413.889652758707;4424.933625995613;4426.557344265612;4247.68142389322;4398.56014398564;4461.754603496839;4471.821127154943;4472.686911916199;5128.076946149728;5139.640225184201;5143.305653736773;5144.1223953256795;5146;6246.968765156145;6260;6260.843478913063;6261.436470717657;6263.968680156661;1558.2909776052095;1581.6836632673512;1582.327510807902;1582.889197756146;1583.9862488007684;1050.2333296693457;1059.7880423915249;1062.1131355318241;1077.8598782158426;1089.7221208591916;5908.438698323653;5923.585349025613;5925.496332811759;5931.169636250928;5933.258342707161;6391.776287829996;6402.263739669997;6407.679616019181;6407.807765767035;6425.421712045938;5915.349311575723;5921.467067963904;5924.911126333109;5927.051671732502;5927.525797936155;3347.4811404232382;3461.532693086401;3466.878659246914;3469.5836499619704;3492.0920560654413;6783.796486105425;6786.898196527056;6793.388595026471;6796.660166991631;6805.9659701701175;6650.900236496456;6652.8669426611195;6653.933460665428;6659.067730517731;6667.399934005963;6579.80260592183;6739.371645058432;6749.08887300218;6749.932500675029;6780.288069752605;6171.9074213887725;6292.402221788922;6467.126937863516;6470.320616335217;6471.288158302677;6408.391202835724;6421.5825971311715;6428.100065990859;6429.453496452854;6429.485641148791;6687.331266873273;6748.460123190232;6757.391834734897;6767.35710107539;6767.424768894699;4406.691531592758;4436.511983681857;4467.396901418267;4468.709533880287;4471.485779135311;6381.074744162163;6381.680915954276;6388.488920886411;6395.456386207038;6438.67806609677;6281.403266689657;6289.119523266838;6292.087647291026;6292.276388215414;6292.402221788922;6170.197874276315;6193.597416167935;6259.186305780219;6266.530010249341;6273.466755325666;6165.815025549241;6166.167567378347;6171.9691401542705;6175.84560385994;6176.66028368444;6278.309385967448;6285.057241413824;6291.307956124731;6296.118543404019;6303.086052522267;6038;6147.0779383092895;6151.569390142647;6152.323244443197;6156.753729850756 08:55:24 INFO - PROCESS | 3401 | |5;yui.html;790.1426951757343;794.6582969323191;803.2529747334976;823.3660081737063;830.8213734047182;13926.860731392682;14069.507567235123;14081;14089.084209526374;14109.365078571476;13171.93414032931;13182;13190.142640728345;13225.140365876236;13225.470981160766;824.2746383182791;826.7437094500724;838.8364268967554;840.9369297302696;841.6675413211777;842.692417267696;843.8354520868434;845.71245776436;846.6105591427951;847.2882778466087;865.6234537975969;867.5878957495203;868.9044205137429;869.1221865915408;869.4348673362302;873.3842640938124;875.1336177184605;875.369733791669;875.8117004843989;876.3296078499952;641.1472741254121;641.5477088652535;642.6240649220211;643.1542521584101;644.3427703742157;14067.366968486444;14383.352749126314;14390.136591804525;14400.351984160738;14446.422143114263;12328.32194229317;12566.246025238515;12673.49306027767;12743;12925;10349.327293725959;10608.893911060868;10752.19358548112;10828.296160749525;11141.832872506919;3505.8422370993367;3558.19940513385;3630.673239408466;3666.7616604920595;3669.7614655047337;45007.549924500665;45187.54812451866;51248.23127653088;52864.47135528634;54220.728896355264;8992.505412202261;9193.816123677489;9771.364861283993;9871.210303175729;10027.649032283834;18042.90978545125;18059.729104063448;18115.184816683282;18152;18210.726839097424;7614.505057171266;7773.533587984739;7875.133735289113;8087.797805054921;8111.797205069921;4496.730196188174;4499.257622492252;4535.863924082283;4611.838585649486;4626.514216007338;3203.08712017074;3212.662670419619;3218.3724173786354;3220.130564747505;3227.306129182237;581.5870731780399;596.5645079092287;604.268834709997;607.5139888089511;617.9196704428396;626.9310375858652;672.2974491656231;679.1307126877605;700.4921431961787;708.3377042465312;8107.918920810835;8492.447990880573;9063.410878293022;9811.116999470081;9934.105930466292;690.2752110284182;702.4310308650009;727.0766127018657;731.8828987361996;739.9371053460409;4099.323611604052;4150.252954468165;4198.412222288882;4202.3696445533415;4231.809568569422;54746.452535474935;56066.719666401405;56182;56287;56523.434765651815;52898;53258.46741532535;53690.73154634202;54348.18477722837;54375.45624543783;43686.781566091966;45108.54891451044;50201.49798501968;50445.45100038993;50522.242166367534;8831.293496520391;8881.555922203994;9273.489958052372;9323.533823308942;9496.525173741424;33329.333413331115;33610.49584256189;34217.828910855285;35258.471122932664;35363.646363536034;43275.35086973761;43846.12307753891;43933.56066439295;46650.53349466598;47033;12140.392980351124;12298;12346.506139754309;12355.25868447896;12789.552365667529;12429.316387598768;12433.751324973631;12795.42420591057;12862.807057893951;12912.483500659868;11581.826272606086;11906.761864762482;12069.094817888868;12385.071119665881;12405.44175512086;11450.885491144982;11550.88449115498;11687.590934317259;11780.212783948245;11965.820512692142;11674.591389301333;11792.646220613395;11856.407179641155;11882.76234475323;12012;9362.812743745224;9374.859377109213;9411.34120611578;9451.574679139592;9921.156701680438;9359;9504;9850.408975461496;10283.588656453958;10299.485025748832 08:55:24 INFO - PROCESS | 3401 | __end_tp_report 08:55:24 INFO - PROCESS | 3401 | __start_cc_report 08:55:24 INFO - PROCESS | 3401 | _x_x_mozilla_cycle_collect,870 08:55:24 INFO - PROCESS | 3401 | __end_cc_report 08:55:24 INFO - PROCESS | 3401 | __startTimestamp1455123323991__endTimestamp 08:55:24 INFO - PROCESS | 3401 | 08:55:24 INFO - PROCESS | 3401 | ------- Summary: start ------- 08:55:24 INFO - PROCESS | 3401 | Number of tests: 6 08:55:24 INFO - PROCESS | 3401 | 08:55:24 INFO - PROCESS | 3401 | [#0] dojo.html Cycles:165 Average:5285.04 Median:5512.31 stddev:593.41 (10.8%) stddev-sans-first:570.85 08:55:24 INFO - PROCESS | 3401 | Values: 3139.0 3153.3 3183.1 3191.4 3225.1 5145.5 5166.0 5179.8 5206.6 5305.5 5298.1 5344.2 5353.4 5363.2 5371.5 4721.5 4774.2 4895.5 4933.3 4945.9 4637.6 4889.5 4920.1 4921.5 4931.8 4677.7 4802.5 4859.0 4880.3 4880.7 4797.2 4802.5 4811.5 4830.0 4864.7 4722.1 4782.4 4801.2 4814.0 4837.1 5069.1 5105.6 5118.2 5121.6 5126.7 5644.4 5679.5 5696.3 5750.0 5750.9 5630.9 5631.6 5643.4 5649.0 5652.9 5216.2 5247.8 5253.8 5257.6 5293.7 5792.4 5883.1 5888.3 5888.7 5933.6 5560.3 5570.1 5602.7 5609.6 5614.2 5427.4 5549.9 5672.6 5696.4 5708.1 5726.1 5732.3 5739.1 5747.3 5753.6 5714.5 5734.1 5740.8 5742.7 5745.7 4331.6 4369.8 4400.6 4435.0 4446.4 3908.4 3911.6 3914.5 3946.4 3975.2 5240.2 5299.8 5321.5 5324.0 5337.2 5511.5 5592.7 5711.6 5765.2 5780.0 5230.7 5306.7 5332.0 5333.5 5335.7 4780.0 4921.1 4921.3 4923.3 4926.8 5924.5 5947.6 5973.5 5985.9 6042.0 5661.3 5663.0 5667.1 5673.2 5689.7 5760.7 5849.8 5862.8 5924.4 5937.6 5666.0 5731.5 5733.7 5736.2 5791.5 5709.0 5718.4 5721.5 5723.9 5724.6 5344.1 5426.9 5512.3 5574.9 5596.2 5646.3 5649.7 5653.2 5657.9 5665.5 5499.3 5560.5 5564.0 5566.3 5571.7 5408.2 5502.4 5605.4 5628.0 5646.4 5538.8 5541.1 5545.0 5550.4 5551.0 08:55:24 INFO - PROCESS | 3401 | 08:55:24 INFO - PROCESS | 3401 | [#1] ext.html Cycles:180 Average:47617.38 Median:35285.00 stddev:89195.10 (252.8%) stddev-sans-first:89375.22 08:55:24 INFO - PROCESS | 3401 | Values: 522.5 529.9 535.7 548.5 550.9 28207.6 28657.7 28833.7 28843.4 28867.0 29208.4 36446.3 37635.0 37666.4 37749.0 8540.8 8542.0 8552.1 8556.1 8556.1 8330.6 8598.7 8638.0 8639.8 8643.1 8425.9 8506.6 8593.0 8616.4 8683.9 8471.7 8597.9 8668.6 8680.2 8689.0 8680.1 8717.0 8787.9 8791.4 8792.7 39632.2 39643.0 39983.2 39983.2 40132.6 3422.1 3422.4 3492.7 3653.8 3664.2 28591.3 28672.9 28921.3 30040.1 30040.8 3673.9 3723.8 3754.8 3789.5 3843.8 271348.0 272962.0 273205.0 273596.0 273626.0 53740.7 53818.0 61164.7 61622.7 61638.0 70950.0 72145.0 72273.6 72317.0 72370.6 15587.8 15920.3 15929.9 15931.8 15940.4 11352.2 12186.9 12215.5 12362.8 12557.9 19763.7 20199.4 20254.1 20273.9 20300.0 7881.6 8158.6 8260.7 8304.8 8364.8 999.1 1047.1 1076.2 1077.1 1157.4 28582.1 28974.7 29346.4 31145.7 31577.2 1067.5 1068.3 1121.3 1155.2 1159.0 14210.0 14635.4 14667.6 14687.5 14747.5 473148.0 475137.0 477036.0 477824.0 478792.0 51567.0 51943.7 52117.7 52163.0 52217.7 1279.5 1373.4 1376.7 1381.4 1419.9 27986.2 29054.6 29444.9 29992.9 30093.7 40699.8 40830.2 40882.6 41425.0 42081.8 187311.1 188049.0 191405.0 191476.0 193305.0 31059.4 31278.4 31990.7 32098.2 32148.5 42285.0 42447.0 42959.0 43201.1 43337.7 35233.0 35633.3 35958.3 36742.0 37249.0 27346.2 30314.7 35337.0 37477.4 37601.6 33702.0 34017.1 34193.8 34263.3 34277.3 28722.0 29653.4 30559.8 30914.0 30916.2 23448.5 23743.6 23745.2 23799.6 26450.7 08:55:24 INFO - PROCESS | 3401 | 08:55:24 INFO - PROCESS | 3401 | [#2] jquery.html Cycles:180 Average:27852.39 Median:25070.79 stddev:89294.98 (356.2%) stddev-sans-first:89521.62 08:55:24 INFO - PROCESS | 3401 | Values: 362.9 367.2 367.9 373.6 374.8 16483.2 17077.2 17379.9 17602.1 17631.8 16771.7 17042.3 17555.8 17615.4 17673.4 5399.0 5405.6 5523.7 5533.8 5535.3 4993.8 5571.2 5617.3 5617.5 5622.6 4034.5 4184.3 5340.6 5457.8 5468.3 5769.9 5954.5 6007.5 6009.1 6009.1 5236.6 5313.4 5339.9 5340.8 5341.2 15597.7 19373.2 19398.4 19415.2 20389.4 2234.8 2328.8 2334.0 2342.0 2342.4 12837.3 13054.3 13098.2 13316.5 13662.9 1925.2 1948.0 1956.3 1996.7 2050.6 56832.0 57659.7 58290.4 59033.7 59971.1 9903.4 10055.5 10248.3 10287.7 10352.5 13185.7 13312.8 13332.7 13364.3 13383.1 7770.5 7794.1 7805.7 7818.0 7866.2 7666.1 7671.2 7675.0 7700.3 7727.2 6091.2 6122.1 6178.4 6179.4 6184.6 1795.5 1801.7 1816.7 1821.0 1823.1 420.6 828.3 949.6 962.2 1013.0 9253.0 10640.5 11240.7 11302.7 11406.4 481.1 489.3 503.1 507.6 508.7 6159.2 6433.5 9754.2 9925.1 9990.9 536892.0 537625.0 542020.0 557218.0 560741.0 45488.0 50012.7 74928.9 76038.6 77369.6 1182.4 1194.9 1195.3 1196.0 1200.6 15622.4 15733.4 15846.7 16026.5 16034.5 34432.0 34639.0 34657.1 35305.5 35656.8 44356.0 45879.3 49652.3 50898.0 51073.2 7686.8 7737.1 7779.2 7794.3 7948.9 9182.5 11310.0 11376.2 11680.6 11876.3 9672.7 9906.4 9955.2 9956.0 10238.3 9781.6 9993.3 10132.7 10202.1 10246.6 7278.6 9460.7 9877.9 10058.6 10120.7 7753.6 7757.6 7845.5 7949.1 8020.3 9324.5 10468.2 10503.9 10593.9 10645.0 08:55:24 INFO - PROCESS | 3401 | 08:55:24 INFO - PROCESS | 3401 | [#3] mootools.html Cycles:180 Average:5584.51 Median:6278.30 stddev:2853.85 (45.5%) stddev-sans-first:2844.08 08:55:24 INFO - PROCESS | 3401 | Values: 1347.5 1499.9 1513.7 1680.5 1814.6 7049.9 7512.8 7643.0 7707.5 7713.5 7536.7 7762.0 7776.2 7779.7 7788.9 2011.4 2052.8 2285.7 2316.1 2345.3 2365.6 2372.3 2377.8 2379.8 2380.3 2278.4 2343.2 2346.9 2347.6 2350.8 2303.6 2337.6 2365.7 2367.4 2368.1 2322.6 2339.8 2366.2 2387.8 2392.9 7749.6 7772.8 7781.9 7788.5 7797.9 4976.8 4992.3 5014.0 5054.2 5087.9 3151.7 3162.4 3248.7 3270.7 3285.8 1016.7 1021.6 1037.4 1050.2 1065.0 10944.3 11018.3 11018.6 11048.8 11051.2 4482.8 4609.6 4613.7 4618.2 4624.4 9336.0 9337.8 9346.2 9348.5 9364.4 4958.8 4987.1 4999.3 5000.6 5001.3 4572.6 4577.1 4608.4 4640.7 4641.6 3516.7 3759.4 3786.1 3849.2 3851.1 1207.5 1226.5 1231.0 1237.4 1252.4 1344.2 1354.7 1359.0 1368.1 1377.6 7375.9 7477.4 7494.5 7496.2 7666.6 1143.4 1158.0 1160.9 1182.9 1183.3 5806.8 5832.0 5859.6 5870.2 5923.1 9198.1 9593.0 9593.8 9747.9 9757.7 9610.7 9626.4 9632.5 9639.1 9644.9 7291.8 7434.7 7550.1 7550.4 7752.7 7122.1 7136.0 7146.8 7179.1 7188.1 8426.4 8535.4 8622.7 8728.6 8937.7 8629.3 8780.5 8948.3 9081.2 9127.3 6156.1 6930.2 6990.7 7087.7 7113.1 7298.7 7458.3 7487.1 7499.9 7513.3 6827.5 7159.2 7200.7 7270.3 7295.3 6896.7 7047.6 7079.0 7134.3 7138.4 6927.9 7030.8 7037.4 7058.3 7086.9 6400.5 6437.3 6554.6 6583.0 6583.9 6548.5 6593.1 6634.3 6638.2 6640.1 08:55:24 INFO - PROCESS | 3401 | 08:55:24 INFO - PROCESS | 3401 | [#4] prototype.html Cycles:180 Average:5212.89 Median:5911.89 stddev:1576.26 (26.7%) stddev-sans-first:1537.55 08:55:24 INFO - PROCESS | 3401 | Values: 333.6 333.9 337.3 342.4 345.2 5714.7 5817.2 5822.7 5847.5 5874.5 5570.4 5727.0 5761.1 5764.9 5774.3 4506.8 4507.2 4519.8 4521.4 4531.4 4329.9 4368.6 4488.4 4512.1 4523.7 4473.7 4473.8 4474.3 4481.5 4485.2 4476.3 4480.9 4481.6 4503.9 4508.2 3985.5 3987.2 3988.6 3995.4 3997.3 5421.8 5558.1 5577.3 5588.7 5601.9 5168.8 5169.0 5173.3 5173.5 5173.9 5951.8 6177.6 6219.3 6220.8 6224.3 4208.2 4291.1 4291.5 4295.9 4341.6 6358.6 6465.6 6485.9 6489.1 6490.6 4398.2 4412.5 4413.9 4424.9 4426.6 4247.7 4398.6 4461.8 4471.8 4472.7 5128.1 5139.6 5143.3 5144.1 5146.0 6247.0 6260.0 6260.8 6261.4 6264.0 1558.3 1581.7 1582.3 1582.9 1584.0 1050.2 1059.8 1062.1 1077.9 1089.7 5908.4 5923.6 5925.5 5931.2 5933.3 6391.8 6402.3 6407.7 6407.8 6425.4 5915.3 5921.5 5924.9 5927.1 5927.5 3347.5 3461.5 3466.9 3469.6 3492.1 6783.8 6786.9 6793.4 6796.7 6806.0 6650.9 6652.9 6653.9 6659.1 6667.4 6579.8 6739.4 6749.1 6749.9 6780.3 6171.9 6292.4 6467.1 6470.3 6471.3 6408.4 6421.6 6428.1 6429.5 6429.5 6687.3 6748.5 6757.4 6767.4 6767.4 4406.7 4436.5 4467.4 4468.7 4471.5 6381.1 6381.7 6388.5 6395.5 6438.7 6281.4 6289.1 6292.1 6292.3 6292.4 6170.2 6193.6 6259.2 6266.5 6273.5 6165.8 6166.2 6172.0 6175.8 6176.7 6278.3 6285.1 6291.3 6296.1 6303.1 6038.0 6147.1 6151.6 6152.3 6156.8 08:55:24 INFO - PROCESS | 3401 | 08:55:24 INFO - PROCESS | 3401 | [#5] yui.html Cycles:180 Average:14109.35 Median:46841.77 stddev:16157.62 (34.5%) stddev-sans-first:16171.99 08:55:24 INFO - PROCESS | 3401 | Values: 790.1 794.7 803.3 823.4 830.8 13926.9 14069.5 14081.0 14089.1 14109.4 13171.9 13182.0 13190.1 13225.1 13225.5 824.3 826.7 838.8 840.9 841.7 842.7 843.8 845.7 846.6 847.3 865.6 867.6 868.9 869.1 869.4 873.4 875.1 875.4 875.8 876.3 641.1 641.5 642.6 643.2 644.3 14067.4 14383.4 14390.1 14400.4 14446.4 12328.3 12566.2 12673.5 12743.0 12925.0 10349.3 10608.9 10752.2 10828.3 11141.8 3505.8 3558.2 3630.7 3666.8 3669.8 45007.5 45187.5 51248.2 52864.5 54220.7 8992.5 9193.8 9771.4 9871.2 10027.6 18042.9 18059.7 18115.2 18152.0 18210.7 7614.5 7773.5 7875.1 8087.8 8111.8 4496.7 4499.3 4535.9 4611.8 4626.5 3203.1 3212.7 3218.4 3220.1 3227.3 581.6 596.6 604.3 607.5 617.9 626.9 672.3 679.1 700.5 708.3 8107.9 8492.4 9063.4 9811.1 9934.1 690.3 702.4 727.1 731.9 739.9 4099.3 4150.3 4198.4 4202.4 4231.8 54746.5 56066.7 56182.0 56287.0 56523.4 52898.0 53258.5 53690.7 54348.2 54375.5 43686.8 45108.5 50201.5 50445.5 50522.2 8831.3 8881.6 9273.5 9323.5 9496.5 33329.3 33610.5 34217.8 35258.5 35363.6 43275.4 43846.1 43933.6 46650.5 47033.0 12140.4 12298.0 12346.5 12355.3 12789.6 12429.3 12433.8 12795.4 12862.8 12912.5 11581.8 11906.8 12069.1 12385.1 12405.4 11450.9 11550.9 11687.6 11780.2 11965.8 11674.6 11792.6 11856.4 11882.8 12012.0 9362.8 9374.9 9411.3 9451.6 9921.2 9359.0 9504.0 9850.4 10283.6 10299.5 08:55:24 INFO - PROCESS | 3401 | -------- Summary: end -------- 08:55:24 INFO - PROCESS | 3401 | 08:55:24 INFO - TEST-INFO | 3401: exit 0 08:55:24 INFO - TEST-OK | dromaeo_css | took 1117266ms 08:55:24 INFO - TEST-START | kraken 08:55:24 INFO - operating with platform_type : linux_ 08:55:24 INFO - Initialising browser for kraken test... 08:55:24 INFO - TEST-INFO | started process 3578 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQL5TNk/profile http://localhost:54428/getInfo.html) 08:55:28 INFO - PROCESS | 3578 | __metrics Screen width/height:1600/1200 08:55:28 INFO - PROCESS | 3578 | colorDepth:24 08:55:28 INFO - PROCESS | 3578 | Browser inner width/height: 1024/697 08:55:28 INFO - PROCESS | 3578 | __metrics 08:55:29 INFO - PROCESS | 3578 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:30 INFO - TEST-INFO | 3578: exit 0 08:55:30 INFO - Browser initialized. 08:55:30 INFO - Running cycle 1/1 for kraken test... 08:55:30 INFO - TEST-INFO | started process 3660 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQL5TNk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:42 INFO - PROCESS | 3660 | RSS: Main: 153382912 08:55:42 INFO - PROCESS | 3660 | 08:55:44 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54428/tests/kraken/driver.html?testName=audio-beat-detection) 08:55:45 INFO - PROCESS | 3660 | RSS: Main: 193130496 08:55:45 INFO - PROCESS | 3660 | 08:55:47 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54428/tests/kraken/driver.html?testName=audio-dft) 08:55:48 INFO - PROCESS | 3660 | RSS: Main: 182489088 08:55:48 INFO - PROCESS | 3660 | 08:55:51 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54428/tests/kraken/driver.html?testName=audio-fft) 08:55:51 INFO - PROCESS | 3660 | RSS: Main: 167190528 08:55:51 INFO - PROCESS | 3660 | 08:55:53 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54428/tests/kraken/driver.html?testName=audio-oscillator) 08:55:54 INFO - PROCESS | 3660 | RSS: Main: 167649280 08:55:54 INFO - PROCESS | 3660 | 08:55:56 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54428/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:55:57 INFO - PROCESS | 3660 | RSS: Main: 169611264 08:55:57 INFO - PROCESS | 3660 | 08:56:00 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54428/tests/kraken/driver.html?testName=imaging-darkroom) 08:56:00 INFO - PROCESS | 3660 | RSS: Main: 169328640 08:56:00 INFO - PROCESS | 3660 | 08:56:04 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54428/tests/kraken/driver.html?testName=imaging-desaturate) 08:56:04 INFO - PROCESS | 3660 | RSS: Main: 171151360 08:56:04 INFO - PROCESS | 3660 | 08:56:07 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54428/tests/kraken/driver.html?testName=json-parse-financial) 08:56:08 INFO - PROCESS | 3660 | RSS: Main: 170098688 08:56:08 INFO - PROCESS | 3660 | 08:56:09 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54428/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:56:10 INFO - PROCESS | 3660 | RSS: Main: 182337536 08:56:10 INFO - PROCESS | 3660 | 08:56:12 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54428/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:56:12 INFO - PROCESS | 3660 | RSS: Main: 180486144 08:56:12 INFO - PROCESS | 3660 | 08:56:16 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54428/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:56:16 INFO - PROCESS | 3660 | RSS: Main: 187793408 08:56:16 INFO - PROCESS | 3660 | 08:56:17 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:56:18 INFO - PROCESS | 3660 | RSS: Main: 194445312 08:56:18 INFO - PROCESS | 3660 | 08:56:21 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:56:21 INFO - PROCESS | 3660 | RSS: Main: 194752512 08:56:21 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | Cycle 1(1): loaded http://localhost:54428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54428/tests/kraken/driver.html?testName=ai-astar) 08:56:23 INFO - PROCESS | 3660 | RSS: Main: 255950848 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | __start_tp_report 08:56:23 INFO - PROCESS | 3660 | _x_x_mozilla_page_load 08:56:23 INFO - PROCESS | 3660 | _x_x_mozilla_page_load_details 08:56:23 INFO - PROCESS | 3660 | |i|pagename|runs| 08:56:23 INFO - PROCESS | 3660 | |0;ai-astar;111;112;106;109;112;111;104;110;111;110 08:56:23 INFO - PROCESS | 3660 | |1;audio-beat-detection;151;127;150;172;128;151;160;126;165;129 08:56:23 INFO - PROCESS | 3660 | |2;audio-dft;162;163;163;162;162;163;161;163;161;165 08:56:23 INFO - PROCESS | 3660 | |3;audio-fft;77;77;93;98;74;75;72;115;93;72 08:56:23 INFO - PROCESS | 3660 | |4;audio-oscillator;97;97;144;97;98;97;137;96;96;149 08:56:23 INFO - PROCESS | 3660 | |5;imaging-gaussian-blur;119;115;115;116;115;115;116;115;115;114 08:56:23 INFO - PROCESS | 3660 | |6;imaging-darkroom;146;146;145;146;145;145;146;145;145;145 08:56:23 INFO - PROCESS | 3660 | |7;imaging-desaturate;96;97;97;96;96;96;96;96;95;97 08:56:23 INFO - PROCESS | 3660 | |8;json-parse-financial;58;57;57;57;57;57;58;65;57;57 08:56:23 INFO - PROCESS | 3660 | |9;json-stringify-tinderbox;68;67;68;68;68;68;70;68;69;69 08:56:23 INFO - PROCESS | 3660 | |10;stanford-crypto-aes;87;81;83;83;82;82;82;83;91;82 08:56:23 INFO - PROCESS | 3660 | |11;stanford-crypto-ccm;118;117;118;118;121;124;118;118;124;121 08:56:23 INFO - PROCESS | 3660 | |12;stanford-crypto-pbkdf2;158;145;153;152;152;139;153;152;153;151 08:56:23 INFO - PROCESS | 3660 | |13;stanford-crypto-sha256-iterative;70;70;69;70;71;70;70;69;70;68 08:56:23 INFO - PROCESS | 3660 | __end_tp_report 08:56:23 INFO - PROCESS | 3660 | __start_cc_report 08:56:23 INFO - PROCESS | 3660 | _x_x_mozilla_cycle_collect,976 08:56:23 INFO - PROCESS | 3660 | __end_cc_report 08:56:23 INFO - PROCESS | 3660 | __startTimestamp1455123383630__endTimestamp 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | ------- Summary: start ------- 08:56:23 INFO - PROCESS | 3660 | Number of tests: 14 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:2.63 (2.4%) stddev-sans-first:2.74 08:56:23 INFO - PROCESS | 3660 | Values: 111.0 112.0 106.0 109.0 112.0 111.0 104.0 110.0 111.0 110.0 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:151.00 stddev:17.23 (11.4%) stddev-sans-first:18.18 08:56:23 INFO - PROCESS | 3660 | Values: 151.0 127.0 150.0 172.0 128.0 151.0 160.0 126.0 165.0 129.0 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 08:56:23 INFO - PROCESS | 3660 | Values: 162.0 163.0 163.0 162.0 162.0 163.0 161.0 163.0 161.0 165.0 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#3] audio-fft Cycles:10 Average:84.60 Median:77.00 stddev:14.46 (18.8%) stddev-sans-first:15.08 08:56:23 INFO - PROCESS | 3660 | Values: 77.0 77.0 93.0 98.0 74.0 75.0 72.0 115.0 93.0 72.0 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:97.00 stddev:22.64 (23.3%) stddev-sans-first:23.45 08:56:23 INFO - PROCESS | 3660 | Values: 97.0 97.0 144.0 97.0 98.0 97.0 137.0 96.0 96.0 149.0 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:0.60 08:56:23 INFO - PROCESS | 3660 | Values: 119.0 115.0 115.0 116.0 115.0 115.0 116.0 115.0 115.0 114.0 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:56:23 INFO - PROCESS | 3660 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:56:23 INFO - PROCESS | 3660 | Values: 96.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 97.0 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.00 stddev:2.49 (4.4%) stddev-sans-first:2.65 08:56:23 INFO - PROCESS | 3660 | Values: 58.0 57.0 57.0 57.0 57.0 57.0 58.0 65.0 57.0 57.0 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 08:56:23 INFO - PROCESS | 3660 | Values: 68.0 67.0 68.0 68.0 68.0 68.0 70.0 68.0 69.0 69.0 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:3.06 (3.7%) stddev-sans-first:2.99 08:56:23 INFO - PROCESS | 3660 | Values: 87.0 81.0 83.0 83.0 82.0 82.0 82.0 83.0 91.0 82.0 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:119.50 stddev:2.63 (2.2%) stddev-sans-first:2.71 08:56:23 INFO - PROCESS | 3660 | Values: 118.0 117.0 118.0 118.0 121.0 124.0 118.0 118.0 124.0 121.0 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.80 Median:152.50 stddev:5.20 (3.4%) stddev-sans-first:4.82 08:56:23 INFO - PROCESS | 3660 | Values: 158.0 145.0 153.0 152.0 152.0 139.0 153.0 152.0 153.0 151.0 08:56:23 INFO - PROCESS | 3660 | 08:56:23 INFO - PROCESS | 3660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 08:56:23 INFO - PROCESS | 3660 | Values: 70.0 70.0 69.0 70.0 71.0 70.0 70.0 69.0 70.0 68.0 08:56:23 INFO - PROCESS | 3660 | -------- Summary: end -------- 08:56:23 INFO - PROCESS | 3660 | 08:56:24 INFO - TEST-INFO | 3660: exit 0 08:56:24 INFO - TEST-OK | kraken | took 59838ms 08:56:24 INFO - SUITE-END | took 1177s 08:56:24 INFO - Completed test suite (00:19:37) 08:56:24 INFO - Working with test: dromaeo_css 08:56:24 INFO - Generating results file: dromaeo_css 08:56:24 INFO - Working with test: kraken 08:56:24 INFO - Generating results file: kraken 08:56:24 INFO - javascript benchmark 08:56:24 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:56:24 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:56:24 INFO - process_Request line: dromaeo_css 6937.25 graph.html#tests=[[72,64,35]] 08:56:24 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:56:24 INFO - process_Request line: kraken 1520.60 graph.html#tests=[[232,64,35]] 08:56:24 INFO - RETURN: dromaeo_css: 6937.25 08:56:24 INFO - RETURN: kraken: 1520.60 08:56:24 INFO - javascript benchmark 08:56:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3139.0, 3153.3062726200237, 3183.0928185467133, 3191.409589225992, 3225.096972847602, 5145.459726728691, 5166.0, 5179.8446046618565, 5206.5574426173725, 5305.522502974732, 5298.09932311508, 5344.22508736233, 5353.357597088355, 5363.195520671901, 5371.462853714636, 4721.527847215269, 4774.188387974053, 4895.461499235082, 4933.284673722308, 4945.936623625919, 4637.605803506689, 4889.462159162489, 4920.065187614359, 4921.532454416824, 4931.802727890898, 4677.719336839784, 4802.471728109905, 4858.975705121487, 4880.341153944243, 4880.731559764212, 4797.18447863864, 4802.4957379475, 4811.542903424169, 4829.95170048302, 4864.659473836833, 4722.055588882203, 4782.426108866958, 4801.18379875422, 4813.9890622969215, 4837.129316722989, 5069.138246498104, 5105.566026887719, 5118.155504341779, 5121.590272778206, 5126.71803050832, 5644.435556444323, 5679.488846003838, 5696.316442026942, 5749.971250143764, 5750.913736293959, 5630.915536266959, 5631.63394379364, 5643.351014633328, 5649.0396632572565, 5652.9152062719095, 5216.243644671501, 5247.763850626693, 5253.842384728464, 5257.579393648499, 5293.682379057192, 5792.362840087587, 5883.058710606282, 5888.263967004124, 5888.676122813201, 5933.614315069507, 5560.332760068737, 5570.080936645408, 5602.691851948182, 5609.635373700697, 5614.1859430382365, 5427.375851777097, 5549.889002219933, 5672.631278966854, 5696.3733989261145, 5708.086706127, 5726.112452569859, 5732.3121225453215, 5739.139129130664, 5747.339056008613, 5753.626014309057, 5714.514266287329, 5734.082546792493, 5740.827775166752, 5742.684152371659, 5745.68398738065, 4331.566843315643, 4369.80335884886, 4400.559944005574, 4434.977825110854, 4446.399736035659, 3908.4332771748504, 3911.647951684305, 3914.4715463412645, 3946.408038794204, 3975.20495900821, 5240.213967904769, 5299.814506492255, 5321.521063104339, 5324.04167249891, 5337.199420087018, 5511.476409741148, 5592.720363981784, 5711.571632127607, 5765.1928729977835, 5780.0, 5230.686158830483, 5306.734663266821, 5331.973340133274, 5333.493318134771, 5335.706536140472, 4779.95220047802, 4921.064997650435, 4921.335619691367, 4923.335349727812, 4926.75366231687, 5924.496417804448, 5947.5539334550085, 5973.462388384979, 5985.910211346746, 6042.0, 5661.2923384576925, 5663.0, 5667.121596152603, 5673.205751194753, 5689.687067211343, 5760.711964401847, 5849.824505264849, 5862.794802181903, 5924.407559244041, 5937.643741375358, 5666.0, 5731.541476681939, 5733.684647344436, 5736.225609542658, 5791.507721843691, 5709.0, 5718.428157184248, 5721.542276617777, 5723.914141287801, 5724.599278050663, 5344.118220493575, 5426.864328391822, 5512.310961129859, 5574.9442505574425, 5596.1605759136455, 5646.265985421869, 5649.68926709035, 5653.152027195789, 5657.943420565906, 5665.546756259407, 5499.285092937893, 5560.527355174855, 5564.02629539837, 5566.332040155207, 5571.693556854412, 5408.215808707794, 5502.449755024466, 5605.383407825055, 5628.0, 5646.35066967304, 5538.833834984957, 5541.141123125922, 5545.0, 5550.4449555044175, 5550.972245138749], "unit": "score", "name": "dojo.html", "value": 5246.36545019152}, {"lowerIsBetter": false, "replicates": [522.474912712724, 529.8913722686849, 535.7348112684222, 548.5447078924493, 550.900837849187, 28207.576886346695, 28657.713422865763, 28833.711662883365, 28843.42313153741, 28867.0, 29208.415831683353, 36446.27107457849, 37635.0, 37666.43500347497, 37749.0, 8540.829183416328, 8541.95729021354, 8552.102029286929, 8556.144385561456, 8556.144385561456, 8330.62512186953, 8598.699045533407, 8638.049814520398, 8639.827203455927, 8643.0924752901, 8425.873611895795, 8506.617202225914, 8592.957035214815, 8616.396852220347, 8683.869741953877, 8471.745847624581, 8597.914020859775, 8668.566571671392, 8680.218780309802, 8689.0, 8680.08859069795, 8716.956415217883, 8787.868181977276, 8791.428557143765, 8792.736217913473, 39632.20735585301, 39643.0, 39983.20033599341, 39983.20033599341, 40132.59867401318, 3422.093145316493, 3422.435298175798, 3492.7185191830276, 3653.8355773990234, 3664.193877346979, 28591.28521786951, 28672.856635716897, 28921.276968075756, 30040.098797036124, 30040.8497957511, 3673.9081522961874, 3723.8138093095235, 3754.755940863835, 3789.488419063419, 3843.8270277837287, 271348.0, 272962.0, 273204.999999998, 273596.0, 273626.0, 53740.73129634405, 53818.0, 61164.69417652972, 61622.69188654028, 61638.0, 70950.0, 72145.0, 72273.63863180755, 72317.0, 72370.63814680892, 15587.766183507256, 15920.283587238602, 15929.920350398406, 15931.761023584655, 15940.362385504683, 11352.205345625727, 12186.878131218575, 12215.450304736309, 12362.75274494505, 12557.874421255854, 19763.703544446846, 20199.39401817948, 20254.088566014565, 20273.898630506752, 20300.0, 7881.645325960346, 8158.551279679675, 8260.669573217125, 8304.750857474286, 8364.832703346021, 999.1008092716613, 1047.1256500821746, 1076.1659713721772, 1077.0737166037202, 1157.398152960456, 28582.141410909677, 28974.71025289762, 29346.413071738447, 31145.68854311473, 31577.210569735482, 1067.4609322292192, 1068.3056013591229, 1121.2543658467027, 1155.174050553858, 1158.959436419738, 14210.0, 14635.414583416545, 14667.559973200821, 14687.485937992118, 14747.483838065617, 473148.0, 475137.0, 477036.0, 477824.0, 478792.0, 51567.0, 51943.74028129835, 52117.73941130346, 52163.0, 52217.7389113052, 1279.4818098670053, 1373.3545233740126, 1376.7315373502272, 1381.3990913952464, 1419.9219042952736, 27986.160415187576, 29054.564181537717, 29444.852775736843, 29992.85003574968, 30093.69906300909, 40699.79650101731, 40830.183396332504, 40882.59117408788, 41425.0, 42081.78959105185, 187311.06344468734, 188049.0, 191405.0, 191476.0, 193305.0, 31059.37881242408, 31278.37443251168, 31990.68009319877, 32098.19754506156, 32148.517772232968, 42285.0, 42447.0, 42959.0, 43201.13597727965, 43337.69986900398, 35233.0, 35633.28733425265, 35958.26611594151, 36742.0, 37249.0, 27346.179614611592, 30314.696853031186, 35337.0, 37477.43783843299, 37601.62398376091, 33702.0, 34017.14957126092, 34193.829030854686, 34263.31473370469, 34277.314453710285, 28722.0, 29653.40693186081, 30559.847200764743, 30914.0, 30916.22709432282, 23448.531029378977, 23743.643845342678, 23745.168919087748, 23799.64300535459, 26450.735492644828], "unit": "score", "name": "ext.html", "value": 18234.962079986504}, {"lowerIsBetter": false, "replicates": [362.8856910073327, 367.1518791591424, 367.86756767563674, 373.63943794238565, 374.77326217638347, 16483.175841207936, 17077.23152458139, 17379.91310043451, 17602.11989400531, 17631.823681763177, 16771.66456670866, 17042.318307267724, 17555.82444175558, 17615.383461578847, 17673.381431649894, 5398.973005134969, 5405.567554595633, 5523.6685798851995, 5533.806316778893, 5535.308086489189, 4993.800247990076, 5571.247881536002, 5617.269754931853, 5617.466340697627, 5622.606417550773, 4034.536028356747, 4184.3305071188615, 5340.62615616907, 5457.836264912039, 5468.343798744157, 5769.855753606173, 5954.46409823118, 6007.549433792461, 6009.06859436788, 6009.128676341949, 5236.633435659505, 5313.362396512443, 5339.866503337409, 5340.839774806762, 5341.172118321666, 15597.688046239125, 19373.225070997145, 19398.4180474586, 19415.22339106434, 20389.388318350473, 2234.7988681018787, 2328.8006676561586, 2334.0430423526273, 2341.988290058556, 2342.390978345625, 12837.29394883281, 13054.347282635925, 13098.2141071536, 13316.533921312708, 13662.863371366258, 1925.2491528303972, 1948.0, 1956.3152896486258, 1996.6505861474184, 2050.620635182496, 56832.0, 57659.71170144164, 58290.41709582935, 59033.704831475996, 59971.10043349397, 9903.356281841658, 10055.547500362502, 10248.333858299187, 10287.742806429898, 10352.482375881176, 13185.73628527424, 13312.800307995389, 13332.73334533304, 13364.264965426995, 13383.130096543693, 7770.456068075294, 7794.10367807698, 7805.68777248915, 7818.0, 7866.213378662088, 7666.080070391477, 7671.194524574951, 7674.961625191839, 7700.306972372401, 7727.150013498511, 6091.208142941389, 6122.081687746873, 6178.351273116348, 6179.443850053427, 6184.628922264678, 1795.4703362508092, 1801.7297405389033, 1816.6548355812354, 1820.981790182081, 1823.0975667044634, 420.5563130896872, 828.3083625172927, 949.620151939216, 962.2446379591987, 1013.0274936061317, 9253.0, 10640.521176547074, 11240.662780116609, 11302.717432064264, 11406.429678516208, 481.0547274605417, 489.32228863024966, 503.14465408805177, 507.60660488122, 508.7411891203047, 6159.23009623797, 6433.453156481752, 9754.170895473964, 9925.106740393256, 9990.850137247948, 536892.0, 537625.0, 542020.0, 557218.0, 560741.0, 45488.0, 50012.74993625009, 74928.87606685904, 76038.61980690171, 77369.613151935, 1182.3792508932706, 1194.8506436695413, 1195.3222194575765, 1196.037190061991, 1200.6158029430674, 15622.375104996128, 15733.370665173265, 15846.683066338379, 16026.519204423887, 16034.518964431085, 34432.0, 34639.0, 34657.13357166091, 35305.47041794426, 35656.82171589125, 44356.0, 45879.31181032221, 49652.25521617106, 50898.0, 51073.23390149076, 7686.769396918102, 7737.1102323233545, 7779.222077792176, 7794.337481314152, 7948.8807667883875, 9182.494962776844, 11310.038646714793, 11376.203665743318, 11680.649580512598, 11876.287422754662, 9672.661456848977, 9906.405615663083, 9955.153811926068, 9955.950220248853, 10238.283320167517, 9781.559829807533, 9993.250506212209, 10132.66948601811, 10202.132660382435, 10246.59013639476, 7278.599677017814, 9460.668876589287, 9877.851832222379, 10058.597656093674, 10120.696379108638, 7753.573553454614, 7757.573333466714, 7845.490043147177, 7949.1255961843, 8020.318272946864, 9324.487153206368, 10468.162546996375, 10503.94748026255, 10593.89406105929, 10645.0], "unit": "score", "name": "jquery.html", "value": 8223.235332963912}, {"lowerIsBetter": false, "replicates": [1347.4542810161888, 1499.910005399676, 1513.7199618070654, 1680.5462525118219, 1814.6370725854824, 7049.929500704998, 7512.774616761499, 7643.0, 7707.537547747125, 7713.537187768738, 7536.736214232503, 7762.029746281715, 7776.222377762221, 7779.688812447495, 7788.883166752503, 2011.386527109231, 2052.7844576319494, 2285.725712914444, 2316.073570571776, 2345.2729653807287, 2365.597848365773, 2372.3476044087843, 2377.8335516513853, 2379.762023797624, 2380.321608341623, 2278.3734473019886, 2343.2267351773958, 2346.941326466835, 2347.565700345433, 2350.8471949323325, 2303.5738388398117, 2337.55586438577, 2365.73976862545, 2367.419982104378, 2368.064614477289, 2322.5935461294207, 2339.777721116491, 2366.171839856054, 2387.8447900886385, 2392.9042838286446, 7749.573773442458, 7772.766816995442, 7781.922180778233, 7788.493747906368, 7797.883031754528, 4976.800927962877, 4992.276119962585, 5014.0, 5054.216596427523, 5087.923681144785, 3151.7321027712674, 3162.383335249627, 3248.7238584720326, 3270.721988630969, 3285.786423882464, 1016.654337525245, 1021.5607288865784, 1037.444966942682, 1050.2018465965843, 1064.966982027432, 10944.288621239593, 11018.338899665965, 11018.559257629686, 11048.779024419466, 11051.17116216279, 4482.75344856036, 4609.608183304456, 4613.6770426070525, 4618.1918164321105, 4624.352590637313, 9335.953320233355, 9337.766555836159, 9346.177495388334, 9348.532573371303, 9364.391314564667, 4958.752062396866, 4987.127252730757, 4999.3000979862845, 5000.599952003831, 5001.274815151783, 4572.611328037087, 4577.130345234395, 4608.423947006624, 4640.6751527393435, 4641.559051890065, 3516.6659167379057, 3759.436084587334, 3786.072412258959, 3849.210911763138, 3851.114243723959, 1207.541134368934, 1226.4607917064027, 1231.0151878497165, 1237.4431505822415, 1252.3738130934532, 1344.2405041151717, 1354.6816498122932, 1358.9660258493616, 1368.0697125954446, 1377.5798381493742, 7375.926240737524, 7477.439192060618, 7494.475386722877, 7496.212897645669, 7666.578338191453, 1143.3940011793763, 1157.9652610421701, 1160.878107798686, 1182.8757980411933, 1183.3018519073787, 5806.82579522615, 5832.0, 5859.560532960045, 5870.178175055496, 5923.141144534018, 9198.126178013077, 9592.95203523978, 9593.808123837623, 9747.853782193273, 9757.658481953098, 9610.711678649512, 9626.422414655142, 9632.47021413829, 9639.084286992724, 9644.855327170098, 7291.817704557428, 7434.665440055102, 7550.131734850453, 7550.35821955129, 7752.7286544971785, 7122.074130363227, 7136.036635054201, 7146.785596432115, 7179.138503379419, 7188.101487314086, 8426.368022398467, 8535.3598480113, 8622.741317760478, 8728.563571821256, 8937.73186804397, 8629.309655227442, 8780.517071561126, 8948.284137268873, 9081.182693557612, 9127.269818414643, 6156.138140660221, 6930.237673855771, 6990.720371185299, 7087.68105435267, 7113.146422429135, 7298.671559779928, 7458.254174582498, 7487.064116985377, 7499.850003000019, 7513.2862378074, 6827.48793840454, 7159.248278930846, 7200.71197152129, 7270.309320614533, 7295.270472952662, 6896.689648965708, 7047.612381319077, 7079.0, 7134.250903655042, 7138.428925686037, 6927.861442771217, 7030.753923612649, 7037.437005039687, 7058.25888281723, 7086.929130708627, 6400.45596124316, 6437.259715132633, 6554.57395269325, 6583.0454584086, 6583.901241481477, 6548.47612191014, 6593.076969224217, 6634.336566343327, 6638.20341559016, 6640.136782218281], "unit": "score", "name": "mootools.html", "value": 4620.210346394097}, {"lowerIsBetter": false, "replicates": [333.6480013585666, 333.85143611093065, 337.3287158554477, 342.3649130862252, 345.1870844161997, 5714.657120572769, 5817.214676018736, 5822.65064096154, 5847.473727364536, 5874.471297583216, 5570.442955704428, 5726.971365143178, 5761.1358296255585, 5764.942350576493, 5774.307083150017, 4506.797194126256, 4507.166174257764, 4519.796609152596, 4521.412216411862, 4531.388262584542, 4329.913401731964, 4368.606825385715, 4488.394066800989, 4512.0975804839, 4523.6607254455885, 4473.66447516436, 4473.753943533105, 4474.261746811772, 4481.4846292676275, 4485.192665320241, 4476.328550717386, 4480.910381792379, 4481.574250446202, 4503.909921801545, 4508.233600287959, 3985.501812273466, 3987.1626958338784, 3988.581198974095, 3995.360742281221, 3997.300472417315, 5421.83734487962, 5558.082916318803, 5577.274954255961, 5588.720563971826, 5601.943980560224, 5168.8449346519665, 5168.974155129238, 5173.3016042834115, 5173.508516690908, 5173.948260517384, 5951.821445356603, 6177.598456100384, 6219.34696856828, 6220.782272620437, 6224.284207316171, 4208.179405016023, 4291.0774183550375, 4291.506476755182, 4295.871123866289, 4341.609255167018, 6358.551957496351, 6465.579737317059, 6485.93514064858, 6489.09152718615, 6490.643014634194, 4398.164348773723, 4412.536683648235, 4413.889652758707, 4424.933625995613, 4426.557344265612, 4247.68142389322, 4398.56014398564, 4461.754603496839, 4471.821127154943, 4472.686911916199, 5128.076946149728, 5139.640225184201, 5143.305653736773, 5144.1223953256795, 5146.0, 6246.968765156145, 6260.0, 6260.843478913063, 6261.436470717657, 6263.968680156661, 1558.2909776052095, 1581.6836632673512, 1582.327510807902, 1582.889197756146, 1583.9862488007684, 1050.2333296693457, 1059.7880423915249, 1062.1131355318241, 1077.8598782158426, 1089.7221208591916, 5908.438698323653, 5923.585349025613, 5925.496332811759, 5931.169636250928, 5933.258342707161, 6391.776287829996, 6402.263739669997, 6407.679616019181, 6407.807765767035, 6425.421712045938, 5915.349311575723, 5921.467067963904, 5924.911126333109, 5927.051671732502, 5927.525797936155, 3347.4811404232382, 3461.532693086401, 3466.878659246914, 3469.5836499619704, 3492.0920560654413, 6783.796486105425, 6786.898196527056, 6793.388595026471, 6796.660166991631, 6805.9659701701175, 6650.900236496456, 6652.8669426611195, 6653.933460665428, 6659.067730517731, 6667.399934005963, 6579.80260592183, 6739.371645058432, 6749.08887300218, 6749.932500675029, 6780.288069752605, 6171.9074213887725, 6292.402221788922, 6467.126937863516, 6470.320616335217, 6471.288158302677, 6408.391202835724, 6421.5825971311715, 6428.100065990859, 6429.453496452854, 6429.485641148791, 6687.331266873273, 6748.460123190232, 6757.391834734897, 6767.35710107539, 6767.424768894699, 4406.691531592758, 4436.511983681857, 4467.396901418267, 4468.709533880287, 4471.485779135311, 6381.074744162163, 6381.680915954276, 6388.488920886411, 6395.456386207038, 6438.67806609677, 6281.403266689657, 6289.119523266838, 6292.087647291026, 6292.276388215414, 6292.402221788922, 6170.197874276315, 6193.597416167935, 6259.186305780219, 6266.530010249341, 6273.466755325666, 6165.815025549241, 6166.167567378347, 6171.9691401542705, 6175.84560385994, 6176.66028368444, 6278.309385967448, 6285.057241413824, 6291.307956124731, 6296.118543404019, 6303.086052522267, 6038.0, 6147.0779383092895, 6151.569390142647, 6152.323244443197, 6156.753729850756], "unit": "score", "name": "prototype.html", "value": 4704.434343031893}, {"lowerIsBetter": false, "replicates": [790.1426951757343, 794.6582969323191, 803.2529747334976, 823.3660081737063, 830.8213734047182, 13926.860731392682, 14069.507567235123, 14081.0, 14089.084209526374, 14109.365078571476, 13171.93414032931, 13182.0, 13190.142640728345, 13225.140365876236, 13225.470981160766, 824.2746383182791, 826.7437094500724, 838.8364268967554, 840.9369297302696, 841.6675413211777, 842.692417267696, 843.8354520868434, 845.71245776436, 846.6105591427951, 847.2882778466087, 865.6234537975969, 867.5878957495203, 868.9044205137429, 869.1221865915408, 869.4348673362302, 873.3842640938124, 875.1336177184605, 875.369733791669, 875.8117004843989, 876.3296078499952, 641.1472741254121, 641.5477088652535, 642.6240649220211, 643.1542521584101, 644.3427703742157, 14067.366968486444, 14383.352749126314, 14390.136591804525, 14400.351984160738, 14446.422143114263, 12328.32194229317, 12566.246025238515, 12673.49306027767, 12743.0, 12925.0, 10349.327293725959, 10608.893911060868, 10752.19358548112, 10828.296160749525, 11141.832872506919, 3505.8422370993367, 3558.19940513385, 3630.673239408466, 3666.7616604920595, 3669.7614655047337, 45007.549924500665, 45187.54812451866, 51248.23127653088, 52864.47135528634, 54220.728896355264, 8992.505412202261, 9193.816123677489, 9771.364861283993, 9871.210303175729, 10027.649032283834, 18042.90978545125, 18059.729104063448, 18115.184816683282, 18152.0, 18210.726839097424, 7614.505057171266, 7773.533587984739, 7875.133735289113, 8087.797805054921, 8111.797205069921, 4496.730196188174, 4499.257622492252, 4535.863924082283, 4611.838585649486, 4626.514216007338, 3203.08712017074, 3212.662670419619, 3218.3724173786354, 3220.130564747505, 3227.306129182237, 581.5870731780399, 596.5645079092287, 604.268834709997, 607.5139888089511, 617.9196704428396, 626.9310375858652, 672.2974491656231, 679.1307126877605, 700.4921431961787, 708.3377042465312, 8107.918920810835, 8492.447990880573, 9063.410878293022, 9811.116999470081, 9934.105930466292, 690.2752110284182, 702.4310308650009, 727.0766127018657, 731.8828987361996, 739.9371053460409, 4099.323611604052, 4150.252954468165, 4198.412222288882, 4202.3696445533415, 4231.809568569422, 54746.452535474935, 56066.719666401405, 56182.0, 56287.0, 56523.434765651815, 52898.0, 53258.46741532535, 53690.73154634202, 54348.18477722837, 54375.45624543783, 43686.781566091966, 45108.54891451044, 50201.49798501968, 50445.45100038993, 50522.242166367534, 8831.293496520391, 8881.555922203994, 9273.489958052372, 9323.533823308942, 9496.525173741424, 33329.333413331115, 33610.49584256189, 34217.828910855285, 35258.471122932664, 35363.646363536034, 43275.35086973761, 43846.12307753891, 43933.56066439295, 46650.53349466598, 47033.0, 12140.392980351124, 12298.0, 12346.506139754309, 12355.25868447896, 12789.552365667529, 12429.316387598768, 12433.751324973631, 12795.42420591057, 12862.807057893951, 12912.483500659868, 11581.826272606086, 11906.761864762482, 12069.094817888868, 12385.071119665881, 12405.44175512086, 11450.885491144982, 11550.88449115498, 11687.590934317259, 11780.212783948245, 11965.820512692142, 11674.591389301333, 11792.646220613395, 11856.407179641155, 11882.76234475323, 12012.0, 9362.812743745224, 9374.859377109213, 9411.34120611578, 9451.574679139592, 9921.156701680438, 9359.0, 9504.0, 9850.408975461496, 10283.588656453958, 10299.485025748832], "unit": "score", "name": "yui.html", "value": 6517.95341233066}], "name": "dromaeo_css", "value": 6937.247835529038}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 106.0, 109.0, 112.0, 111.0, 104.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 150.0, 172.0, 128.0, 151.0, 160.0, 126.0, 165.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 162.0, 162.0, 163.0, 161.0, 163.0, 161.0, 165.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 93.0, 98.0, 74.0, 75.0, 72.0, 115.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 144.0, 97.0, 98.0, 97.0, 137.0, 96.0, 96.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 116.0, 115.0, 115.0, 116.0, 115.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 58.0, 65.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 70.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [87.0, 81.0, 83.0, 83.0, 82.0, 82.0, 82.0, 83.0, 91.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 118.0, 118.0, 121.0, 124.0, 118.0, 118.0, 124.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.7}, {"lowerIsBetter": true, "replicates": [158.0, 145.0, 153.0, 152.0, 152.0, 139.0, 153.0, 152.0, 153.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.8}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 70.0, 71.0, 70.0, 70.0, 69.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1520.6}]} 08:56:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1520.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6937.25"}}} 08:56:24 INFO - Return code: 0 08:56:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:56:25 INFO - # TBPL SUCCESS # 08:56:25 INFO - Running post-action listener: _resource_record_post_action 08:56:25 INFO - Running post-run listener: _resource_record_post_run 08:56:26 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 10338304; Write bytes: 424710144; Read time: 3132; Write time: 669496 08:56:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 84832256; Read time: 0; Write time: 153256 08:56:26 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 8577024; Write bytes: 335683584; Read time: 3020; Write time: 504692 08:56:26 INFO - Running post-run listener: _upload_blobber_files 08:56:26 INFO - Blob upload gear active. 08:56:26 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:56:26 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 08:56:26 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'] 08:56:26 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 08:56:26 INFO - (blobuploader) - INFO - Open directory for files ... 08:56:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:56:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:56:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:27 INFO - (blobuploader) - INFO - Done attempting. 08:56:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:56:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:56:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:28 INFO - (blobuploader) - INFO - Done attempting. 08:56:28 INFO - (blobuploader) - INFO - Iteration through files over. 08:56:28 INFO - Return code: 0 08:56:28 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:56:28 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:56:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f0db6cb869d6b701e98d5a512091007c10beb9fb14d1fc70a4194aaf74644a973199a2bd7623642dd09b8c79e822ff97e10d7acbbec1a278d9e4834e0488bbd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b03d34a0cabfe47a95ae84af002cd1f5df298177009edc80f13e99e0854181e988e970f9d2ad503c916b1d4ea666c23aa388cc7c9ab29312469944ca249b2e6a"} 08:56:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:56:28 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:56:28 INFO - Contents: 08:56:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f0db6cb869d6b701e98d5a512091007c10beb9fb14d1fc70a4194aaf74644a973199a2bd7623642dd09b8c79e822ff97e10d7acbbec1a278d9e4834e0488bbd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b03d34a0cabfe47a95ae84af002cd1f5df298177009edc80f13e99e0854181e988e970f9d2ad503c916b1d4ea666c23aa388cc7c9ab29312469944ca249b2e6a"} 08:56:28 INFO - Running post-run listener: copy_logs_to_upload_dir 08:56:28 INFO - Copying logs to upload dir... 08:56:28 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:56:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.079922 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-10 08:56:28.327692) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 08:56:28.330787) ========= 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=df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687 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/f0db6cb869d6b701e98d5a512091007c10beb9fb14d1fc70a4194aaf74644a973199a2bd7623642dd09b8c79e822ff97e10d7acbbec1a278d9e4834e0488bbd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b03d34a0cabfe47a95ae84af002cd1f5df298177009edc80f13e99e0854181e988e970f9d2ad503c916b1d4ea666c23aa388cc7c9ab29312469944ca249b2e6a"} build_url:https://queue.taskcluster.net/v1/task/ZJBxp5qOToKou7wdpBAc5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011160 build_url: 'https://queue.taskcluster.net/v1/task/ZJBxp5qOToKou7wdpBAc5g/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/f0db6cb869d6b701e98d5a512091007c10beb9fb14d1fc70a4194aaf74644a973199a2bd7623642dd09b8c79e822ff97e10d7acbbec1a278d9e4834e0488bbd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b03d34a0cabfe47a95ae84af002cd1f5df298177009edc80f13e99e0854181e988e970f9d2ad503c916b1d4ea666c23aa388cc7c9ab29312469944ca249b2e6a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 08:56:28.355811) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:56:28.356184) ========= 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=df17445c3590ff7897617a0e00000225-1455120432.638597-2048681687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004404 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 08:56:28.442049) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 08:56:28.442424) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 08:56:28.442749) ========= ========= Total master_lag: 0.26 =========