builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1455109214.62 results: success (0) buildid: 20160210023046 builduid: 1d1d3997d2224221a60a552f620ef4a4 revision: 672120149d88eeeb3f2bfd52b61bdd7a78566325 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.620297) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.620665) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.620947) ========= 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=32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006300 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.648472) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.648824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.675577) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.675842) ========= 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=32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.726354) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.726662) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.726984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.727263) ========= 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=32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-10 05:00:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2016-02-10 05:00:15 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164348 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.903779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.904053) ========= 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=32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022133 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:14.953654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 05:00:14.953958) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 672120149d88eeeb3f2bfd52b61bdd7a78566325 --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 672120149d88eeeb3f2bfd52b61bdd7a78566325 --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=32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-10 05:00:15,121 truncating revision to first 12 chars 2016-02-10 05:00:15,121 Setting DEBUG logging. 2016-02-10 05:00:15,121 attempt 1/10 2016-02-10 05:00:15,121 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/672120149d88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 05:00:16,148 unpacking tar archive at: fx-team-672120149d88/testing/mozharness/ program finished with exit code 0 elapsedTime=1.304255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 05:00:16.276136) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:16.276500) ========= echo 672120149d88eeeb3f2bfd52b61bdd7a78566325 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'672120149d88eeeb3f2bfd52b61bdd7a78566325'] 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=32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 672120149d88eeeb3f2bfd52b61bdd7a78566325 program finished with exit code 0 elapsedTime=0.004662 script_repo_revision: '672120149d88eeeb3f2bfd52b61bdd7a78566325' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:16.328339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:16.328615) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 05:00:16.338578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-10 05:00:16.338859) ========= /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=32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:00:16 INFO - MultiFileLogger online at 20160210 05:00:16 in /builds/slave/test-pgo 05:00:16 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 05:00:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:00:16 INFO - {'append_to_log': False, 05:00:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:00:16 INFO - 'blob_upload_branch': 'Fx-Team', 05:00:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:00:16 INFO - 'branch': 'Fx-Team', 05:00:16 INFO - 'buildbot_json_path': 'buildprops.json', 05:00:16 INFO - 'config_files': ('talos/linux_config.py',), 05:00:16 INFO - 'default_actions': ('clobber', 05:00:16 INFO - 'read-buildbot-config', 05:00:16 INFO - 'download-and-extract', 05:00:16 INFO - 'populate-webroot', 05:00:16 INFO - 'create-virtualenv', 05:00:16 INFO - 'install', 05:00:16 INFO - 'run-tests'), 05:00:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:00:16 INFO - 'download_minidump_stackwalk': True, 05:00:16 INFO - 'download_symbols': 'ondemand', 05:00:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:00:16 INFO - 'tooltool.py': '/tools/tooltool.py', 05:00:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:00:16 INFO - '/tools/misc-python/virtualenv.py')}, 05:00:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:00:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:00:16 INFO - 'installer_path': 'installer.exe', 05:00:16 INFO - 'log_level': 'info', 05:00:16 INFO - 'log_name': 'talos', 05:00:16 INFO - 'log_to_console': True, 05:00:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:00:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:00:16 INFO - 'opt_config_files': (), 05:00:16 INFO - 'pip_index': False, 05:00:16 INFO - 'sps_profile': False, 05:00:16 INFO - 'sps_profile_interval': 0, 05:00:16 INFO - 'suite': 'dromaeojs', 05:00:16 INFO - 'system_bits': '32', 05:00:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:00:16 INFO - 'title': 'talos-linux64-ix-008', 05:00:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:00:16 INFO - 'use_talos_json': True, 05:00:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:00:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:00:16 INFO - 'work_dir': 'build'} 05:00:16 INFO - ##### 05:00:16 INFO - ##### Running clobber step. 05:00:16 INFO - ##### 05:00:16 INFO - Running pre-action listener: _resource_record_pre_action 05:00:16 INFO - Running main action method: clobber 05:00:16 INFO - rmtree: /builds/slave/test-pgo/build 05:00:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:00:17 INFO - Running post-action listener: _resource_record_post_action 05:00:17 INFO - ##### 05:00:17 INFO - ##### Running read-buildbot-config step. 05:00:17 INFO - ##### 05:00:17 INFO - Running pre-action listener: _resource_record_pre_action 05:00:17 INFO - Running main action method: read_buildbot_config 05:00:17 INFO - Using buildbot properties: 05:00:17 INFO - { 05:00:17 INFO - "project": "", 05:00:17 INFO - "product": "firefox", 05:00:17 INFO - "script_repo_revision": "production", 05:00:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:00:17 INFO - "repository": "", 05:00:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:00:17 INFO - "buildid": "20160210023046", 05:00:17 INFO - "pgo_build": "True", 05:00:17 INFO - "basedir": "/builds/slave/test-pgo", 05:00:17 INFO - "buildnumber": 637, 05:00:17 INFO - "slavename": "talos-linux64-ix-008", 05:00:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:00:17 INFO - "platform": "ubuntu64_hw", 05:00:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:00:17 INFO - "branch": "fx-team", 05:00:17 INFO - "repo_path": "integration/fx-team", 05:00:17 INFO - "revision": "672120149d88eeeb3f2bfd52b61bdd7a78566325", 05:00:17 INFO - "stage_platform": "linux64-pgo", 05:00:17 INFO - "builduid": "1d1d3997d2224221a60a552f620ef4a4", 05:00:17 INFO - "slavebuilddir": "test" 05:00:17 INFO - } 05:00:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:00:17 INFO - Running post-action listener: _resource_record_post_action 05:00:17 INFO - ##### 05:00:17 INFO - ##### Running download-and-extract step. 05:00:17 INFO - ##### 05:00:17 INFO - Running pre-action listener: _resource_record_pre_action 05:00:17 INFO - Running main action method: download_and_extract 05:00:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:17 INFO - https://queue.taskcluster.net/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/test_packages.json 05:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/test_packages.json 05:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:00:22 INFO - Downloaded 1448 bytes. 05:00:22 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:00:22 INFO - Using the following test package requirements: 05:00:22 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:00:22 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:00:22 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:00:22 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:22 INFO - u'jsshell-linux-x86_64.zip'], 05:00:22 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:00:22 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:00:22 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:00:22 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:00:22 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:00:22 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:00:22 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:00:22 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:22 INFO - https://queue.taskcluster.net/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/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 05:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/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 05:00:28 INFO - Downloaded 23289699 bytes. 05:00:28 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'] 05:00:28 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 05:00:29 INFO - Return code: 0 05:00:29 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 05:00:29 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')]} 05:00:29 INFO - https://queue.taskcluster.net/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:00:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:00:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:00:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/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 05:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/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 05:00:30 INFO - Downloaded 23289699 bytes. 05:00:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:00:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:00:32 INFO - Return code: 0 05:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:32 INFO - https://queue.taskcluster.net/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/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 05:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/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 05:00:32 INFO - Downloaded 10706547 bytes. 05:00:32 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'] 05:00:32 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 05:00:33 INFO - Return code: 0 05:00:33 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')]} 05:00:33 INFO - https://queue.taskcluster.net/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/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 05:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TqtimH7TQW2QGHgzKBsGBQ/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 05:00:34 INFO - Downloaded 56532449 bytes. 05:00:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:00:34 INFO - mkdir: /builds/slave/test-pgo/properties 05:00:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:00:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:00:34 INFO - Contents: 05:00:34 INFO - build_url:https://queue.taskcluster.net/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:00:34 INFO - Running post-action listener: _resource_record_post_action 05:00:34 INFO - Running post-action listener: set_extra_try_arguments 05:00:34 INFO - ##### 05:00:34 INFO - ##### Running populate-webroot step. 05:00:34 INFO - ##### 05:00:34 INFO - Running pre-action listener: _resource_record_pre_action 05:00:34 INFO - Running main action method: populate_webroot 05:00:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:00:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:00:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:00:34 INFO - '--tppagecycles', 05:00:34 INFO - '7'], 05:00:34 INFO - 'tests': ['tsvgm']}}, 05:00:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:00:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:00:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:00:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:00:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:00:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:00:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:34 INFO - 'talos_options': ['--e10s'], 05:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:34 INFO - 'tests': ['damp', 'tps']}, 05:00:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:34 INFO - 'talos_options': ['--e10s'], 05:00:34 INFO - 'tests': ['damp', 'tps']}, 05:00:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:00:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:00:34 INFO - 'other': {'tests': ['a11yr', 05:00:34 INFO - 'ts_paint', 05:00:34 INFO - 'tpaint', 05:00:34 INFO - 'sessionrestore', 05:00:34 INFO - 'sessionrestore_no_auto_restore']}, 05:00:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:00:34 INFO - 'tests': ['a11yr', 05:00:34 INFO - 'ts_paint', 05:00:34 INFO - 'tpaint', 05:00:34 INFO - 'sessionrestore', 05:00:34 INFO - 'sessionrestore_no_auto_restore']}, 05:00:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:00:34 INFO - 'tests': ['a11yr', 05:00:34 INFO - 'ts_paint', 05:00:34 INFO - 'tpaint', 05:00:34 INFO - 'sessionrestore', 05:00:34 INFO - 'sessionrestore_no_auto_restore']}, 05:00:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:00:34 INFO - 'tests': ['a11yr', 05:00:34 INFO - 'ts_paint', 05:00:34 INFO - 'tpaint', 05:00:34 INFO - 'sessionrestore', 05:00:34 INFO - 'sessionrestore_no_auto_restore']}, 05:00:34 INFO - 'other_l64': {'tests': ['a11yr', 05:00:34 INFO - 'ts_paint', 05:00:34 INFO - 'tpaint', 05:00:34 INFO - 'sessionrestore', 05:00:34 INFO - 'sessionrestore_no_auto_restore']}, 05:00:34 INFO - 'other_nol64': {'tests': ['a11yr', 05:00:34 INFO - 'ts_paint', 05:00:34 INFO - 'tpaint', 05:00:34 INFO - 'sessionrestore', 05:00:34 INFO - 'sessionrestore_no_auto_restore']}, 05:00:34 INFO - 'svgr': {'tests': ['tsvgx', 05:00:34 INFO - 'tsvgr_opacity', 05:00:35 INFO - 'tart', 05:00:35 INFO - 'tscrollx', 05:00:35 INFO - 'cart']}, 05:00:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:00:35 INFO - 'tests': ['tsvgx', 05:00:35 INFO - 'tsvgr_opacity', 05:00:35 INFO - 'tart', 05:00:35 INFO - 'tscrollx', 05:00:35 INFO - 'cart']}, 05:00:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:35 INFO - 'tests': ['tp5o']}, 05:00:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:35 INFO - 'talos_options': ['--e10s'], 05:00:35 INFO - 'tests': ['tp5o']}, 05:00:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:35 INFO - 'talos_options': ['--xperf_path', 05:00:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:35 INFO - 'tests': ['tp5n']}, 05:00:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:35 INFO - 'talos_options': ['--e10s', 05:00:35 INFO - '--xperf_path', 05:00:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:35 INFO - 'tests': ['tp5n']}}, 05:00:35 INFO - 'talos.zip': {'path': '', 05:00:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:00:35 INFO - Running post-action listener: _resource_record_post_action 05:00:35 INFO - ##### 05:00:35 INFO - ##### Running create-virtualenv step. 05:00:35 INFO - ##### 05:00:35 INFO - Running pre-action listener: _resource_record_pre_action 05:00:35 INFO - Running main action method: create_virtualenv 05:00:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:00:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:00:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:00:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:00:35 INFO - Using real prefix '/usr' 05:00:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:00:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:00:37 INFO - Installing pip.................done. 05:00:37 INFO - Return code: 0 05:00:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6d913e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e278c0>, '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 0x1e287c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28c50>, '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': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', '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 05:00:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:00:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:00:37 INFO - Using env: {'DISPLAY': ':0', 05:00:37 INFO - 'HOME': '/home/cltbld', 05:00:37 INFO - 'LANG': 'en_US.UTF-8', 05:00:37 INFO - 'LANGUAGE': 'en_US:en', 05:00:37 INFO - 'LOGNAME': 'cltbld', 05:00:37 INFO - 'MAIL': '/var/mail/cltbld', 05:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:37 INFO - 'MOZ_NO_REMOTE': '1', 05:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:37 INFO - 'NO_EM_RESTART': '1', 05:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:37 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:37 INFO - 'SHELL': '/bin/bash', 05:00:37 INFO - 'SHLVL': '1', 05:00:37 INFO - 'TERM': 'linux', 05:00:37 INFO - 'TMOUT': '86400', 05:00:37 INFO - 'USER': 'cltbld', 05:00:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', 05:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:37 INFO - '_': '/tools/buildbot/bin/python'} 05:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:37 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 05:00:37 INFO - Cleaning up... 05:00:37 INFO - Return code: 0 05:00:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6d913e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e278c0>, '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 0x1e287c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28c50>, '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': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', '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 05:00:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:00:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:00:37 INFO - Using env: {'DISPLAY': ':0', 05:00:37 INFO - 'HOME': '/home/cltbld', 05:00:37 INFO - 'LANG': 'en_US.UTF-8', 05:00:37 INFO - 'LANGUAGE': 'en_US:en', 05:00:37 INFO - 'LOGNAME': 'cltbld', 05:00:37 INFO - 'MAIL': '/var/mail/cltbld', 05:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:37 INFO - 'MOZ_NO_REMOTE': '1', 05:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:37 INFO - 'NO_EM_RESTART': '1', 05:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:37 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:37 INFO - 'SHELL': '/bin/bash', 05:00:37 INFO - 'SHLVL': '1', 05:00:37 INFO - 'TERM': 'linux', 05:00:37 INFO - 'TMOUT': '86400', 05:00:37 INFO - 'USER': 'cltbld', 05:00:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', 05:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:37 INFO - '_': '/tools/buildbot/bin/python'} 05:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:37 INFO - Downloading/unpacking psutil>=0.7.1 05:00:37 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 05:00:37 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 05:00:37 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 05:00:37 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 05:00:37 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 05:00:37 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 05:00:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:00:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:39 INFO - Installing collected packages: psutil 05:00:39 INFO - Running setup.py install for psutil 05:00:39 INFO - building 'psutil._psutil_linux' extension 05:00:39 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 05:00:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:00:40 INFO - building 'psutil._psutil_posix' extension 05:00:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:00:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:00:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:40 INFO - Successfully installed psutil 05:00:40 INFO - Cleaning up... 05:00:40 INFO - Return code: 0 05:00:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:00: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')]} 05:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6d913e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e278c0>, '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 0x1e287c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28c50>, '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': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', '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 05:00:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:00:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:00:40 INFO - Using env: {'DISPLAY': ':0', 05:00:40 INFO - 'HOME': '/home/cltbld', 05:00:40 INFO - 'LANG': 'en_US.UTF-8', 05:00:40 INFO - 'LANGUAGE': 'en_US:en', 05:00:40 INFO - 'LOGNAME': 'cltbld', 05:00:40 INFO - 'MAIL': '/var/mail/cltbld', 05:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:40 INFO - 'MOZ_NO_REMOTE': '1', 05:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:40 INFO - 'NO_EM_RESTART': '1', 05:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:40 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:40 INFO - 'SHELL': '/bin/bash', 05:00:40 INFO - 'SHLVL': '1', 05:00:40 INFO - 'TERM': 'linux', 05:00:40 INFO - 'TMOUT': '86400', 05:00:40 INFO - 'USER': 'cltbld', 05:00:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', 05:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:40 INFO - '_': '/tools/buildbot/bin/python'} 05:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:00:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:00:42 INFO - Installing collected packages: mozsystemmonitor 05:00:42 INFO - Running setup.py install for mozsystemmonitor 05:00:42 INFO - Successfully installed mozsystemmonitor 05:00:42 INFO - Cleaning up... 05:00:42 INFO - Return code: 0 05:00:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:42 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 0x7f6d913e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e278c0>, '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 0x1e287c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28c50>, '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': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', '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 05:00:42 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 05:00:42 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 05:00:42 INFO - Using env: {'DISPLAY': ':0', 05:00:42 INFO - 'HOME': '/home/cltbld', 05:00:42 INFO - 'LANG': 'en_US.UTF-8', 05:00:42 INFO - 'LANGUAGE': 'en_US:en', 05:00:42 INFO - 'LOGNAME': 'cltbld', 05:00:42 INFO - 'MAIL': '/var/mail/cltbld', 05:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:42 INFO - 'MOZ_NO_REMOTE': '1', 05:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:42 INFO - 'NO_EM_RESTART': '1', 05:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:42 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:42 INFO - 'SHELL': '/bin/bash', 05:00:42 INFO - 'SHLVL': '1', 05:00:42 INFO - 'TERM': 'linux', 05:00:42 INFO - 'TMOUT': '86400', 05:00:42 INFO - 'USER': 'cltbld', 05:00:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', 05:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:42 INFO - '_': '/tools/buildbot/bin/python'} 05:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:00:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:00:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:00:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:45 INFO - Downloading docopt-0.6.1.tar.gz 05:00:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:00:45 INFO - Installing collected packages: blobuploader, requests, docopt 05:00:45 INFO - Running setup.py install for blobuploader 05:00:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:00:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:00:45 INFO - Running setup.py install for requests 05:00:45 INFO - Running setup.py install for docopt 05:00:45 INFO - Successfully installed blobuploader requests docopt 05:00:45 INFO - Cleaning up... 05:00:45 INFO - Return code: 0 05:00:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:00: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')]} 05:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:45 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 0x7f6d913e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e278c0>, '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 0x1e287c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28c50>, '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': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', '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 05:00:45 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 05:00:45 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 05:00:45 INFO - Using env: {'DISPLAY': ':0', 05:00:45 INFO - 'HOME': '/home/cltbld', 05:00:45 INFO - 'LANG': 'en_US.UTF-8', 05:00:45 INFO - 'LANGUAGE': 'en_US:en', 05:00:45 INFO - 'LOGNAME': 'cltbld', 05:00:45 INFO - 'MAIL': '/var/mail/cltbld', 05:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:45 INFO - 'MOZ_NO_REMOTE': '1', 05:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:45 INFO - 'NO_EM_RESTART': '1', 05:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:45 INFO - 'SHELL': '/bin/bash', 05:00:45 INFO - 'SHLVL': '1', 05:00:45 INFO - 'TERM': 'linux', 05:00:45 INFO - 'TMOUT': '86400', 05:00:45 INFO - 'USER': 'cltbld', 05:00:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', 05:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:45 INFO - '_': '/tools/buildbot/bin/python'} 05:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:46 INFO - Running setup.py (path:/tmp/pip-C1_fhy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:46 INFO - Running setup.py (path:/tmp/pip-CY0YfD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:46 INFO - Running setup.py (path:/tmp/pip-1zTPbF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:46 INFO - Running setup.py (path:/tmp/pip-g6sMAM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:46 INFO - Running setup.py (path:/tmp/pip-YiHBw1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:46 INFO - Running setup.py (path:/tmp/pip-MGN4Qt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:46 INFO - Running setup.py (path:/tmp/pip-3RgJN0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:46 INFO - Running setup.py (path:/tmp/pip-ZmdY_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:46 INFO - Running setup.py (path:/tmp/pip-i37xx4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:46 INFO - Running setup.py (path:/tmp/pip-YiI1cZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:46 INFO - Running setup.py (path:/tmp/pip-eDMiAj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:46 INFO - Running setup.py (path:/tmp/pip-qZobVL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:47 INFO - Running setup.py (path:/tmp/pip-7PtWm9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:47 INFO - Running setup.py (path:/tmp/pip-x9SKyC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:47 INFO - Running setup.py (path:/tmp/pip-iVq0Ta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:47 INFO - Running setup.py (path:/tmp/pip-KLINnv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:47 INFO - Running setup.py (path:/tmp/pip-G_dCOD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:00:47 INFO - Running setup.py install for manifestparser 05:00:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:00:47 INFO - Running setup.py install for mozcrash 05:00:47 INFO - Running setup.py install for mozdebug 05:00:47 INFO - Running setup.py install for mozdevice 05:00:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:00:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:00:47 INFO - Running setup.py install for mozfile 05:00:47 INFO - Running setup.py install for mozhttpd 05:00:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:00:48 INFO - Running setup.py install for mozinfo 05:00:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:00:48 INFO - Running setup.py install for mozInstall 05:00:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:00:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:00:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:00:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:00:48 INFO - Running setup.py install for mozleak 05:00:48 INFO - Running setup.py install for mozlog 05:00:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:00:48 INFO - Running setup.py install for moznetwork 05:00:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:00:48 INFO - Running setup.py install for mozprocess 05:00:48 INFO - Running setup.py install for mozprofile 05:00:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:00:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:00:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:00:48 INFO - Running setup.py install for mozrunner 05:00:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:00:48 INFO - Running setup.py install for mozscreenshot 05:00:48 INFO - Running setup.py install for moztest 05:00:49 INFO - Running setup.py install for mozversion 05:00:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:00:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:00:49 INFO - Cleaning up... 05:00:49 INFO - Return code: 0 05:00:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6d913e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e278c0>, '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 0x1e287c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28c50>, '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': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', '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 05:00:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:00:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:00:49 INFO - Using env: {'DISPLAY': ':0', 05:00:49 INFO - 'HOME': '/home/cltbld', 05:00:49 INFO - 'LANG': 'en_US.UTF-8', 05:00:49 INFO - 'LANGUAGE': 'en_US:en', 05:00:49 INFO - 'LOGNAME': 'cltbld', 05:00:49 INFO - 'MAIL': '/var/mail/cltbld', 05:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:49 INFO - 'MOZ_NO_REMOTE': '1', 05:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:49 INFO - 'NO_EM_RESTART': '1', 05:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:49 INFO - 'SHELL': '/bin/bash', 05:00:49 INFO - 'SHLVL': '1', 05:00:49 INFO - 'TERM': 'linux', 05:00:49 INFO - 'TMOUT': '86400', 05:00:49 INFO - 'USER': 'cltbld', 05:00:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', 05:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:49 INFO - '_': '/tools/buildbot/bin/python'} 05:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:49 INFO - Running setup.py (path:/tmp/pip-hjqjIi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:49 INFO - Running setup.py (path:/tmp/pip-tJvCBp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:49 INFO - Running setup.py (path:/tmp/pip-r11R6Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:49 INFO - Running setup.py (path:/tmp/pip-sVKKnl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:49 INFO - Running setup.py (path:/tmp/pip-xyKK14-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:49 INFO - Running setup.py (path:/tmp/pip-P2A3ib-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:49 INFO - Running setup.py (path:/tmp/pip-733GxS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:49 INFO - Running setup.py (path:/tmp/pip-o4QRJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:49 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)) 05:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:49 INFO - Running setup.py (path:/tmp/pip-Xzhc09-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:50 INFO - Running setup.py (path:/tmp/pip-OmirOy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:50 INFO - Running setup.py (path:/tmp/pip-ykR0XU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:50 INFO - Running setup.py (path:/tmp/pip-B9cOzJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:50 INFO - Running setup.py (path:/tmp/pip-Hr4t8r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:50 INFO - Running setup.py (path:/tmp/pip-dDchsC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:50 INFO - Running setup.py (path:/tmp/pip-Pu8Dvs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:50 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)) 05:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:50 INFO - Running setup.py (path:/tmp/pip-4lEdii-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:50 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)) 05:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:50 INFO - Running setup.py (path:/tmp/pip-GnHTUJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:50 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)) 05:00:50 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)) 05:00:50 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)) 05:00:50 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)) 05:00:50 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)) 05:00:50 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)) 05:00:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:52 INFO - Downloading blessings-1.6.tar.gz 05:00:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:00:52 INFO - Installing collected packages: blessings 05:00:52 INFO - Running setup.py install for blessings 05:00:52 INFO - Successfully installed blessings 05:00:52 INFO - Cleaning up... 05:00:52 INFO - Return code: 0 05:00:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:00:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:00:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:00:52 INFO - Reading from file tmpfile_stdout 05:00:52 INFO - Current package versions: 05:00:52 INFO - argparse == 1.2.1 05:00:52 INFO - blessings == 1.6 05:00:52 INFO - blobuploader == 1.2.4 05:00:52 INFO - docopt == 0.6.1 05:00:52 INFO - manifestparser == 1.1 05:00:52 INFO - mozInstall == 1.12 05:00:52 INFO - mozcrash == 0.16 05:00:52 INFO - mozdebug == 0.1 05:00:52 INFO - mozdevice == 0.48 05:00:52 INFO - mozfile == 1.2 05:00:52 INFO - mozhttpd == 0.7 05:00:52 INFO - mozinfo == 0.9 05:00:52 INFO - mozleak == 0.1 05:00:52 INFO - mozlog == 3.1 05:00:52 INFO - moznetwork == 0.27 05:00:52 INFO - mozprocess == 0.22 05:00:52 INFO - mozprofile == 0.28 05:00:52 INFO - mozrunner == 6.11 05:00:52 INFO - mozscreenshot == 0.1 05:00:52 INFO - mozsystemmonitor == 0.0 05:00:52 INFO - moztest == 0.7 05:00:52 INFO - mozversion == 1.4 05:00:52 INFO - psutil == 3.1.1 05:00:52 INFO - requests == 1.2.3 05:00:52 INFO - wsgiref == 0.1.2 05:00:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f6d913e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e278c0>, '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 0x1e287c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28c50>, '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': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', '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 05:00:52 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 05:00:52 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 05:00:52 INFO - Using env: {'DISPLAY': ':0', 05:00:52 INFO - 'HOME': '/home/cltbld', 05:00:52 INFO - 'LANG': 'en_US.UTF-8', 05:00:52 INFO - 'LANGUAGE': 'en_US:en', 05:00:52 INFO - 'LOGNAME': 'cltbld', 05:00:52 INFO - 'MAIL': '/var/mail/cltbld', 05:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:52 INFO - 'MOZ_NO_REMOTE': '1', 05:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:52 INFO - 'NO_EM_RESTART': '1', 05:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:52 INFO - 'SHELL': '/bin/bash', 05:00:52 INFO - 'SHLVL': '1', 05:00:52 INFO - 'TERM': 'linux', 05:00:52 INFO - 'TMOUT': '86400', 05:00:52 INFO - 'USER': 'cltbld', 05:00:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', 05:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:52 INFO - '_': '/tools/buildbot/bin/python'} 05:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:00:53 INFO - Cleaning up... 05:00:53 INFO - Return code: 0 05:00:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6d913e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e278c0>, '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 0x1e287c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28c50>, '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': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', '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 05:00:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:00:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:00:53 INFO - Using env: {'DISPLAY': ':0', 05:00:53 INFO - 'HOME': '/home/cltbld', 05:00:53 INFO - 'LANG': 'en_US.UTF-8', 05:00:53 INFO - 'LANGUAGE': 'en_US:en', 05:00:53 INFO - 'LOGNAME': 'cltbld', 05:00:53 INFO - 'MAIL': '/var/mail/cltbld', 05:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:53 INFO - 'MOZ_NO_REMOTE': '1', 05:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:53 INFO - 'NO_EM_RESTART': '1', 05:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:53 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:53 INFO - 'SHELL': '/bin/bash', 05:00:53 INFO - 'SHLVL': '1', 05:00:53 INFO - 'TERM': 'linux', 05:00:53 INFO - 'TMOUT': '86400', 05:00:53 INFO - 'USER': 'cltbld', 05:00:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', 05:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:53 INFO - '_': '/tools/buildbot/bin/python'} 05:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:53 INFO - Downloading/unpacking jsonschema 05:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:00:55 INFO - Downloading/unpacking functools32 (from jsonschema) 05:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:00:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:00:55 INFO - warning: no files found matching '*.txt' 05:00:55 INFO - no previously-included directories found matching 'build' 05:00:55 INFO - no previously-included directories found matching 'dist' 05:00:55 INFO - no previously-included directories found matching '.git*' 05:00:55 INFO - Installing collected packages: jsonschema, functools32 05:00:55 INFO - Running setup.py install for functools32 05:00:55 INFO - warning: no files found matching '*.txt' 05:00:55 INFO - no previously-included directories found matching 'build' 05:00:55 INFO - no previously-included directories found matching 'dist' 05:00:55 INFO - no previously-included directories found matching '.git*' 05:00:55 INFO - Successfully installed jsonschema functools32 05:00:55 INFO - Cleaning up... 05:00:55 INFO - Return code: 0 05:00:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:00:55 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')]} 05:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:55 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')]} 05:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:55 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 0x7f6d913e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d98670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e278c0>, '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 0x1e287c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28c50>, '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': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', '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 05:00:55 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 05:00:55 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 05:00:55 INFO - Using env: {'DISPLAY': ':0', 05:00:55 INFO - 'HOME': '/home/cltbld', 05:00:55 INFO - 'LANG': 'en_US.UTF-8', 05:00:55 INFO - 'LANGUAGE': 'en_US:en', 05:00:55 INFO - 'LOGNAME': 'cltbld', 05:00:55 INFO - 'MAIL': '/var/mail/cltbld', 05:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:55 INFO - 'MOZ_NO_REMOTE': '1', 05:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:55 INFO - 'NO_EM_RESTART': '1', 05:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:55 INFO - 'SHELL': '/bin/bash', 05:00:55 INFO - 'SHLVL': '1', 05:00:55 INFO - 'TERM': 'linux', 05:00:55 INFO - 'TMOUT': '86400', 05:00:55 INFO - 'USER': 'cltbld', 05:00:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', 05:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:55 INFO - '_': '/tools/buildbot/bin/python'} 05:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:55 INFO - Downloading/unpacking flake8 05:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:00:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:00:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 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 05:00:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:00:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:58 INFO - no previously-included directories found matching 'docs/_build' 05:00:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:00:58 INFO - Running setup.py install for pep8 05:00:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:58 INFO - no previously-included directories found matching 'docs/_build' 05:00:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:00:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:00:58 INFO - Cleaning up... 05:00:58 INFO - Return code: 0 05:00:58 INFO - Running post-action listener: _resource_record_post_action 05:00:58 INFO - Running post-action listener: _start_resource_monitoring 05:00:58 INFO - Starting resource monitoring. 05:00:58 INFO - ##### 05:00:58 INFO - ##### Running install step. 05:00:58 INFO - ##### 05:00:58 INFO - Running pre-action listener: _resource_record_pre_action 05:00:58 INFO - Running main action method: install 05:00:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:00:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:00:58 INFO - Reading from file tmpfile_stdout 05:00:58 INFO - Detecting whether we're running mozinstall >=1.0... 05:00:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:00:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:00:58 INFO - Reading from file tmpfile_stdout 05:00:58 INFO - Output received: 05:00:58 INFO - Usage: mozinstall [options] installer 05:00:58 INFO - Options: 05:00:58 INFO - -h, --help show this help message and exit 05:00:58 INFO - -d DEST, --destination=DEST 05:00:58 INFO - Directory to install application into. [default: 05:00:58 INFO - "/builds/slave/test-pgo"] 05:00:58 INFO - --app=APP Application being installed. [default: firefox] 05:00:58 INFO - mkdir: /builds/slave/test-pgo/build/application 05:00:58 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'] 05:00:58 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 05:01:14 INFO - Reading from file tmpfile_stdout 05:01:14 INFO - Output received: 05:01:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:01:14 INFO - Running post-action listener: _resource_record_post_action 05:01:14 INFO - ##### 05:01:14 INFO - ##### Running run-tests step. 05:01:14 INFO - ##### 05:01:14 INFO - Running pre-action listener: _resource_record_pre_action 05:01:14 INFO - Running main action method: run_tests 05:01:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:01:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:01:14 INFO - Python 2.7.3 05:01:14 INFO - Return code: 0 05:01:14 INFO - grabbing minidump binary from tooltool 05:01:14 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')]} 05:01:14 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 0x1e278c0>, '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 0x1e287c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:01:14 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 05:01:14 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 05:01:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:01:15 INFO - Return code: 0 05:01:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:01:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:01:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:01:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:01:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:01:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:01:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:01:16 INFO - Return code: 0 05:01:16 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/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 05:01:16 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/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 05:01:16 INFO - Using env: {'DISPLAY': ':0', 05:01:16 INFO - 'HOME': '/home/cltbld', 05:01:16 INFO - 'LANG': 'en_US.UTF-8', 05:01:16 INFO - 'LANGUAGE': 'en_US:en', 05:01:16 INFO - 'LOGNAME': 'cltbld', 05:01:16 INFO - 'MAIL': '/var/mail/cltbld', 05:01:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:01:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:16 INFO - 'MOZ_NO_REMOTE': '1', 05:01:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:16 INFO - 'NO_EM_RESTART': '1', 05:01:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:01:16 INFO - 'SHELL': '/bin/bash', 05:01:16 INFO - 'SHLVL': '1', 05:01:16 INFO - 'TERM': 'linux', 05:01:16 INFO - 'TMOUT': '86400', 05:01:16 INFO - 'USER': 'cltbld', 05:01:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493', 05:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:16 INFO - '_': '/tools/buildbot/bin/python'} 05:01:16 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/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 05:01:16 INFO - mozversion application_buildid: 20160210023046 05:01:16 INFO - mozversion application_changeset: 672120149d88eeeb3f2bfd52b61bdd7a78566325 05:01:16 INFO - mozversion application_display_name: Nightly 05:01:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:01:16 INFO - mozversion application_name: Firefox 05:01:16 INFO - mozversion application_remotingname: firefox 05:01:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:01:16 INFO - mozversion application_vendor: Mozilla 05:01:16 INFO - mozversion application_version: 47.0a1 05:01:16 INFO - mozversion platform_buildid: 20160210023046 05:01:16 INFO - mozversion platform_changeset: 672120149d88eeeb3f2bfd52b61bdd7a78566325 05:01:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:01:16 INFO - mozversion platform_version: 47.0a1 05:01:16 INFO - using testdate: 1455109276 05:01:16 INFO - actual date: 1455109276 05:01:16 INFO - starting webserver on 'localhost:33466' 05:01:16 INFO - SUITE-START | Running 2 tests 05:01:16 INFO - TEST-START | dromaeo_css 05:01:16 INFO - operating with platform_type : linux_ 05:01:16 INFO - Initialising browser for dromaeo_css test... 05:01:16 INFO - TEST-INFO | started process 21004 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTMbbba/profile http://localhost:33466/getInfo.html) 05:01:20 INFO - PROCESS | 21004 | __metrics Screen width/height:1600/1200 05:01:20 INFO - PROCESS | 21004 | colorDepth:24 05:01:20 INFO - PROCESS | 21004 | Browser inner width/height: 1024/697 05:01:20 INFO - PROCESS | 21004 | __metrics 05:01:20 INFO - PROCESS | 21004 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:01:21 INFO - TEST-INFO | 21004: exit 0 05:01:21 INFO - Browser initialized. 05:01:21 INFO - Running cycle 1/1 for dromaeo_css test... 05:01:21 INFO - TEST-INFO | started process 21094 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTMbbba/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:33 INFO - PROCESS | 21094 | RSS: Main: 152190976 05:01:33 INFO - PROCESS | 21094 | 05:02:24 INFO - PROCESS | 21094 | 1455109344812 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] 05:04:33 INFO - PROCESS | 21094 | Cycle 1(1): loaded http://localhost:33466/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33466/tests/dromaeo/cssquery-ext.html) 05:04:34 INFO - PROCESS | 21094 | RSS: Main: 262901760 05:04:34 INFO - PROCESS | 21094 | 05:07:36 INFO - PROCESS | 21094 | Cycle 1(1): loaded http://localhost:33466/tests/dromaeo/cssquery-ext.html (next: http://localhost:33466/tests/dromaeo/cssquery-jquery.html) 05:07:37 INFO - PROCESS | 21094 | RSS: Main: 236277760 05:07:37 INFO - PROCESS | 21094 | 05:10:39 INFO - PROCESS | 21094 | Cycle 1(1): loaded http://localhost:33466/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33466/tests/dromaeo/cssquery-mootools.html) 05:10:39 INFO - PROCESS | 21094 | RSS: Main: 240992256 05:10:39 INFO - PROCESS | 21094 | 05:13:41 INFO - PROCESS | 21094 | Cycle 1(1): loaded http://localhost:33466/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33466/tests/dromaeo/cssquery-prototype.html) 05:13:42 INFO - PROCESS | 21094 | RSS: Main: 218288128 05:13:42 INFO - PROCESS | 21094 | 05:16:44 INFO - PROCESS | 21094 | Cycle 1(1): loaded http://localhost:33466/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33466/tests/dromaeo/cssquery-yui.html) 05:16:45 INFO - PROCESS | 21094 | RSS: Main: 219557888 05:16:45 INFO - PROCESS | 21094 | 05:19:48 INFO - PROCESS | 21094 | Cycle 1(1): loaded http://localhost:33466/tests/dromaeo/cssquery-yui.html (next: http://localhost:33466/tests/dromaeo/cssquery-dojo.html) 05:19:48 INFO - PROCESS | 21094 | RSS: Main: 277082112 05:19:48 INFO - PROCESS | 21094 | 05:19:48 INFO - PROCESS | 21094 | __start_tp_report 05:19:48 INFO - PROCESS | 21094 | _x_x_mozilla_page_load 05:19:48 INFO - PROCESS | 21094 | _x_x_mozilla_page_load_details 05:19:48 INFO - PROCESS | 21094 | |i|pagename|runs| 05:19:48 INFO - PROCESS | 21094 | |0;dojo.html;3106.8135911845293;3132.9530057049164;3180.7137357637807;3181.045686294113;3217.3726123405936;5001.249812528123;5086.465921078289;5091.134507133792;5129.281900533923;5172.870678233046;5037.093323201822;5079.263506791523;5091.109055915209;5093.465186155456;5154.8453546393575;4627.676062675614;4677.625789936806;4727.101850648383;4767.284907263921;4803.06340263647;4645;4695.624350051988;4748.311494833247;4756.97621511892;4879.146149423855;4710.788014539354;4736.95263047372;4749.572538471554;4760.90478190436;4777.641676874248;4723.504032076617;4728.905421891577;4746.240601503778;4752.904941901177;4768.47546769855;4642.9535704643195;4716.669833111683;4732.266498692708;4749.762511874393;4779.593734532569;4990.925136122961;4991.675541089854;5020.0963826511215;5032.6980381177245;5044.722540260284;5400.810971615974;5517.117261238222;5525.419830917776;5532.5573954083575;5532.640378375393;5433.972830135824;5489.615726899118;5607.271054762855;5632.859178520529;5687;5214.4524824893215;5233.371995360543;5235.083860324428;5238.109521381374;5280.577553795687;5459.481349271892;5555.694436806015;5654.236678048493;5663.320401551758;5664.150377443417;5463.262459567907;5496.862578435571;5501.449855014546;5504.394516603251;5510.9448905510435;5504.256925315111;5519.944800551943;5521.3926468088475;5521.944780552223;5528.944710552923;5362.436944120889;5441.483059109458;5489.945100549024;5497.230387745719;5530.972345138329;5538.16927460876;5540;5541.501264886179;5548.112302031655;5559.916601250903;4316.719413238129;4324.783760811947;4329.372241025034;4330;4361.9127617447475;3807.942880856734;3835.7506762060375;3894.6300101490315;3909.4722212501515;3918.0792513759243;5093.9490605094215;5106.4893510648635;5120.231965205249;5122.282880396748;5170.663906846043;5491.752871120809;5495.505404513613;5514.28314319144;5524.751386187631;5530.640508366943;4994.775235114428;5065.670731402447;5070.797168113308;5096.949030509648;5147.0992576298995;4667.393238878924;4703.694259873166;4718.2214934536105;4720.433547974265;4756.833510827174;5641.2384328116;5711.914321285184;5714.428557144335;5716.228309178291;5727;5378.435264297193;5543.944560554342;5548.056830338772;5566.610337276352;5608.579356548356;5693.4021927696995;5729.369769325288;5738.426157384228;5740;5742.59801813869;5314.1497360422145;5395.298611180521;5464.453554644504;5473.890522189614;5475.206095116266;5534.4742249486235;5572.108462645957;5575.275214222287;5575.804846830341;5613.775448982158;5392.919106213489;5415.5938304626525;5426.511613954763;5446.183072539151;5463.972680136574;5209.661372010807;5336.786528538815;5430.647007944471;5446.101393270066;5482.945170548403;5332.493413125747;5343.973280133574;5344.625876188785;5349.144136938071;5365.061114304903;5394.487523685244;5431.619786614899;5442.047641662773;5442.183672449006;5486.231927530069;5177.508136727156;5263.184206448007;5294.867628309323;5344.919826202532;5386.084365657769 05:19:48 INFO - PROCESS | 21094 | |1;ext.html;535.568867062015;541.5369858770754;553.3498139685868;565.2905603467649;614.431650723081;28200.43599128019;36824.26351472969;37130.4430433543;37320.253594928115;37418.8129059355;39051.804740976324;39619;39695;39730.40404393929;39779.60220397795;8435.451695639795;8629.95685021574;8634.481931084156;8647.092055334193;8689.217970382664;8546.273566746833;8648.610812513452;8651.48091114535;8686.305095592368;8857.557122143899;8841;8914.331425143107;8924.509151996637;8926.73219803407;8933.46399216046;8836.028036915934;8864.73405797827;8890.599923003449;8898.19916207538;8910.86633700495;8795.648174073029;8864.73405797827;8909.910900890973;8962.73111806647;8973.147550982647;39762.403563946566;39782;39951.60048399508;40166.799166004275;40309.39535906934;3444.6555344465605;3478.2521757821937;3858.594847541024;3998.3602623580377;4142.275101857163;29832.70167298321;30119.69880301213;30242;30351;30371.848140759153;3937.6652984496354;3976.8210430530694;3981.3629819228786;4006.779627120507;4012.197560487914;260166;261382;262203;264444;265684;56031.71984140053;56043;56099.43900560942;56242.437575624535;56576.43423565794;58895;58947;58982.70508647429;59037.409625903194;59171.40828591745;15162.772558411632;15399.307031183624;15402.922985385001;15416.229188540528;15436.228188590525;11114.833277500844;11134.16493762971;11134.944325278322;11139.053180479588;11140.33158010522;17430.286380912985;18511.629767404578;18742.25030998772;18827.34104306343;19026.904865475863;6575.736970521126;7648.73229436967;7905.209479052164;8016.559089250147;8068.870358149864;848.4824257203101;952.6379975609224;1043.5095505112736;1054.2462139570243;1146.0774076868036;27034.864825675744;27856.582151267747;28191.71808281932;28347;28958.420831583673;1012.4633944009687;1095.4686976816238;1139.7378602921374;1202.657242685848;1216.9534200587489;13438.932805335911;15336.539903802905;15450;15521.301541430663;15775.132367719656;278775;284647;284932;285409;286747;50673;50921.74539127281;51010.48989510132;51305;51348.48651513512;1314.0932756398054;1331.8202042724108;1340.6112227454123;1341.584108926236;1361.537077393671;29464.410711785215;30250;30362.59703108517;30379;30479.847600761856;45295.773521132185;45843.3123503141;45928;45983.77008114938;46044.30933536067;265153;266907;267237;267434;311101;32465.51301730523;33154.17114572155;33199.838005669684;33475.83262083674;33486.832565837016;39883.99557508881;40282.597174029055;40610.1877962445;40669.38995915123;41072;34679.82660086784;34893.127671808405;34895;35105.64894351024;35576.46635300524;33976.83011584926;34290.314193716484;34608.65391346155;34763.826180868935;35134;31750.841245793625;34002;36620.81689591535;36879.26241475209;39732.60267397289;29522.261943451587;31568;31643.52534712027;31906.36187276288;32039;24357.75642243555;24553;24808;25155;25170.49659006773 05:19:48 INFO - PROCESS | 21094 | |2;jquery.html;361.35498135827544;367.702161249388;368.1183565360962;371.8196674612811;372.2313422781955;13538.39077241524;14451.710965780678;16303.510894673149;17432.825671743278;18240.54398640033;16168;16339.91830040848;16373.42693005745;17287.222075006623;17815.109244537787;5787.536997040227;5968.820935371924;5968.850778730544;5973.253343332083;5978.910316345236;4296.656267498608;4470.105978804236;4475.28395456727;4478.529754375792;5953.642781433128;6443.323451037644;6510.64191469469;6621.702023408934;6692.765753198639;6701.028350889118;6603.933960660428;6650.3682150195655;6660.433863121641;6663.30035346289;6664.566803157779;6385.616862988236;6539.34606539347;6550.836229094263;6552.475801935833;6556.573822701557;21736.13055477779;22183.11267549296;22833.20083797059;22979;23009.76990230093;2386.7016622922133;2391.4499665076955;2467.629855521668;2783.471140483322;2807.4946509628257;13450.260235687034;13578.253196074213;13887.305634718325;13944.930275348659;14209.715805683829;1982.8512861535298;1995.860289779716;2009.65835807913;2011.6580181369056;2022.6157030164222;60836.69581652063;65107.67446162786;65540;67433.3256667432;70596.29403705949;14996.47512337063;15408.691826163415;15639.3744250231;15723.135227562365;15751.842481575266;23750.406239844142;23782.405439863796;23948;24064.87967560186;24073.7592624075;6796.558223715443;6913.755524005626;6915.481338899603;6954.826129346807;7118.074650295428;6382.553221274559;6412.070249813844;6483.610983341015;6490.935090649033;6556.213254409501;4138.91722165555;4403.339499075164;4505.954940450619;4511.736713720164;4545.36364908913;1591.4350405605844;1623.6914986152594;1633.942812001598;1763.6913540130427;1840.061568599997;859.2910848549972;934.7896723237353;980.3921568627496;1018.3228153277987;1063.9202059845543;11737.530498779954;13978.720425591431;14932.776008359884;15079.170645614597;15140.167290798892;925.3799954030816;933.6125507914139;942.6323733743845;952.3000594562991;975.4829940131741;8938.597763100675;9022.819543609092;9088.318376121684;9108.590113444778;9164.816703666023;461716;470861;471791;472741;476436;68646.65676671585;71606.64196678983;72079;73164.63417682878;73337.29958354296;1120.4117838134882;1128.7573171768108;1133.195431243826;1149.741308205647;1150.9539618415338;13200.603981880558;13433.328333583477;13526.797098043735;13613.591592252249;13640.79538806899;32508.512372314908;33565.32869342551;33630.66369336275;33852.32295354128;33880.49179262264;43287;43577;45863;47062.76468617635;47789.283160753315;7493.43799215072;7598.506097103671;7611.733589324347;7674.386049116169;7684.500507466997;8759;10747;11417.31496110236;11920.70198245016;12073.517059317881;9179.311551633788;9934;9988.151007164472;10144.695659130239;10563.154947604327;8786.384953053224;9551.761205969628;9622.9037709622;9989.650362237287;10317.535710893178;9005.864912026194;9619.663311784054;9687.41875487473;9690.321677482509;9837.754056148653;7277.345038946521;7335.083114610674;7530.872192361635;7683.654235559301;7710.344620707303;8295.419320647738;10472.947635261775;10561.683149505527;10658;10710.785784284115 05:19:48 INFO - PROCESS | 21094 | |3;mootools.html;1314.4150852870478;1437.0443654969447;1448.304813689429;1586.5161125856616;1730.6019615488444;6512.38132377424;7079.469039822015;7207.999999999994;7251.129864416264;7265.09186351706;7096.361327480526;7240.746573869916;7259.528130671502;7263.818404539889;7271.745488907889;1852.8517718582548;1909.9236030558761;1915.6551820672273;2210.546837898235;2213.900374483152;1913.0817207740292;2111.229401268534;2159.0608085482863;2159.222679835258;2166.1010680567547;2113.8837363944976;2122.628540005501;2132.957340853182;2200.4938864061273;2215.3575463115676;2082.5001999520005;2109.810117089454;2109.9050542725613;2111.80993710566;2118.1739121742535;2181.814545763612;2184.3992901951933;2185.595664802017;2186.081845624841;2195.868247905115;7381;7429.888551671729;7434.9256507434775;7437.553746775211;7443.739469118609;4631.374764406829;4725.196716558194;4758.119747846625;4761.523847615245;4767.499412561666;2956.467835789557;3162.0513845846385;3165.7309128724087;3183.3155871487743;3188.8883889063773;972.5234635028855;992.3053862296422;998.6604554451449;1012.3065699995526;1057.2863317260894;10264.127549158256;10285.897141028569;10287.177025837915;10287.588496460132;10299.536520856505;4180.602842729936;4241.257779888507;4241.63946064588;4292.420523229324;4293.377460268243;8786.07746186654;8786.780330491789;8788.384813063152;8790.604422800989;8806.86789698155;4657.650676199299;4676.994446194085;4683.461401938753;4687.296905464208;4715.976420117946;4297.39836422901;4301.806418711166;4302.290122129876;4303.956960430418;4304.074623955802;3264.3308121834966;3447.6035255945385;3470.323286959019;3532.823358832048;3562.447820587813;1191.8391017212566;1203.9759204815855;1207.9939600301943;1214.6538236602526;1215.477344741752;1309.0509380698918;1320.1551007355301;1323.7087840675035;1335.2522587351114;1361.9046666733432;6635.8009259722285;6700.731970721214;6703.698333575001;6711.295313991961;6737.09049278351;1104.9944750276197;1111.4823695900022;1115.81031224692;1133.9376334301528;1153.1870031627682;5342.599305052059;5395.973020134874;5411.918821217685;5422.674639521641;5427.375851777097;8723.563821808884;9052.592633331516;9102.635894564275;9196.816063678689;9261.120193581599;9067.591958361889;9071.682491112779;9094.81810363789;9178.265738740885;9180.540972951325;6925.134358205224;6975.720971161199;7105.25394833535;7240.094988126379;7241.094863142107;6578.76974305897;6598.1422415085735;6608.70260838273;6615.801525954229;6619;8046.074701409413;8113.5131892086665;8122;8243.711470098518;8270.793230169294;8129.309008734087;8343.66625335004;8462.407631465738;8467.110953350057;8498.1501849817;6394.200724909387;6440.581362211441;6477.77327793525;6488.9026664601015;6496.935030649822;6261.436470717657;6850.143732033496;6967.233604303624;7046.330598593126;7067.25793791665;6700.564463309869;6752.08846805675;6782.932170678428;6850.794476165723;6868;6480.837979050561;6539.738410463528;6597.571157874723;6606.6036037837885;6717.1267735194115;6248.156498872594;6277.340879207617;6301.117843501822;6302.71637776292;6319.210098737658;6301.96849015752;6339.936600633934;6348;6351;6353.52348573868;6244.46922011616;6373.87252254943;6385.553011289351;6401.839954001187;6414.5189110815945 05:19:48 INFO - PROCESS | 21094 | |4;prototype.html;313.64714695967035;334.97320214382853;335.79180907837116;340.3176630855135;343.7610860451987;5861.824145275643;5864.1203819427055;5869.647821130735;5904.409559044098;5929.110633404992;5554.389017208104;5653.462921022507;5668.716564171796;5798.391168927265;5833.795817146401;4520.050789334244;4554.43069616298;4567.337736028274;4581.266997280436;4586.72479651222;4302.182585308797;4552.180607490651;4581.908361832761;4583.587477127058;4585.426821647294;4412.735235885857;4484.843030493933;4493.640508759291;4506.97746511267;4526.6831321807485;4524.592786649201;4544.590986811169;4550.317452382136;4551.590356867898;4562.8631141065825;3973.562908080109;3977.880663580097;3978.264021156095;4001.199760048002;4012.25773231953;5533.363663178746;5627.831165065055;5637.746301416446;5676.3188417389765;5679.687617181054;5275.182346736262;5284.2866213061125;5285.709285989269;5287.735613219362;5290.867728306785;6249.437550620466;6251.937480625181;6254.8123556293385;6258.624482531062;6259.624422534663;4435.977820110911;4439.889002774924;4441.511433742286;4441.75570343631;4442.444694413199;6353.205849268841;6521.543491955565;6521.739130434777;6533.705983230719;6543.149390579194;4523.932141017887;4531.750753708578;4531.932021019687;4532.048269863366;4532.818687252539;4591.471980722193;4593.839215627437;4595.885102872455;4596.2416201326405;4597.862064138081;5261.815836445706;5262.289590905179;5262.315898933114;5264.447233040552;5276.657017293864;6129.417705317987;6293.905591416133;6295.276043254993;6305.621662700161;6322.683865806691;1604.9277782499817;1626.1950334584456;1626.7966504186977;1627.3897288516807;1627.4710719016366;1047.4396198034167;1089.983650245247;1095.1567293184203;1098.4068602954314;1113.7104352868312;5887.587868849139;5924.911126333022;5926.4666180044005;5931.169636250928;5942.673152976541;6462.7738029169695;6466.35336466359;6477.4170324671;6478.578892371981;6486.416222539994;5712.171735098387;5804.738786754606;5805.448482394166;5822.592418530747;5824.446677565709;3451.6548345165284;3472.68745812873;3489.267253876714;3498.7201023918024;3518.2435776308216;6719.731210751515;6734.158230221223;6737.056812046318;6769.086173366631;6780.050792888901;6495.837604059841;6677.265500795006;6701.525664353834;6702.396784289437;6704.497162712816;6791.796246112525;6792.184937807495;6796.796096117125;6801.421879140328;6810.31896810315;6601.801945941629;6626.039224312544;6631.933680663132;6632.436242919406;6638.103855979381;6369.745210191726;6462.903056454251;6463.709133089116;6468.256150542559;6481.935180648322;6759.493038022069;6774.051632771515;6774.42417394527;6781.728730850711;6791.72833086671;4362.585554372329;4387.341898715218;4387.648988080882;4391.187630288407;4393.7363758174615;6418.646974416265;6535.117759102651;6554.967225164034;6563.343665633399;6573.211214654272;6337.302896681454;6340.1440805490665;6344.302126766144;6346.841328966812;6348.269948955929;6328.335524769833;6331.841703957438;6336.398042185985;6341.651209183355;6343.143675603919;6121.571489995836;6183.907241391293;6210.5652604317265;6223.190985171898;6225.906611400742;6341.841453963688;6345.206849143857;6350.682465876595;6355.777547785805;6356.968215158895;6161.938380616316;6177.96911015442;6178.752849885954;6180.196574445294;6180.969095154495 05:19:48 INFO - PROCESS | 21094 | |5;yui.html;700.8808502554566;821.5194111444805;831.305859607228;839.2404873589402;845.5898889038818;12981.870181298184;13056.673583160402;13119.93440032801;13157.079004469691;13161.276129812857;13073.280969546671;13093.934530327359;13130.212187268771;13131;13143.934280328585;674.8211723893172;682.8804959132157;684.8698747238034;808.870580707087;820.1429506166071;670.778643047793;809.7611204694629;826.7230477789948;830.1366578758084;834.253343257784;863.313665635821;867.9566021698889;869.6347534035721;870.0386073388909;870.5342641686699;707.8902770070647;862.2756884217225;862.6808081010004;862.8274345130999;863.2317237658489;636.1634450697318;643.6041834271936;647.0746832030195;648.0279580629057;648.3419329380682;12805.359732013361;12825.422855971503;12831.615051548468;12857.164284321489;12858.678533036655;12465.875341246563;12810.55163069288;12923;13303.86696133036;13624.727505449835;9684.75788105296;9724.75688107796;9815.607375704963;9914.058164474363;10270.89729102707;3526.947095793565;3627.129488922666;3634.545681789776;3652.1782598915033;3659.8536058557893;47481.28778068332;47519.76240118777;47633;47661.285080723814;47676.523234767556;9681;9990.30067895255;10079.748006299755;10369.533370998322;10395.94802025985;17750.20124094419;17754.467365979042;17784.91107544454;17801.020943847954;17810.19854106568;7336.96331518339;7500.849983000309;7509;7573.166951635316;7590.468667193243;4262.936055959163;4326.545712700121;4362.039327908094;4411.448568928884;4455.6658250631335;3133.4046531159006;3151.385479831457;3153.0225630054756;3160.225744692565;3162.304293055524;554.1742803223168;560.3108176942302;560.938296787353;571.245955338957;571.6312978129083;457.6476113392669;480.84372578911996;545.4490964126261;606.7300051477139;613.3988691082764;7908.248716371935;8325.625346859406;8443;8656.740297791077;8739.563021848882;531.7447625139954;536.9919451208235;598.7096258314714;675.3955210087042;718.3032458515232;3715.5169827922196;3850.537935447764;3900.531936167621;4013.4581831452965;4150.439690641785;50585.747071264406;50646.74676626667;50894;51590.74204628953;51602.48397516052;46652;47033.76483117631;47451.762741186074;47468.287975680396;48107.75946120247;42883.85580720951;42897.35653965193;43042.569574304485;43210.351844722354;43546.56453435425;7625.389968802593;7684.884726729216;7741;7866.270416113026;7902.723404680809;32735.181620458727;32753;33478.16304592405;33484.66515334913;33738.83130584331;37450.43824342582;37555.81222093872;40086.39654413791;40664.39003414892;40772.592274078066;9576.138147566753;9791.069848364394;10020.498975051072;10066.49667516636;10267.486625668836;11128.721781955515;11135.944320278346;11300.434978251218;11523.481443334902;11607.593734219261;10089.394636321844;10117.19062475015;10234.744131396477;10347.12049475803;10483.37099774016;10378.844317335397;10409.791804163722;10477.214208934512;10773.569057237935;10798.514066866852;10287.897121028993;10449.05958463742;10498.737531561772;10525.89474105249;10551.94724026375;7541.5475071495885;7601.7719468416035;7609.391248700202;7827.765167044998;8017.278444939983;7364.3003914628025;7603.7338693145475;7891;8830.205281524693;9681.66114186 05:19:48 INFO - PROCESS | 21094 | __end_tp_report 05:19:48 INFO - PROCESS | 21094 | __start_cc_report 05:19:48 INFO - PROCESS | 21094 | _x_x_mozilla_cycle_collect,865 05:19:48 INFO - PROCESS | 21094 | __end_cc_report 05:19:48 INFO - PROCESS | 21094 | __startTimestamp1455110388276__endTimestamp 05:19:48 INFO - PROCESS | 21094 | 05:19:48 INFO - PROCESS | 21094 | ------- Summary: start ------- 05:19:48 INFO - PROCESS | 21094 | Number of tests: 6 05:19:48 INFO - PROCESS | 21094 | 05:19:48 INFO - PROCESS | 21094 | [#0] dojo.html Cycles:165 Average:5135.19 Median:5343.97 stddev:548.18 (10.3%) stddev-sans-first:526.26 05:19:48 INFO - PROCESS | 21094 | Values: 3106.8 3133.0 3180.7 3181.0 3217.4 5001.2 5086.5 5091.1 5129.3 5172.9 5037.1 5079.3 5091.1 5093.5 5154.8 4627.7 4677.6 4727.1 4767.3 4803.1 4645.0 4695.6 4748.3 4757.0 4879.1 4710.8 4737.0 4749.6 4760.9 4777.6 4723.5 4728.9 4746.2 4752.9 4768.5 4643.0 4716.7 4732.3 4749.8 4779.6 4990.9 4991.7 5020.1 5032.7 5044.7 5400.8 5517.1 5525.4 5532.6 5532.6 5434.0 5489.6 5607.3 5632.9 5687.0 5214.5 5233.4 5235.1 5238.1 5280.6 5459.5 5555.7 5654.2 5663.3 5664.2 5463.3 5496.9 5501.4 5504.4 5510.9 5504.3 5519.9 5521.4 5521.9 5528.9 5362.4 5441.5 5489.9 5497.2 5531.0 5538.2 5540.0 5541.5 5548.1 5559.9 4316.7 4324.8 4329.4 4330.0 4361.9 3807.9 3835.8 3894.6 3909.5 3918.1 5093.9 5106.5 5120.2 5122.3 5170.7 5491.8 5495.5 5514.3 5524.8 5530.6 4994.8 5065.7 5070.8 5096.9 5147.1 4667.4 4703.7 4718.2 4720.4 4756.8 5641.2 5711.9 5714.4 5716.2 5727.0 5378.4 5543.9 5548.1 5566.6 5608.6 5693.4 5729.4 5738.4 5740.0 5742.6 5314.1 5395.3 5464.5 5473.9 5475.2 5534.5 5572.1 5575.3 5575.8 5613.8 5392.9 5415.6 5426.5 5446.2 5464.0 5209.7 5336.8 5430.6 5446.1 5482.9 5332.5 5344.0 5344.6 5349.1 5365.1 5394.5 5431.6 5442.0 5442.2 5486.2 5177.5 5263.2 5294.9 5344.9 5386.1 05:19:48 INFO - PROCESS | 21094 | 05:19:48 INFO - PROCESS | 21094 | [#1] ext.html Cycles:180 Average:44351.09 Median:35119.82 stddev:71509.18 (203.6%) stddev-sans-first:71634.11 05:19:48 INFO - PROCESS | 21094 | Values: 535.6 541.5 553.3 565.3 614.4 28200.4 36824.3 37130.4 37320.3 37418.8 39051.8 39619.0 39695.0 39730.4 39779.6 8435.5 8630.0 8634.5 8647.1 8689.2 8546.3 8648.6 8651.5 8686.3 8857.6 8841.0 8914.3 8924.5 8926.7 8933.5 8836.0 8864.7 8890.6 8898.2 8910.9 8795.6 8864.7 8909.9 8962.7 8973.1 39762.4 39782.0 39951.6 40166.8 40309.4 3444.7 3478.3 3858.6 3998.4 4142.3 29832.7 30119.7 30242.0 30351.0 30371.8 3937.7 3976.8 3981.4 4006.8 4012.2 260166.0 261382.0 262203.0 264444.0 265684.0 56031.7 56043.0 56099.4 56242.4 56576.4 58895.0 58947.0 58982.7 59037.4 59171.4 15162.8 15399.3 15402.9 15416.2 15436.2 11114.8 11134.2 11134.9 11139.1 11140.3 17430.3 18511.6 18742.3 18827.3 19026.9 6575.7 7648.7 7905.2 8016.6 8068.9 848.5 952.6 1043.5 1054.2 1146.1 27034.9 27856.6 28191.7 28347.0 28958.4 1012.5 1095.5 1139.7 1202.7 1217.0 13438.9 15336.5 15450.0 15521.3 15775.1 278775.0 284647.0 284932.0 285409.0 286747.0 50673.0 50921.7 51010.5 51305.0 51348.5 1314.1 1331.8 1340.6 1341.6 1361.5 29464.4 30250.0 30362.6 30379.0 30479.8 45295.8 45843.3 45928.0 45983.8 46044.3 265153.0 266907.0 267237.0 267434.0 311101.0 32465.5 33154.2 33199.8 33475.8 33486.8 39884.0 40282.6 40610.2 40669.4 41072.0 34679.8 34893.1 34895.0 35105.6 35576.5 33976.8 34290.3 34608.7 34763.8 35134.0 31750.8 34002.0 36620.8 36879.3 39732.6 29522.3 31568.0 31643.5 31906.4 32039.0 24357.8 24553.0 24808.0 25155.0 25170.5 05:19:48 INFO - PROCESS | 21094 | 05:19:48 INFO - PROCESS | 21094 | [#2] jquery.html Cycles:180 Average:26556.96 Median:4492.24 stddev:77019.16 (1714.5%) stddev-sans-first:77210.10 05:19:48 INFO - PROCESS | 21094 | Values: 361.4 367.7 368.1 371.8 372.2 13538.4 14451.7 16303.5 17432.8 18240.5 16168.0 16339.9 16373.4 17287.2 17815.1 5787.5 5968.8 5968.9 5973.3 5978.9 4296.7 4470.1 4475.3 4478.5 5953.6 6443.3 6510.6 6621.7 6692.8 6701.0 6603.9 6650.4 6660.4 6663.3 6664.6 6385.6 6539.3 6550.8 6552.5 6556.6 21736.1 22183.1 22833.2 22979.0 23009.8 2386.7 2391.4 2467.6 2783.5 2807.5 13450.3 13578.3 13887.3 13944.9 14209.7 1982.9 1995.9 2009.7 2011.7 2022.6 60836.7 65107.7 65540.0 67433.3 70596.3 14996.5 15408.7 15639.4 15723.1 15751.8 23750.4 23782.4 23948.0 24064.9 24073.8 6796.6 6913.8 6915.5 6954.8 7118.1 6382.6 6412.1 6483.6 6490.9 6556.2 4138.9 4403.3 4506.0 4511.7 4545.4 1591.4 1623.7 1633.9 1763.7 1840.1 859.3 934.8 980.4 1018.3 1063.9 11737.5 13978.7 14932.8 15079.2 15140.2 925.4 933.6 942.6 952.3 975.5 8938.6 9022.8 9088.3 9108.6 9164.8 461716.0 470861.0 471791.0 472741.0 476436.0 68646.7 71606.6 72079.0 73164.6 73337.3 1120.4 1128.8 1133.2 1149.7 1151.0 13200.6 13433.3 13526.8 13613.6 13640.8 32508.5 33565.3 33630.7 33852.3 33880.5 43287.0 43577.0 45863.0 47062.8 47789.3 7493.4 7598.5 7611.7 7674.4 7684.5 8759.0 10747.0 11417.3 11920.7 12073.5 9179.3 9934.0 9988.2 10144.7 10563.2 8786.4 9551.8 9622.9 9989.7 10317.5 9005.9 9619.7 9687.4 9690.3 9837.8 7277.3 7335.1 7530.9 7683.7 7710.3 8295.4 10472.9 10561.7 10658.0 10710.8 05:19:48 INFO - PROCESS | 21094 | 05:19:48 INFO - PROCESS | 21094 | [#3] mootools.html Cycles:180 Average:5230.03 Median:6289.23 stddev:2680.05 (42.6%) stddev-sans-first:2671.40 05:19:48 INFO - PROCESS | 21094 | Values: 1314.4 1437.0 1448.3 1586.5 1730.6 6512.4 7079.5 7208.0 7251.1 7265.1 7096.4 7240.7 7259.5 7263.8 7271.7 1852.9 1909.9 1915.7 2210.5 2213.9 1913.1 2111.2 2159.1 2159.2 2166.1 2113.9 2122.6 2133.0 2200.5 2215.4 2082.5 2109.8 2109.9 2111.8 2118.2 2181.8 2184.4 2185.6 2186.1 2195.9 7381.0 7429.9 7434.9 7437.6 7443.7 4631.4 4725.2 4758.1 4761.5 4767.5 2956.5 3162.1 3165.7 3183.3 3188.9 972.5 992.3 998.7 1012.3 1057.3 10264.1 10285.9 10287.2 10287.6 10299.5 4180.6 4241.3 4241.6 4292.4 4293.4 8786.1 8786.8 8788.4 8790.6 8806.9 4657.7 4677.0 4683.5 4687.3 4716.0 4297.4 4301.8 4302.3 4304.0 4304.1 3264.3 3447.6 3470.3 3532.8 3562.4 1191.8 1204.0 1208.0 1214.7 1215.5 1309.1 1320.2 1323.7 1335.3 1361.9 6635.8 6700.7 6703.7 6711.3 6737.1 1105.0 1111.5 1115.8 1133.9 1153.2 5342.6 5396.0 5411.9 5422.7 5427.4 8723.6 9052.6 9102.6 9196.8 9261.1 9067.6 9071.7 9094.8 9178.3 9180.5 6925.1 6975.7 7105.3 7240.1 7241.1 6578.8 6598.1 6608.7 6615.8 6619.0 8046.1 8113.5 8122.0 8243.7 8270.8 8129.3 8343.7 8462.4 8467.1 8498.2 6394.2 6440.6 6477.8 6488.9 6496.9 6261.4 6850.1 6967.2 7046.3 7067.3 6700.6 6752.1 6782.9 6850.8 6868.0 6480.8 6539.7 6597.6 6606.6 6717.1 6248.2 6277.3 6301.1 6302.7 6319.2 6302.0 6339.9 6348.0 6351.0 6353.5 6244.5 6373.9 6385.6 6401.8 6414.5 05:19:48 INFO - PROCESS | 21094 | 05:19:48 INFO - PROCESS | 21094 | [#4] prototype.html Cycles:180 Average:5265.16 Median:5862.97 stddev:1582.71 (27.0%) stddev-sans-first:1542.90 05:19:48 INFO - PROCESS | 21094 | Values: 313.6 335.0 335.8 340.3 343.8 5861.8 5864.1 5869.6 5904.4 5929.1 5554.4 5653.5 5668.7 5798.4 5833.8 4520.1 4554.4 4567.3 4581.3 4586.7 4302.2 4552.2 4581.9 4583.6 4585.4 4412.7 4484.8 4493.6 4507.0 4526.7 4524.6 4544.6 4550.3 4551.6 4562.9 3973.6 3977.9 3978.3 4001.2 4012.3 5533.4 5627.8 5637.7 5676.3 5679.7 5275.2 5284.3 5285.7 5287.7 5290.9 6249.4 6251.9 6254.8 6258.6 6259.6 4436.0 4439.9 4441.5 4441.8 4442.4 6353.2 6521.5 6521.7 6533.7 6543.1 4523.9 4531.8 4531.9 4532.0 4532.8 4591.5 4593.8 4595.9 4596.2 4597.9 5261.8 5262.3 5262.3 5264.4 5276.7 6129.4 6293.9 6295.3 6305.6 6322.7 1604.9 1626.2 1626.8 1627.4 1627.5 1047.4 1090.0 1095.2 1098.4 1113.7 5887.6 5924.9 5926.5 5931.2 5942.7 6462.8 6466.4 6477.4 6478.6 6486.4 5712.2 5804.7 5805.4 5822.6 5824.4 3451.7 3472.7 3489.3 3498.7 3518.2 6719.7 6734.2 6737.1 6769.1 6780.1 6495.8 6677.3 6701.5 6702.4 6704.5 6791.8 6792.2 6796.8 6801.4 6810.3 6601.8 6626.0 6631.9 6632.4 6638.1 6369.7 6462.9 6463.7 6468.3 6481.9 6759.5 6774.1 6774.4 6781.7 6791.7 4362.6 4387.3 4387.6 4391.2 4393.7 6418.6 6535.1 6555.0 6563.3 6573.2 6337.3 6340.1 6344.3 6346.8 6348.3 6328.3 6331.8 6336.4 6341.7 6343.1 6121.6 6183.9 6210.6 6223.2 6225.9 6341.8 6345.2 6350.7 6355.8 6357.0 6161.9 6178.0 6178.8 6180.2 6181.0 05:19:48 INFO - PROCESS | 21094 | 05:19:48 INFO - PROCESS | 21094 | [#5] yui.html Cycles:180 Average:12922.23 Median:47460.03 stddev:14704.50 (31.0%) stddev-sans-first:14717.11 05:19:48 INFO - PROCESS | 21094 | Values: 700.9 821.5 831.3 839.2 845.6 12981.9 13056.7 13119.9 13157.1 13161.3 13073.3 13093.9 13130.2 13131.0 13143.9 674.8 682.9 684.9 808.9 820.1 670.8 809.8 826.7 830.1 834.3 863.3 868.0 869.6 870.0 870.5 707.9 862.3 862.7 862.8 863.2 636.2 643.6 647.1 648.0 648.3 12805.4 12825.4 12831.6 12857.2 12858.7 12465.9 12810.6 12923.0 13303.9 13624.7 9684.8 9724.8 9815.6 9914.1 10270.9 3526.9 3627.1 3634.5 3652.2 3659.9 47481.3 47519.8 47633.0 47661.3 47676.5 9681.0 9990.3 10079.7 10369.5 10395.9 17750.2 17754.5 17784.9 17801.0 17810.2 7337.0 7500.8 7509.0 7573.2 7590.5 4262.9 4326.5 4362.0 4411.4 4455.7 3133.4 3151.4 3153.0 3160.2 3162.3 554.2 560.3 560.9 571.2 571.6 457.6 480.8 545.4 606.7 613.4 7908.2 8325.6 8443.0 8656.7 8739.6 531.7 537.0 598.7 675.4 718.3 3715.5 3850.5 3900.5 4013.5 4150.4 50585.7 50646.7 50894.0 51590.7 51602.5 46652.0 47033.8 47451.8 47468.3 48107.8 42883.9 42897.4 43042.6 43210.4 43546.6 7625.4 7684.9 7741.0 7866.3 7902.7 32735.2 32753.0 33478.2 33484.7 33738.8 37450.4 37555.8 40086.4 40664.4 40772.6 9576.1 9791.1 10020.5 10066.5 10267.5 11128.7 11135.9 11300.4 11523.5 11607.6 10089.4 10117.2 10234.7 10347.1 10483.4 10378.8 10409.8 10477.2 10773.6 10798.5 10287.9 10449.1 10498.7 10525.9 10551.9 7541.5 7601.8 7609.4 7827.8 8017.3 7364.3 7603.7 7891.0 8830.2 9681.7 05:19:48 INFO - PROCESS | 21094 | -------- Summary: end -------- 05:19:48 INFO - PROCESS | 21094 | 05:19:48 INFO - TEST-INFO | 21094: exit 0 05:19:48 INFO - TEST-OK | dromaeo_css | took 1112632ms 05:19:48 INFO - TEST-START | kraken 05:19:48 INFO - operating with platform_type : linux_ 05:19:48 INFO - Initialising browser for kraken test... 05:19:48 INFO - TEST-INFO | started process 21275 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeayz6z/profile http://localhost:33466/getInfo.html) 05:19:52 INFO - PROCESS | 21275 | __metrics Screen width/height:1600/1200 05:19:52 INFO - PROCESS | 21275 | colorDepth:24 05:19:52 INFO - PROCESS | 21275 | Browser inner width/height: 1024/697 05:19:52 INFO - PROCESS | 21275 | __metrics 05:19:53 INFO - PROCESS | 21275 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:19:53 INFO - TEST-INFO | 21275: exit 0 05:19:53 INFO - Browser initialized. 05:19:53 INFO - Running cycle 1/1 for kraken test... 05:19:53 INFO - TEST-INFO | started process 21355 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeayz6z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:05 INFO - PROCESS | 21355 | RSS: Main: 152363008 05:20:05 INFO - PROCESS | 21355 | 05:20:08 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33466/tests/kraken/driver.html?testName=audio-beat-detection) 05:20:08 INFO - PROCESS | 21355 | RSS: Main: 192106496 05:20:08 INFO - PROCESS | 21355 | 05:20:11 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33466/tests/kraken/driver.html?testName=audio-dft) 05:20:11 INFO - PROCESS | 21355 | RSS: Main: 183087104 05:20:11 INFO - PROCESS | 21355 | 05:20:14 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33466/tests/kraken/driver.html?testName=audio-fft) 05:20:15 INFO - PROCESS | 21355 | RSS: Main: 165941248 05:20:15 INFO - PROCESS | 21355 | 05:20:17 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33466/tests/kraken/driver.html?testName=audio-oscillator) 05:20:18 INFO - PROCESS | 21355 | RSS: Main: 168808448 05:20:18 INFO - PROCESS | 21355 | 05:20:20 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33466/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:20:20 INFO - PROCESS | 21355 | RSS: Main: 169689088 05:20:20 INFO - PROCESS | 21355 | 05:20:23 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33466/tests/kraken/driver.html?testName=imaging-darkroom) 05:20:24 INFO - PROCESS | 21355 | RSS: Main: 171200512 05:20:24 INFO - PROCESS | 21355 | 05:20:27 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33466/tests/kraken/driver.html?testName=imaging-desaturate) 05:20:28 INFO - PROCESS | 21355 | RSS: Main: 172072960 05:20:28 INFO - PROCESS | 21355 | 05:20:31 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33466/tests/kraken/driver.html?testName=json-parse-financial) 05:20:31 INFO - PROCESS | 21355 | RSS: Main: 170668032 05:20:31 INFO - PROCESS | 21355 | 05:20:33 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33466/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:20:33 INFO - PROCESS | 21355 | RSS: Main: 180748288 05:20:33 INFO - PROCESS | 21355 | 05:20:35 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33466/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:20:36 INFO - PROCESS | 21355 | RSS: Main: 178827264 05:20:36 INFO - PROCESS | 21355 | 05:20:38 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33466/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:20:38 INFO - PROCESS | 21355 | RSS: Main: 189067264 05:20:38 INFO - PROCESS | 21355 | 05:20:41 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:20:41 INFO - PROCESS | 21355 | RSS: Main: 193970176 05:20:41 INFO - PROCESS | 21355 | 05:20:44 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:20:45 INFO - PROCESS | 21355 | RSS: Main: 195170304 05:20:45 INFO - PROCESS | 21355 | 05:20:46 INFO - PROCESS | 21355 | Cycle 1(1): loaded http://localhost:33466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33466/tests/kraken/driver.html?testName=ai-astar) 05:20:47 INFO - PROCESS | 21355 | RSS: Main: 254558208 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | __start_tp_report 05:20:47 INFO - PROCESS | 21355 | _x_x_mozilla_page_load 05:20:47 INFO - PROCESS | 21355 | _x_x_mozilla_page_load_details 05:20:47 INFO - PROCESS | 21355 | |i|pagename|runs| 05:20:47 INFO - PROCESS | 21355 | |0;ai-astar;112;113;107;111;113;111;103;111;111;111 05:20:47 INFO - PROCESS | 21355 | |1;audio-beat-detection;157;128;149;164;126;165;151;126;171;127 05:20:47 INFO - PROCESS | 21355 | |2;audio-dft;160;161;162;160;164;163;159;163;162;161 05:20:47 INFO - PROCESS | 21355 | |3;audio-fft;75;73;117;94;73;73;74;105;91;72 05:20:47 INFO - PROCESS | 21355 | |4;audio-oscillator;96;96;146;94;95;94;138;95;96;133 05:20:47 INFO - PROCESS | 21355 | |5;imaging-gaussian-blur;119;115;115;114;114;114;115;114;114;114 05:20:47 INFO - PROCESS | 21355 | |6;imaging-darkroom;145;145;145;145;146;145;145;145;146;145 05:20:47 INFO - PROCESS | 21355 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;95;96 05:20:47 INFO - PROCESS | 21355 | |8;json-parse-financial;56;57;56;57;56;55;56;64;53;53 05:20:47 INFO - PROCESS | 21355 | |9;json-stringify-tinderbox;66;72;66;67;66;66;67;66;67;67 05:20:47 INFO - PROCESS | 21355 | |10;stanford-crypto-aes;83;85;89;85;86;86;85;85;86;86 05:20:47 INFO - PROCESS | 21355 | |11;stanford-crypto-ccm;121;132;119;118;122;124;121;119;121;124 05:20:47 INFO - PROCESS | 21355 | |12;stanford-crypto-pbkdf2;154;144;152;149;153;140;151;149;149;150 05:20:47 INFO - PROCESS | 21355 | |13;stanford-crypto-sha256-iterative;69;68;70;69;69;69;67;70;68;67 05:20:47 INFO - PROCESS | 21355 | __end_tp_report 05:20:47 INFO - PROCESS | 21355 | __start_cc_report 05:20:47 INFO - PROCESS | 21355 | _x_x_mozilla_cycle_collect,960 05:20:47 INFO - PROCESS | 21355 | __end_cc_report 05:20:47 INFO - PROCESS | 21355 | __startTimestamp1455110447072__endTimestamp 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | ------- Summary: start ------- 05:20:47 INFO - PROCESS | 21355 | Number of tests: 14 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:3.06 (2.8%) stddev-sans-first:3.18 05:20:47 INFO - PROCESS | 21355 | Values: 112.0 113.0 107.0 111.0 113.0 111.0 103.0 111.0 111.0 111.0 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:154.00 stddev:18.10 (11.8%) stddev-sans-first:18.79 05:20:47 INFO - PROCESS | 21355 | Values: 157.0 128.0 149.0 164.0 126.0 165.0 151.0 126.0 171.0 127.0 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.58 (1.0%) stddev-sans-first:1.58 05:20:47 INFO - PROCESS | 21355 | Values: 160.0 161.0 162.0 160.0 164.0 163.0 159.0 163.0 162.0 161.0 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#3] audio-fft Cycles:10 Average:84.70 Median:73.50 stddev:16.20 (22.0%) stddev-sans-first:16.80 05:20:47 INFO - PROCESS | 21355 | Values: 75.0 73.0 117.0 94.0 73.0 73.0 74.0 105.0 91.0 72.0 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:95.00 stddev:21.42 (22.5%) stddev-sans-first:22.25 05:20:47 INFO - PROCESS | 21355 | Values: 96.0 96.0 146.0 94.0 95.0 94.0 138.0 95.0 96.0 133.0 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.50 stddev:1.55 (1.4%) stddev-sans-first:0.50 05:20:47 INFO - PROCESS | 21355 | Values: 119.0 115.0 115.0 114.0 114.0 114.0 115.0 114.0 114.0 114.0 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 05:20:47 INFO - PROCESS | 21355 | Values: 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 05:20:47 INFO - PROCESS | 21355 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:3.06 (5.5%) stddev-sans-first:3.24 05:20:47 INFO - PROCESS | 21355 | Values: 56.0 57.0 56.0 57.0 56.0 55.0 56.0 64.0 53.0 53.0 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:1.83 (2.7%) stddev-sans-first:1.90 05:20:47 INFO - PROCESS | 21355 | Values: 66.0 72.0 66.0 67.0 66.0 66.0 67.0 66.0 67.0 67.0 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.51 (1.8%) stddev-sans-first:1.27 05:20:47 INFO - PROCESS | 21355 | Values: 83.0 85.0 89.0 85.0 86.0 86.0 85.0 85.0 86.0 86.0 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:121.50 stddev:4.01 (3.3%) stddev-sans-first:4.24 05:20:47 INFO - PROCESS | 21355 | Values: 121.0 132.0 119.0 118.0 122.0 124.0 121.0 119.0 121.0 124.0 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:150.50 stddev:4.23 (2.8%) stddev-sans-first:4.10 05:20:47 INFO - PROCESS | 21355 | Values: 154.0 144.0 152.0 149.0 153.0 140.0 151.0 149.0 149.0 150.0 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - PROCESS | 21355 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 05:20:47 INFO - PROCESS | 21355 | Values: 69.0 68.0 70.0 69.0 69.0 69.0 67.0 70.0 68.0 67.0 05:20:47 INFO - PROCESS | 21355 | -------- Summary: end -------- 05:20:47 INFO - PROCESS | 21355 | 05:20:47 INFO - TEST-INFO | 21355: exit 0 05:20:47 INFO - TEST-OK | kraken | took 59038ms 05:20:47 INFO - SUITE-END | took 1171s 05:20:48 INFO - Completed test suite (00:19:31) 05:20:48 INFO - Working with test: dromaeo_css 05:20:48 INFO - Generating results file: dromaeo_css 05:20:48 INFO - Working with test: kraken 05:20:48 INFO - Generating results file: kraken 05:20:48 INFO - javascript benchmark 05:20:48 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:20:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:20:48 INFO - process_Request line: dromaeo_css 6810.73 graph.html#tests=[[72,64,35]] 05:20:48 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:20:48 INFO - process_Request line: kraken 1515.70 graph.html#tests=[[232,64,35]] 05:20:48 INFO - RETURN: dromaeo_css: 6810.73 05:20:48 INFO - RETURN: kraken: 1515.70 05:20:48 INFO - javascript benchmark 05:20:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3106.8135911845293, 3132.9530057049164, 3180.7137357637807, 3181.045686294113, 3217.3726123405936, 5001.249812528123, 5086.465921078289, 5091.134507133792, 5129.281900533923, 5172.870678233046, 5037.093323201822, 5079.263506791523, 5091.109055915209, 5093.465186155456, 5154.8453546393575, 4627.676062675614, 4677.625789936806, 4727.101850648383, 4767.284907263921, 4803.06340263647, 4645.0, 4695.624350051988, 4748.311494833247, 4756.97621511892, 4879.146149423855, 4710.788014539354, 4736.95263047372, 4749.572538471554, 4760.90478190436, 4777.641676874248, 4723.504032076617, 4728.905421891577, 4746.240601503778, 4752.904941901177, 4768.47546769855, 4642.9535704643195, 4716.669833111683, 4732.266498692708, 4749.762511874393, 4779.593734532569, 4990.925136122961, 4991.675541089854, 5020.0963826511215, 5032.6980381177245, 5044.722540260284, 5400.810971615974, 5517.117261238222, 5525.419830917776, 5532.5573954083575, 5532.640378375393, 5433.972830135824, 5489.615726899118, 5607.271054762855, 5632.859178520529, 5687.0, 5214.4524824893215, 5233.371995360543, 5235.083860324428, 5238.109521381374, 5280.577553795687, 5459.481349271892, 5555.694436806015, 5654.236678048493, 5663.320401551758, 5664.150377443417, 5463.262459567907, 5496.862578435571, 5501.449855014546, 5504.394516603251, 5510.9448905510435, 5504.256925315111, 5519.944800551943, 5521.3926468088475, 5521.944780552223, 5528.944710552923, 5362.436944120889, 5441.483059109458, 5489.945100549024, 5497.230387745719, 5530.972345138329, 5538.16927460876, 5540.0, 5541.501264886179, 5548.112302031655, 5559.916601250903, 4316.719413238129, 4324.783760811947, 4329.372241025034, 4330.0, 4361.9127617447475, 3807.942880856734, 3835.7506762060375, 3894.6300101490315, 3909.4722212501515, 3918.0792513759243, 5093.9490605094215, 5106.4893510648635, 5120.231965205249, 5122.282880396748, 5170.663906846043, 5491.752871120809, 5495.505404513613, 5514.28314319144, 5524.751386187631, 5530.640508366943, 4994.775235114428, 5065.670731402447, 5070.797168113308, 5096.949030509648, 5147.0992576298995, 4667.393238878924, 4703.694259873166, 4718.2214934536105, 4720.433547974265, 4756.833510827174, 5641.2384328116, 5711.914321285184, 5714.428557144335, 5716.228309178291, 5727.0, 5378.435264297193, 5543.944560554342, 5548.056830338772, 5566.610337276352, 5608.579356548356, 5693.4021927696995, 5729.369769325288, 5738.426157384228, 5740.0, 5742.59801813869, 5314.1497360422145, 5395.298611180521, 5464.453554644504, 5473.890522189614, 5475.206095116266, 5534.4742249486235, 5572.108462645957, 5575.275214222287, 5575.804846830341, 5613.775448982158, 5392.919106213489, 5415.5938304626525, 5426.511613954763, 5446.183072539151, 5463.972680136574, 5209.661372010807, 5336.786528538815, 5430.647007944471, 5446.101393270066, 5482.945170548403, 5332.493413125747, 5343.973280133574, 5344.625876188785, 5349.144136938071, 5365.061114304903, 5394.487523685244, 5431.619786614899, 5442.047641662773, 5442.183672449006, 5486.231927530069, 5177.508136727156, 5263.184206448007, 5294.867628309323, 5344.919826202532, 5386.084365657769], "unit": "score", "name": "dojo.html", "value": 5101.371593655991}, {"lowerIsBetter": false, "replicates": [535.568867062015, 541.5369858770754, 553.3498139685868, 565.2905603467649, 614.431650723081, 28200.43599128019, 36824.26351472969, 37130.4430433543, 37320.253594928115, 37418.8129059355, 39051.804740976324, 39619.0, 39695.0, 39730.40404393929, 39779.60220397795, 8435.451695639795, 8629.95685021574, 8634.481931084156, 8647.092055334193, 8689.217970382664, 8546.273566746833, 8648.610812513452, 8651.48091114535, 8686.305095592368, 8857.557122143899, 8841.0, 8914.331425143107, 8924.509151996637, 8926.73219803407, 8933.46399216046, 8836.028036915934, 8864.73405797827, 8890.599923003449, 8898.19916207538, 8910.86633700495, 8795.648174073029, 8864.73405797827, 8909.910900890973, 8962.73111806647, 8973.147550982647, 39762.403563946566, 39782.0, 39951.60048399508, 40166.799166004275, 40309.39535906934, 3444.6555344465605, 3478.2521757821937, 3858.594847541024, 3998.3602623580377, 4142.275101857163, 29832.70167298321, 30119.69880301213, 30242.0, 30351.0, 30371.848140759153, 3937.6652984496354, 3976.8210430530694, 3981.3629819228786, 4006.779627120507, 4012.197560487914, 260166.0, 261382.0, 262203.0, 264444.0, 265684.0, 56031.71984140053, 56043.0, 56099.43900560942, 56242.437575624535, 56576.43423565794, 58895.0, 58947.0, 58982.70508647429, 59037.409625903194, 59171.40828591745, 15162.772558411632, 15399.307031183624, 15402.922985385001, 15416.229188540528, 15436.228188590525, 11114.833277500844, 11134.16493762971, 11134.944325278322, 11139.053180479588, 11140.33158010522, 17430.286380912985, 18511.629767404578, 18742.25030998772, 18827.34104306343, 19026.904865475863, 6575.736970521126, 7648.73229436967, 7905.209479052164, 8016.559089250147, 8068.870358149864, 848.4824257203101, 952.6379975609224, 1043.5095505112736, 1054.2462139570243, 1146.0774076868036, 27034.864825675744, 27856.582151267747, 28191.71808281932, 28347.0, 28958.420831583673, 1012.4633944009687, 1095.4686976816238, 1139.7378602921374, 1202.657242685848, 1216.9534200587489, 13438.932805335911, 15336.539903802905, 15450.0, 15521.301541430663, 15775.132367719656, 278775.0, 284647.0, 284932.0, 285409.0, 286747.0, 50673.0, 50921.74539127281, 51010.48989510132, 51305.0, 51348.48651513512, 1314.0932756398054, 1331.8202042724108, 1340.6112227454123, 1341.584108926236, 1361.537077393671, 29464.410711785215, 30250.0, 30362.59703108517, 30379.0, 30479.847600761856, 45295.773521132185, 45843.3123503141, 45928.0, 45983.77008114938, 46044.30933536067, 265153.0, 266907.0, 267237.0, 267434.0, 311101.0, 32465.51301730523, 33154.17114572155, 33199.838005669684, 33475.83262083674, 33486.832565837016, 39883.99557508881, 40282.597174029055, 40610.1877962445, 40669.38995915123, 41072.0, 34679.82660086784, 34893.127671808405, 34895.0, 35105.64894351024, 35576.46635300524, 33976.83011584926, 34290.314193716484, 34608.65391346155, 34763.826180868935, 35134.0, 31750.841245793625, 34002.0, 36620.81689591535, 36879.26241475209, 39732.60267397289, 29522.261943451587, 31568.0, 31643.52534712027, 31906.36187276288, 32039.0, 24357.75642243555, 24553.0, 24808.0, 25155.0, 25170.49659006773], "unit": "score", "name": "ext.html", "value": 18258.730854617595}, {"lowerIsBetter": false, "replicates": [361.35498135827544, 367.702161249388, 368.1183565360962, 371.8196674612811, 372.2313422781955, 13538.39077241524, 14451.710965780678, 16303.510894673149, 17432.825671743278, 18240.54398640033, 16168.0, 16339.91830040848, 16373.42693005745, 17287.222075006623, 17815.109244537787, 5787.536997040227, 5968.820935371924, 5968.850778730544, 5973.253343332083, 5978.910316345236, 4296.656267498608, 4470.105978804236, 4475.28395456727, 4478.529754375792, 5953.642781433128, 6443.323451037644, 6510.64191469469, 6621.702023408934, 6692.765753198639, 6701.028350889118, 6603.933960660428, 6650.3682150195655, 6660.433863121641, 6663.30035346289, 6664.566803157779, 6385.616862988236, 6539.34606539347, 6550.836229094263, 6552.475801935833, 6556.573822701557, 21736.13055477779, 22183.11267549296, 22833.20083797059, 22979.0, 23009.76990230093, 2386.7016622922133, 2391.4499665076955, 2467.629855521668, 2783.471140483322, 2807.4946509628257, 13450.260235687034, 13578.253196074213, 13887.305634718325, 13944.930275348659, 14209.715805683829, 1982.8512861535298, 1995.860289779716, 2009.65835807913, 2011.6580181369056, 2022.6157030164222, 60836.69581652063, 65107.67446162786, 65540.0, 67433.3256667432, 70596.29403705949, 14996.47512337063, 15408.691826163415, 15639.3744250231, 15723.135227562365, 15751.842481575266, 23750.406239844142, 23782.405439863796, 23948.0, 24064.87967560186, 24073.7592624075, 6796.558223715443, 6913.755524005626, 6915.481338899603, 6954.826129346807, 7118.074650295428, 6382.553221274559, 6412.070249813844, 6483.610983341015, 6490.935090649033, 6556.213254409501, 4138.91722165555, 4403.339499075164, 4505.954940450619, 4511.736713720164, 4545.36364908913, 1591.4350405605844, 1623.6914986152594, 1633.942812001598, 1763.6913540130427, 1840.061568599997, 859.2910848549972, 934.7896723237353, 980.3921568627496, 1018.3228153277987, 1063.9202059845543, 11737.530498779954, 13978.720425591431, 14932.776008359884, 15079.170645614597, 15140.167290798892, 925.3799954030816, 933.6125507914139, 942.6323733743845, 952.3000594562991, 975.4829940131741, 8938.597763100675, 9022.819543609092, 9088.318376121684, 9108.590113444778, 9164.816703666023, 461716.0, 470861.0, 471791.0, 472741.0, 476436.0, 68646.65676671585, 71606.64196678983, 72079.0, 73164.63417682878, 73337.29958354296, 1120.4117838134882, 1128.7573171768108, 1133.195431243826, 1149.741308205647, 1150.9539618415338, 13200.603981880558, 13433.328333583477, 13526.797098043735, 13613.591592252249, 13640.79538806899, 32508.512372314908, 33565.32869342551, 33630.66369336275, 33852.32295354128, 33880.49179262264, 43287.0, 43577.0, 45863.0, 47062.76468617635, 47789.283160753315, 7493.43799215072, 7598.506097103671, 7611.733589324347, 7674.386049116169, 7684.500507466997, 8759.0, 10747.0, 11417.31496110236, 11920.70198245016, 12073.517059317881, 9179.311551633788, 9934.0, 9988.151007164472, 10144.695659130239, 10563.154947604327, 8786.384953053224, 9551.761205969628, 9622.9037709622, 9989.650362237287, 10317.535710893178, 9005.864912026194, 9619.663311784054, 9687.41875487473, 9690.321677482509, 9837.754056148653, 7277.345038946521, 7335.083114610674, 7530.872192361635, 7683.654235559301, 7710.344620707303, 8295.419320647738, 10472.947635261775, 10561.683149505527, 10658.0, 10710.785784284115], "unit": "score", "name": "jquery.html", "value": 8664.018674939145}, {"lowerIsBetter": false, "replicates": [1314.4150852870478, 1437.0443654969447, 1448.304813689429, 1586.5161125856616, 1730.6019615488444, 6512.38132377424, 7079.469039822015, 7207.999999999994, 7251.129864416264, 7265.09186351706, 7096.361327480526, 7240.746573869916, 7259.528130671502, 7263.818404539889, 7271.745488907889, 1852.8517718582548, 1909.9236030558761, 1915.6551820672273, 2210.546837898235, 2213.900374483152, 1913.0817207740292, 2111.229401268534, 2159.0608085482863, 2159.222679835258, 2166.1010680567547, 2113.8837363944976, 2122.628540005501, 2132.957340853182, 2200.4938864061273, 2215.3575463115676, 2082.5001999520005, 2109.810117089454, 2109.9050542725613, 2111.80993710566, 2118.1739121742535, 2181.814545763612, 2184.3992901951933, 2185.595664802017, 2186.081845624841, 2195.868247905115, 7381.0, 7429.888551671729, 7434.9256507434775, 7437.553746775211, 7443.739469118609, 4631.374764406829, 4725.196716558194, 4758.119747846625, 4761.523847615245, 4767.499412561666, 2956.467835789557, 3162.0513845846385, 3165.7309128724087, 3183.3155871487743, 3188.8883889063773, 972.5234635028855, 992.3053862296422, 998.6604554451449, 1012.3065699995526, 1057.2863317260894, 10264.127549158256, 10285.897141028569, 10287.177025837915, 10287.588496460132, 10299.536520856505, 4180.602842729936, 4241.257779888507, 4241.63946064588, 4292.420523229324, 4293.377460268243, 8786.07746186654, 8786.780330491789, 8788.384813063152, 8790.604422800989, 8806.86789698155, 4657.650676199299, 4676.994446194085, 4683.461401938753, 4687.296905464208, 4715.976420117946, 4297.39836422901, 4301.806418711166, 4302.290122129876, 4303.956960430418, 4304.074623955802, 3264.3308121834966, 3447.6035255945385, 3470.323286959019, 3532.823358832048, 3562.447820587813, 1191.8391017212566, 1203.9759204815855, 1207.9939600301943, 1214.6538236602526, 1215.477344741752, 1309.0509380698918, 1320.1551007355301, 1323.7087840675035, 1335.2522587351114, 1361.9046666733432, 6635.8009259722285, 6700.731970721214, 6703.698333575001, 6711.295313991961, 6737.09049278351, 1104.9944750276197, 1111.4823695900022, 1115.81031224692, 1133.9376334301528, 1153.1870031627682, 5342.599305052059, 5395.973020134874, 5411.918821217685, 5422.674639521641, 5427.375851777097, 8723.563821808884, 9052.592633331516, 9102.635894564275, 9196.816063678689, 9261.120193581599, 9067.591958361889, 9071.682491112779, 9094.81810363789, 9178.265738740885, 9180.540972951325, 6925.134358205224, 6975.720971161199, 7105.25394833535, 7240.094988126379, 7241.094863142107, 6578.76974305897, 6598.1422415085735, 6608.70260838273, 6615.801525954229, 6619.0, 8046.074701409413, 8113.5131892086665, 8122.0, 8243.711470098518, 8270.793230169294, 8129.309008734087, 8343.66625335004, 8462.407631465738, 8467.110953350057, 8498.1501849817, 6394.200724909387, 6440.581362211441, 6477.77327793525, 6488.9026664601015, 6496.935030649822, 6261.436470717657, 6850.143732033496, 6967.233604303624, 7046.330598593126, 7067.25793791665, 6700.564463309869, 6752.08846805675, 6782.932170678428, 6850.794476165723, 6868.0, 6480.837979050561, 6539.738410463528, 6597.571157874723, 6606.6036037837885, 6717.1267735194115, 6248.156498872594, 6277.340879207617, 6301.117843501822, 6302.71637776292, 6319.210098737658, 6301.96849015752, 6339.936600633934, 6348.0, 6351.0, 6353.52348573868, 6244.46922011616, 6373.87252254943, 6385.553011289351, 6401.839954001187, 6414.5189110815945], "unit": "score", "name": "mootools.html", "value": 4332.021893110901}, {"lowerIsBetter": false, "replicates": [313.64714695967035, 334.97320214382853, 335.79180907837116, 340.3176630855135, 343.7610860451987, 5861.824145275643, 5864.1203819427055, 5869.647821130735, 5904.409559044098, 5929.110633404992, 5554.389017208104, 5653.462921022507, 5668.716564171796, 5798.391168927265, 5833.795817146401, 4520.050789334244, 4554.43069616298, 4567.337736028274, 4581.266997280436, 4586.72479651222, 4302.182585308797, 4552.180607490651, 4581.908361832761, 4583.587477127058, 4585.426821647294, 4412.735235885857, 4484.843030493933, 4493.640508759291, 4506.97746511267, 4526.6831321807485, 4524.592786649201, 4544.590986811169, 4550.317452382136, 4551.590356867898, 4562.8631141065825, 3973.562908080109, 3977.880663580097, 3978.264021156095, 4001.199760048002, 4012.25773231953, 5533.363663178746, 5627.831165065055, 5637.746301416446, 5676.3188417389765, 5679.687617181054, 5275.182346736262, 5284.2866213061125, 5285.709285989269, 5287.735613219362, 5290.867728306785, 6249.437550620466, 6251.937480625181, 6254.8123556293385, 6258.624482531062, 6259.624422534663, 4435.977820110911, 4439.889002774924, 4441.511433742286, 4441.75570343631, 4442.444694413199, 6353.205849268841, 6521.543491955565, 6521.739130434777, 6533.705983230719, 6543.149390579194, 4523.932141017887, 4531.750753708578, 4531.932021019687, 4532.048269863366, 4532.818687252539, 4591.471980722193, 4593.839215627437, 4595.885102872455, 4596.2416201326405, 4597.862064138081, 5261.815836445706, 5262.289590905179, 5262.315898933114, 5264.447233040552, 5276.657017293864, 6129.417705317987, 6293.905591416133, 6295.276043254993, 6305.621662700161, 6322.683865806691, 1604.9277782499817, 1626.1950334584456, 1626.7966504186977, 1627.3897288516807, 1627.4710719016366, 1047.4396198034167, 1089.983650245247, 1095.1567293184203, 1098.4068602954314, 1113.7104352868312, 5887.587868849139, 5924.911126333022, 5926.4666180044005, 5931.169636250928, 5942.673152976541, 6462.7738029169695, 6466.35336466359, 6477.4170324671, 6478.578892371981, 6486.416222539994, 5712.171735098387, 5804.738786754606, 5805.448482394166, 5822.592418530747, 5824.446677565709, 3451.6548345165284, 3472.68745812873, 3489.267253876714, 3498.7201023918024, 3518.2435776308216, 6719.731210751515, 6734.158230221223, 6737.056812046318, 6769.086173366631, 6780.050792888901, 6495.837604059841, 6677.265500795006, 6701.525664353834, 6702.396784289437, 6704.497162712816, 6791.796246112525, 6792.184937807495, 6796.796096117125, 6801.421879140328, 6810.31896810315, 6601.801945941629, 6626.039224312544, 6631.933680663132, 6632.436242919406, 6638.103855979381, 6369.745210191726, 6462.903056454251, 6463.709133089116, 6468.256150542559, 6481.935180648322, 6759.493038022069, 6774.051632771515, 6774.42417394527, 6781.728730850711, 6791.72833086671, 4362.585554372329, 4387.341898715218, 4387.648988080882, 4391.187630288407, 4393.7363758174615, 6418.646974416265, 6535.117759102651, 6554.967225164034, 6563.343665633399, 6573.211214654272, 6337.302896681454, 6340.1440805490665, 6344.302126766144, 6346.841328966812, 6348.269948955929, 6328.335524769833, 6331.841703957438, 6336.398042185985, 6341.651209183355, 6343.143675603919, 6121.571489995836, 6183.907241391293, 6210.5652604317265, 6223.190985171898, 6225.906611400742, 6341.841453963688, 6345.206849143857, 6350.682465876595, 6355.777547785805, 6356.968215158895, 6161.938380616316, 6177.96911015442, 6178.752849885954, 6180.196574445294, 6180.969095154495], "unit": "score", "name": "prototype.html", "value": 4753.097370969808}, {"lowerIsBetter": false, "replicates": [700.8808502554566, 821.5194111444805, 831.305859607228, 839.2404873589402, 845.5898889038818, 12981.870181298184, 13056.673583160402, 13119.93440032801, 13157.079004469691, 13161.276129812857, 13073.280969546671, 13093.934530327359, 13130.212187268771, 13131.0, 13143.934280328585, 674.8211723893172, 682.8804959132157, 684.8698747238034, 808.870580707087, 820.1429506166071, 670.778643047793, 809.7611204694629, 826.7230477789948, 830.1366578758084, 834.253343257784, 863.313665635821, 867.9566021698889, 869.6347534035721, 870.0386073388909, 870.5342641686699, 707.8902770070647, 862.2756884217225, 862.6808081010004, 862.8274345130999, 863.2317237658489, 636.1634450697318, 643.6041834271936, 647.0746832030195, 648.0279580629057, 648.3419329380682, 12805.359732013361, 12825.422855971503, 12831.615051548468, 12857.164284321489, 12858.678533036655, 12465.875341246563, 12810.55163069288, 12923.0, 13303.86696133036, 13624.727505449835, 9684.75788105296, 9724.75688107796, 9815.607375704963, 9914.058164474363, 10270.89729102707, 3526.947095793565, 3627.129488922666, 3634.545681789776, 3652.1782598915033, 3659.8536058557893, 47481.28778068332, 47519.76240118777, 47633.0, 47661.285080723814, 47676.523234767556, 9681.0, 9990.30067895255, 10079.748006299755, 10369.533370998322, 10395.94802025985, 17750.20124094419, 17754.467365979042, 17784.91107544454, 17801.020943847954, 17810.19854106568, 7336.96331518339, 7500.849983000309, 7509.0, 7573.166951635316, 7590.468667193243, 4262.936055959163, 4326.545712700121, 4362.039327908094, 4411.448568928884, 4455.6658250631335, 3133.4046531159006, 3151.385479831457, 3153.0225630054756, 3160.225744692565, 3162.304293055524, 554.1742803223168, 560.3108176942302, 560.938296787353, 571.245955338957, 571.6312978129083, 457.6476113392669, 480.84372578911996, 545.4490964126261, 606.7300051477139, 613.3988691082764, 7908.248716371935, 8325.625346859406, 8443.0, 8656.740297791077, 8739.563021848882, 531.7447625139954, 536.9919451208235, 598.7096258314714, 675.3955210087042, 718.3032458515232, 3715.5169827922196, 3850.537935447764, 3900.531936167621, 4013.4581831452965, 4150.439690641785, 50585.747071264406, 50646.74676626667, 50894.0, 51590.74204628953, 51602.48397516052, 46652.0, 47033.76483117631, 47451.762741186074, 47468.287975680396, 48107.75946120247, 42883.85580720951, 42897.35653965193, 43042.569574304485, 43210.351844722354, 43546.56453435425, 7625.389968802593, 7684.884726729216, 7741.0, 7866.270416113026, 7902.723404680809, 32735.181620458727, 32753.0, 33478.16304592405, 33484.66515334913, 33738.83130584331, 37450.43824342582, 37555.81222093872, 40086.39654413791, 40664.39003414892, 40772.592274078066, 9576.138147566753, 9791.069848364394, 10020.498975051072, 10066.49667516636, 10267.486625668836, 11128.721781955515, 11135.944320278346, 11300.434978251218, 11523.481443334902, 11607.593734219261, 10089.394636321844, 10117.19062475015, 10234.744131396477, 10347.12049475803, 10483.37099774016, 10378.844317335397, 10409.791804163722, 10477.214208934512, 10773.569057237935, 10798.514066866852, 10287.897121028993, 10449.05958463742, 10498.737531561772, 10525.89474105249, 10551.94724026375, 7541.5475071495885, 7601.7719468416035, 7609.391248700202, 7827.765167044998, 8017.278444939983, 7364.3003914628025, 7603.7338693145475, 7891.0, 8830.205281524693, 9681.66114186], "unit": "score", "name": "yui.html", "value": 6005.914795734414}], "name": "dromaeo_css", "value": 6810.73479657916}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 107.0, 111.0, 113.0, 111.0, 103.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [157.0, 128.0, 149.0, 164.0, 126.0, 165.0, 151.0, 126.0, 171.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 162.0, 160.0, 164.0, 163.0, 159.0, 163.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 117.0, 94.0, 73.0, 73.0, 74.0, 105.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 146.0, 94.0, 95.0, 94.0, 138.0, 95.0, 96.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 114.8}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 57.0, 56.0, 55.0, 56.0, 64.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [66.0, 72.0, 66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 89.0, 85.0, 86.0, 86.0, 85.0, 85.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [121.0, 132.0, 119.0, 118.0, 122.0, 124.0, 121.0, 119.0, 121.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.1}, {"lowerIsBetter": true, "replicates": [154.0, 144.0, 152.0, 149.0, 153.0, 140.0, 151.0, 149.0, 149.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.1}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 70.0, 69.0, 69.0, 69.0, 67.0, 70.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1515.6999999999994}]} 05:20:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1515.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6810.73"}}} 05:20:48 INFO - Return code: 0 05:20:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:20:48 INFO - # TBPL SUCCESS # 05:20:48 INFO - Running post-action listener: _resource_record_post_action 05:20:48 INFO - Running post-run listener: _resource_record_post_run 05:20:49 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527347712; Read time: 24; Write time: 479572 05:20:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 239927296; Read time: 0; Write time: 262156 05:20:49 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287240192; Read time: 24; Write time: 217396 05:20:49 INFO - Running post-run listener: _upload_blobber_files 05:20:49 INFO - Blob upload gear active. 05:20:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:20:49 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 05:20:49 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'] 05:20:49 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 05:20:50 INFO - (blobuploader) - INFO - Open directory for files ... 05:20:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:20:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:20:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:51 INFO - (blobuploader) - INFO - Done attempting. 05:20:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:20:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:20:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:51 INFO - (blobuploader) - INFO - Done attempting. 05:20:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:20:51 INFO - Return code: 0 05:20:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:20:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:20:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e2aedb28cea7e0543b4c038e7014cf507391a48215566857d6ec86735fcc04c050ae0a0cc7b6d5bc90990466c494a54fddc94c483eacbaae047f191058b241a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82911989c675e91156c93838f6ac69c49def8b3b0892e299c5db29bd55310a94c738f259debf9d178ce173fa6f143031265264d33b0421ff332ab0fbf8e5bb80"} 05:20:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:20:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:20:51 INFO - Contents: 05:20:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e2aedb28cea7e0543b4c038e7014cf507391a48215566857d6ec86735fcc04c050ae0a0cc7b6d5bc90990466c494a54fddc94c483eacbaae047f191058b241a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82911989c675e91156c93838f6ac69c49def8b3b0892e299c5db29bd55310a94c738f259debf9d178ce173fa6f143031265264d33b0421ff332ab0fbf8e5bb80"} 05:20:51 INFO - Running post-run listener: copy_logs_to_upload_dir 05:20:51 INFO - Copying logs to upload dir... 05:20:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:20:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.528668 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-10 05:20:51.876454) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 05:20:51.879605) ========= 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=32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493 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/8e2aedb28cea7e0543b4c038e7014cf507391a48215566857d6ec86735fcc04c050ae0a0cc7b6d5bc90990466c494a54fddc94c483eacbaae047f191058b241a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82911989c675e91156c93838f6ac69c49def8b3b0892e299c5db29bd55310a94c738f259debf9d178ce173fa6f143031265264d33b0421ff332ab0fbf8e5bb80"} build_url:https://queue.taskcluster.net/v1/task/TqtimH7TQW2QGHgzKBsGBQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011564 build_url: 'https://queue.taskcluster.net/v1/task/TqtimH7TQW2QGHgzKBsGBQ/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/8e2aedb28cea7e0543b4c038e7014cf507391a48215566857d6ec86735fcc04c050ae0a0cc7b6d5bc90990466c494a54fddc94c483eacbaae047f191058b241a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82911989c675e91156c93838f6ac69c49def8b3b0892e299c5db29bd55310a94c738f259debf9d178ce173fa6f143031265264d33b0421ff332ab0fbf8e5bb80"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 05:20:51.904301) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 05:20:51.904626) ========= 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=32c5991c409366f7fec8a718000001d2-1455109045.821901-372151493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004694 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 05:20:51.987927) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 05:20:51.988261) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 05:20:51.988552) ========= ========= Total master_lag: 0.27 =========