builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1453902709.67 results: success (0) buildid: 20160127030236 builduid: ebeb34cc0baf471190663de777353d6d revision: 211a4c710fb6af2cad10102c4cabc7cb525998b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:49.669017) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:49.669454) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:49.669736) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006455 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:49.697643) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:49.697959) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:49.729498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:49.730121) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:49.783920) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:49.784217) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:49.784602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:49.784873) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-27 05:51:50-- 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% 83.7M=0s 2016-01-27 05:51:50 (83.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149422 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:49.948084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:49.948366) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014121 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:50.002210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:50.002579) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 211a4c710fb6af2cad10102c4cabc7cb525998b8 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 211a4c710fb6af2cad10102c4cabc7cb525998b8 --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=5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-27 05:51:50,421 truncating revision to first 12 chars 2016-01-27 05:51:50,421 Setting DEBUG logging. 2016-01-27 05:51:50,421 attempt 1/10 2016-01-27 05:51:50,421 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/211a4c710fb6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-27 05:51:50,683 unpacking tar archive at: mozilla-central-211a4c710fb6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540137 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:50.562424) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:50.565775) ========= echo 211a4c710fb6af2cad10102c4cabc7cb525998b8 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'211a4c710fb6af2cad10102c4cabc7cb525998b8'] 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=5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 211a4c710fb6af2cad10102c4cabc7cb525998b8 program finished with exit code 0 elapsedTime=0.004722 script_repo_revision: '211a4c710fb6af2cad10102c4cabc7cb525998b8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:50.618279) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:50.618604) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 05:51:50.634945) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-27 05:51:50.635217) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:51:51 INFO - MultiFileLogger online at 20160127 05:51:51 in /builds/slave/test-pgo 05:51:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:51:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:51:51 INFO - {'append_to_log': False, 05:51:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:51:51 INFO - 'blob_upload_branch': 'Firefox', 05:51:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:51:51 INFO - 'branch': 'Firefox', 05:51:51 INFO - 'buildbot_json_path': 'buildprops.json', 05:51:51 INFO - 'config_files': ('talos/linux_config.py',), 05:51:51 INFO - 'default_actions': ('clobber', 05:51:51 INFO - 'read-buildbot-config', 05:51:51 INFO - 'download-and-extract', 05:51:51 INFO - 'populate-webroot', 05:51:51 INFO - 'create-virtualenv', 05:51:51 INFO - 'install', 05:51:51 INFO - 'run-tests'), 05:51:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:51:51 INFO - 'download_minidump_stackwalk': True, 05:51:51 INFO - 'download_symbols': 'ondemand', 05:51:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:51:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:51:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:51:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:51:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:51:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:51:51 INFO - 'installer_path': 'installer.exe', 05:51:51 INFO - 'log_level': 'info', 05:51:51 INFO - 'log_name': 'talos', 05:51:51 INFO - 'log_to_console': True, 05:51:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:51:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:51:51 INFO - 'opt_config_files': (), 05:51:51 INFO - 'pip_index': False, 05:51:51 INFO - 'sps_profile': False, 05:51:51 INFO - 'sps_profile_interval': 0, 05:51:51 INFO - 'suite': 'dromaeojs-e10s', 05:51:51 INFO - 'system_bits': '32', 05:51:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:51:51 INFO - 'title': 'talos-linux64-ix-039', 05:51:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:51:51 INFO - 'use_talos_json': True, 05:51:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:51:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:51:51 INFO - 'work_dir': 'build'} 05:51:51 INFO - ##### 05:51:51 INFO - ##### Running clobber step. 05:51:51 INFO - ##### 05:51:51 INFO - Running pre-action listener: _resource_record_pre_action 05:51:51 INFO - Running main action method: clobber 05:51:51 INFO - rmtree: /builds/slave/test-pgo/build 05:51:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:51:51 INFO - Running post-action listener: _resource_record_post_action 05:51:51 INFO - ##### 05:51:51 INFO - ##### Running read-buildbot-config step. 05:51:51 INFO - ##### 05:51:51 INFO - Running pre-action listener: _resource_record_pre_action 05:51:51 INFO - Running main action method: read_buildbot_config 05:51:51 INFO - Using buildbot properties: 05:51:51 INFO - { 05:51:51 INFO - "project": "", 05:51:51 INFO - "product": "firefox", 05:51:51 INFO - "script_repo_revision": "production", 05:51:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:51:51 INFO - "repository": "", 05:51:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:51:51 INFO - "buildid": "20160127030236", 05:51:51 INFO - "stage_platform": "linux64-pgo", 05:51:51 INFO - "basedir": "/builds/slave/test-pgo", 05:51:51 INFO - "nightly_build": "True", 05:51:51 INFO - "buildnumber": 332, 05:51:51 INFO - "slavename": "talos-linux64-ix-039", 05:51:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:51:51 INFO - "platform": "ubuntu64_hw", 05:51:51 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:51:51 INFO - "branch": "mozilla-central", 05:51:51 INFO - "repo_path": "mozilla-central", 05:51:51 INFO - "revision": "211a4c710fb6af2cad10102c4cabc7cb525998b8", 05:51:51 INFO - "pgo_build": "True", 05:51:51 INFO - "builduid": "ebeb34cc0baf471190663de777353d6d", 05:51:51 INFO - "slavebuilddir": "test" 05:51:51 INFO - } 05:51:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:51:51 INFO - Running post-action listener: _resource_record_post_action 05:51:51 INFO - ##### 05:51:51 INFO - ##### Running download-and-extract step. 05:51:51 INFO - ##### 05:51:51 INFO - Running pre-action listener: _resource_record_pre_action 05:51:51 INFO - Running main action method: download_and_extract 05:51:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:51:51 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:51:51 INFO - https://queue.taskcluster.net/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:51:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/test_packages.json 05:51:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/test_packages.json 05:51:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:51:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:51:59 INFO - Downloaded 1448 bytes. 05:51:59 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:51:59 INFO - Using the following test package requirements: 05:51:59 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:51:59 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:51:59 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:51:59 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:59 INFO - u'jsshell-linux-x86_64.zip'], 05:51:59 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:51:59 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:51:59 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:51:59 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:51:59 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:51:59 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:51:59 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:59 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:51:59 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:59 INFO - https://queue.taskcluster.net/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:51:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:51:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:51:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/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:51:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/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:52:09 INFO - Downloaded 22503291 bytes. 05:52:09 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:52:09 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:52:10 INFO - Return code: 0 05:52:10 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:52:10 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:52:10 INFO - https://queue.taskcluster.net/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:52:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:52:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:52:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/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:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/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:52:12 INFO - Downloaded 22503291 bytes. 05:52:12 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:52:12 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:52:13 INFO - Return code: 0 05:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:13 INFO - https://queue.taskcluster.net/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:52:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/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:52:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/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:52:14 INFO - Downloaded 10706572 bytes. 05:52:14 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:52:14 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:52:14 INFO - Return code: 0 05:52: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:52:14 INFO - https://queue.taskcluster.net/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:52:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:52:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:52:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/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:52:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_IB7BHDQWeRLwToxUY1KQ/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:52:15 INFO - Downloaded 55975800 bytes. 05:52:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:52:15 INFO - mkdir: /builds/slave/test-pgo/properties 05:52:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:52:15 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:52:15 INFO - Contents: 05:52:15 INFO - build_url:https://queue.taskcluster.net/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:52:15 INFO - Running post-action listener: _resource_record_post_action 05:52:15 INFO - Running post-action listener: set_extra_try_arguments 05:52:15 INFO - ##### 05:52:15 INFO - ##### Running populate-webroot step. 05:52:15 INFO - ##### 05:52:15 INFO - Running pre-action listener: _resource_record_pre_action 05:52:15 INFO - Running main action method: populate_webroot 05:52:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:15 INFO - '--tppagecycles', 05:52:15 INFO - '7'], 05:52:15 INFO - 'tests': ['tsvgm']}}, 05:52:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:52:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:52:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:52:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:52:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:52:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:15 INFO - 'talos_options': ['--e10s'], 05:52:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:15 INFO - 'tests': ['damp', 'tps']}, 05:52:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:15 INFO - 'talos_options': ['--e10s'], 05:52:15 INFO - 'tests': ['damp', 'tps']}, 05:52:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:52:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:15 INFO - 'other': {'tests': ['a11yr', 05:52:15 INFO - 'ts_paint', 05:52:15 INFO - 'tpaint', 05:52:15 INFO - 'sessionrestore', 05:52:15 INFO - 'sessionrestore_no_auto_restore']}, 05:52:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:52:15 INFO - 'tests': ['a11yr', 05:52:15 INFO - 'ts_paint', 05:52:15 INFO - 'tpaint', 05:52:15 INFO - 'sessionrestore', 05:52:15 INFO - 'sessionrestore_no_auto_restore']}, 05:52:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:52:15 INFO - 'tests': ['a11yr', 05:52:15 INFO - 'ts_paint', 05:52:15 INFO - 'tpaint', 05:52:15 INFO - 'sessionrestore', 05:52:15 INFO - 'sessionrestore_no_auto_restore']}, 05:52:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:52:15 INFO - 'tests': ['a11yr', 05:52:15 INFO - 'ts_paint', 05:52:15 INFO - 'tpaint', 05:52:15 INFO - 'sessionrestore', 05:52:15 INFO - 'sessionrestore_no_auto_restore']}, 05:52:15 INFO - 'other_l64': {'tests': ['a11yr', 05:52:15 INFO - 'ts_paint', 05:52:15 INFO - 'tpaint', 05:52:15 INFO - 'sessionrestore', 05:52:15 INFO - 'sessionrestore_no_auto_restore']}, 05:52:15 INFO - 'other_nol64': {'tests': ['a11yr', 05:52:15 INFO - 'ts_paint', 05:52:15 INFO - 'tpaint', 05:52:15 INFO - 'sessionrestore', 05:52:15 INFO - 'sessionrestore_no_auto_restore']}, 05:52:15 INFO - 'svgr': {'tests': ['tsvgx', 05:52:15 INFO - 'tsvgr_opacity', 05:52:15 INFO - 'tart', 05:52:15 INFO - 'tscrollx', 05:52:15 INFO - 'cart']}, 05:52:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:52:15 INFO - 'tests': ['tsvgx', 05:52:15 INFO - 'tsvgr_opacity', 05:52:15 INFO - 'tart', 05:52:15 INFO - 'tscrollx', 05:52:15 INFO - 'cart']}, 05:52:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:15 INFO - 'tests': ['tp5o']}, 05:52:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:15 INFO - 'talos_options': ['--e10s'], 05:52:15 INFO - 'tests': ['tp5o']}, 05:52:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:15 INFO - 'talos_options': ['--xperf_path', 05:52:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:15 INFO - 'tests': ['tp5n']}, 05:52:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:15 INFO - 'talos_options': ['--e10s', 05:52:15 INFO - '--xperf_path', 05:52:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:15 INFO - 'tests': ['tp5n']}}, 05:52:15 INFO - 'talos.zip': {'path': '', 05:52:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:15 INFO - Running post-action listener: _resource_record_post_action 05:52:15 INFO - ##### 05:52:15 INFO - ##### Running create-virtualenv step. 05:52:15 INFO - ##### 05:52:15 INFO - Running pre-action listener: _resource_record_pre_action 05:52:15 INFO - Running main action method: create_virtualenv 05:52:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:52:15 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:52:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:52:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:15 INFO - Using real prefix '/usr' 05:52:15 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:52:16 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:18 INFO - Installing pip.................done. 05:52:18 INFO - Return code: 0 05:52:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:18 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 0x7f771ec3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e19480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8660>, '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 0x1ea9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', '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:52:18 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:52:18 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:52:18 INFO - Using env: {'DISPLAY': ':0', 05:52:18 INFO - 'HOME': '/home/cltbld', 05:52:18 INFO - 'LANG': 'en_US.UTF-8', 05:52:18 INFO - 'LANGUAGE': 'en_US:en', 05:52:18 INFO - 'LOGNAME': 'cltbld', 05:52:18 INFO - 'MAIL': '/var/mail/cltbld', 05:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:18 INFO - 'MOZ_NO_REMOTE': '1', 05:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:18 INFO - 'NO_EM_RESTART': '1', 05:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:18 INFO - 'SHELL': '/bin/bash', 05:52:18 INFO - 'SHLVL': '1', 05:52:18 INFO - 'TERM': 'linux', 05:52:18 INFO - 'TMOUT': '86400', 05:52:18 INFO - 'USER': 'cltbld', 05:52:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', 05:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:18 INFO - '_': '/tools/buildbot/bin/python'} 05:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:18 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:52:18 INFO - Cleaning up... 05:52:18 INFO - Return code: 0 05:52:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:18 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 0x7f771ec3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e19480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8660>, '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 0x1ea9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', '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:52:18 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:52:18 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:52:18 INFO - Using env: {'DISPLAY': ':0', 05:52:18 INFO - 'HOME': '/home/cltbld', 05:52:18 INFO - 'LANG': 'en_US.UTF-8', 05:52:18 INFO - 'LANGUAGE': 'en_US:en', 05:52:18 INFO - 'LOGNAME': 'cltbld', 05:52:18 INFO - 'MAIL': '/var/mail/cltbld', 05:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:18 INFO - 'MOZ_NO_REMOTE': '1', 05:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:18 INFO - 'NO_EM_RESTART': '1', 05:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:18 INFO - 'SHELL': '/bin/bash', 05:52:18 INFO - 'SHLVL': '1', 05:52:18 INFO - 'TERM': 'linux', 05:52:18 INFO - 'TMOUT': '86400', 05:52:18 INFO - 'USER': 'cltbld', 05:52:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', 05:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:18 INFO - '_': '/tools/buildbot/bin/python'} 05:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:18 INFO - Downloading/unpacking psutil>=0.7.1 05:52:18 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:52:18 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:52:18 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:52:18 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:52:18 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:52:18 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:52:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:20 INFO - Installing collected packages: psutil 05:52:20 INFO - Running setup.py install for psutil 05:52:20 INFO - building 'psutil._psutil_linux' extension 05:52:20 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:52:20 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:52:20 INFO - building 'psutil._psutil_posix' extension 05:52:20 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:52:21 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:52:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:21 INFO - Successfully installed psutil 05:52:21 INFO - Cleaning up... 05:52:21 INFO - Return code: 0 05:52:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:52:21 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:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:21 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:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:21 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 0x7f771ec3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e19480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8660>, '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 0x1ea9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', '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:52:21 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:52:21 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:52:21 INFO - Using env: {'DISPLAY': ':0', 05:52:21 INFO - 'HOME': '/home/cltbld', 05:52:21 INFO - 'LANG': 'en_US.UTF-8', 05:52:21 INFO - 'LANGUAGE': 'en_US:en', 05:52:21 INFO - 'LOGNAME': 'cltbld', 05:52:21 INFO - 'MAIL': '/var/mail/cltbld', 05:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:21 INFO - 'MOZ_NO_REMOTE': '1', 05:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:21 INFO - 'NO_EM_RESTART': '1', 05:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:21 INFO - 'SHELL': '/bin/bash', 05:52:21 INFO - 'SHLVL': '1', 05:52:21 INFO - 'TERM': 'linux', 05:52:21 INFO - 'TMOUT': '86400', 05:52:21 INFO - 'USER': 'cltbld', 05:52:21 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', 05:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:21 INFO - '_': '/tools/buildbot/bin/python'} 05:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:52:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:23 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:52:23 INFO - Installing collected packages: mozsystemmonitor 05:52:23 INFO - Running setup.py install for mozsystemmonitor 05:52:23 INFO - Successfully installed mozsystemmonitor 05:52:23 INFO - Cleaning up... 05:52:23 INFO - Return code: 0 05:52:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:23 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 0x7f771ec3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e19480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8660>, '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 0x1ea9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', '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:52:23 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:52:23 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:52:23 INFO - Using env: {'DISPLAY': ':0', 05:52:23 INFO - 'HOME': '/home/cltbld', 05:52:23 INFO - 'LANG': 'en_US.UTF-8', 05:52:23 INFO - 'LANGUAGE': 'en_US:en', 05:52:23 INFO - 'LOGNAME': 'cltbld', 05:52:23 INFO - 'MAIL': '/var/mail/cltbld', 05:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:23 INFO - 'MOZ_NO_REMOTE': '1', 05:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:23 INFO - 'NO_EM_RESTART': '1', 05:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:23 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:23 INFO - 'SHELL': '/bin/bash', 05:52:23 INFO - 'SHLVL': '1', 05:52:23 INFO - 'TERM': 'linux', 05:52:23 INFO - 'TMOUT': '86400', 05:52:23 INFO - 'USER': 'cltbld', 05:52:23 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', 05:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:23 INFO - '_': '/tools/buildbot/bin/python'} 05:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:23 INFO - Downloading/unpacking blobuploader==1.2.4 05:52:23 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:52:23 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:52:23 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:52:23 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:52:23 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:52:23 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:52:25 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52:25 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:52:25 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:52:25 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:52:25 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:52:25 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:52:25 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:52:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:52:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52:25 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:52:25 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:52:25 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:52:25 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:52:25 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:52:25 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:52:26 INFO - Downloading docopt-0.6.1.tar.gz 05:52:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:26 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:26 INFO - Running setup.py install for blobuploader 05:52:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:52:26 INFO - Running setup.py install for requests 05:52:26 INFO - Running setup.py install for docopt 05:52:26 INFO - Successfully installed blobuploader requests docopt 05:52:26 INFO - Cleaning up... 05:52:26 INFO - Return code: 0 05:52:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:26 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 0x7f771ec3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e19480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8660>, '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 0x1ea9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', '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:52:26 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:52:26 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:52:26 INFO - Using env: {'DISPLAY': ':0', 05:52:26 INFO - 'HOME': '/home/cltbld', 05:52:26 INFO - 'LANG': 'en_US.UTF-8', 05:52:26 INFO - 'LANGUAGE': 'en_US:en', 05:52:26 INFO - 'LOGNAME': 'cltbld', 05:52:26 INFO - 'MAIL': '/var/mail/cltbld', 05:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:26 INFO - 'MOZ_NO_REMOTE': '1', 05:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:26 INFO - 'NO_EM_RESTART': '1', 05:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:26 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:26 INFO - 'SHELL': '/bin/bash', 05:52:26 INFO - 'SHLVL': '1', 05:52:26 INFO - 'TERM': 'linux', 05:52:26 INFO - 'TMOUT': '86400', 05:52:26 INFO - 'USER': 'cltbld', 05:52:26 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', 05:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:26 INFO - '_': '/tools/buildbot/bin/python'} 05:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:26 INFO - Running setup.py (path:/tmp/pip-2YCPTc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:26 INFO - Running setup.py (path:/tmp/pip-TwS8mm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:27 INFO - Running setup.py (path:/tmp/pip-RfzNsR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:27 INFO - Running setup.py (path:/tmp/pip-XCVm6Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:52:27 INFO - Running setup.py (path:/tmp/pip-02DuoK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:52:27 INFO - Running setup.py (path:/tmp/pip-qXNgto-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:52:27 INFO - Running setup.py (path:/tmp/pip-N1suIT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:52:27 INFO - Running setup.py (path:/tmp/pip-0KAOkV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:52:27 INFO - Running setup.py (path:/tmp/pip-E7nsYr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:52:27 INFO - Running setup.py (path:/tmp/pip-z84fcR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:52:27 INFO - Running setup.py (path:/tmp/pip-Ury7r6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:52:27 INFO - Running setup.py (path:/tmp/pip-zUIJyx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:52:27 INFO - Running setup.py (path:/tmp/pip-eqBpIn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:52:27 INFO - Running setup.py (path:/tmp/pip-nTUZRG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:52:27 INFO - Running setup.py (path:/tmp/pip-Us6011-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:52:27 INFO - Running setup.py (path:/tmp/pip-qphpF4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:52:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:52:28 INFO - Running setup.py (path:/tmp/pip-di0cQX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:52:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:28 INFO - Running setup.py install for manifestparser 05:52:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:52:28 INFO - Running setup.py install for mozcrash 05:52:28 INFO - Running setup.py install for mozdebug 05:52:28 INFO - Running setup.py install for mozdevice 05:52:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:52:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:52:28 INFO - Running setup.py install for mozfile 05:52:28 INFO - Running setup.py install for mozhttpd 05:52:28 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:52:28 INFO - Running setup.py install for mozinfo 05:52:28 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:52:28 INFO - Running setup.py install for mozInstall 05:52:28 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:52:28 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:52:28 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:52:28 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:52:28 INFO - Running setup.py install for mozleak 05:52:29 INFO - Running setup.py install for mozlog 05:52:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:52:29 INFO - Running setup.py install for moznetwork 05:52:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:52:29 INFO - Running setup.py install for mozprocess 05:52:29 INFO - Running setup.py install for mozprofile 05:52:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:52:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:52:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:52:29 INFO - Running setup.py install for mozrunner 05:52:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:52:29 INFO - Running setup.py install for mozscreenshot 05:52:29 INFO - Running setup.py install for moztest 05:52:29 INFO - Running setup.py install for mozversion 05:52:29 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:52:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:29 INFO - Cleaning up... 05:52:29 INFO - Return code: 0 05:52:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:52: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:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:29 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 0x7f771ec3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e19480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8660>, '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 0x1ea9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', '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:52:29 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:52:29 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:52:29 INFO - Using env: {'DISPLAY': ':0', 05:52:29 INFO - 'HOME': '/home/cltbld', 05:52:29 INFO - 'LANG': 'en_US.UTF-8', 05:52:29 INFO - 'LANGUAGE': 'en_US:en', 05:52:29 INFO - 'LOGNAME': 'cltbld', 05:52:29 INFO - 'MAIL': '/var/mail/cltbld', 05:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:29 INFO - 'MOZ_NO_REMOTE': '1', 05:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:29 INFO - 'NO_EM_RESTART': '1', 05:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:29 INFO - 'SHELL': '/bin/bash', 05:52:29 INFO - 'SHLVL': '1', 05:52:29 INFO - 'TERM': 'linux', 05:52:29 INFO - 'TMOUT': '86400', 05:52:29 INFO - 'USER': 'cltbld', 05:52:29 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', 05:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:29 INFO - '_': '/tools/buildbot/bin/python'} 05:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:30 INFO - Running setup.py (path:/tmp/pip-R5HJyR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:30 INFO - Running setup.py (path:/tmp/pip-PHd0pu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:30 INFO - Running setup.py (path:/tmp/pip-W77gaf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:30 INFO - Running setup.py (path:/tmp/pip-6CJrd7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:52:30 INFO - Running setup.py (path:/tmp/pip-r5tXTd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:52:30 INFO - Running setup.py (path:/tmp/pip-75ej6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:52:30 INFO - Running setup.py (path:/tmp/pip-VxbS3S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:52:30 INFO - Running setup.py (path:/tmp/pip-zgZxYF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:52:30 INFO - Running setup.py (path:/tmp/pip-HI2SI6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:52:30 INFO - Running setup.py (path:/tmp/pip-TObFnb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:52:30 INFO - Running setup.py (path:/tmp/pip-UWK69D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:52:30 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:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:52:30 INFO - Running setup.py (path:/tmp/pip-jO54uz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:52:31 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:52:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:52:31 INFO - Running setup.py (path:/tmp/pip-jbV_Jd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:52:31 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:52:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:52:31 INFO - Running setup.py (path:/tmp/pip-4qVpLB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:52:31 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:52:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:52:31 INFO - Running setup.py (path:/tmp/pip-38tYq6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:52:31 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:52:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:52:31 INFO - Running setup.py (path:/tmp/pip-Udnfro-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:52:31 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:52:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:52:31 INFO - Running setup.py (path:/tmp/pip-o_uZhu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:33 INFO - Downloading blessings-1.6.tar.gz 05:52:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:33 INFO - Installing collected packages: blessings 05:52:33 INFO - Running setup.py install for blessings 05:52:33 INFO - Successfully installed blessings 05:52:33 INFO - Cleaning up... 05:52:33 INFO - Return code: 0 05:52:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:52:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:52:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:52:33 INFO - Reading from file tmpfile_stdout 05:52:33 INFO - Current package versions: 05:52:33 INFO - argparse == 1.2.1 05:52:33 INFO - blessings == 1.6 05:52:33 INFO - blobuploader == 1.2.4 05:52:33 INFO - docopt == 0.6.1 05:52:33 INFO - manifestparser == 1.1 05:52:33 INFO - mozInstall == 1.12 05:52:33 INFO - mozcrash == 0.16 05:52:33 INFO - mozdebug == 0.1 05:52:33 INFO - mozdevice == 0.48 05:52:33 INFO - mozfile == 1.2 05:52:33 INFO - mozhttpd == 0.7 05:52:33 INFO - mozinfo == 0.9 05:52:33 INFO - mozleak == 0.1 05:52:33 INFO - mozlog == 3.1 05:52:33 INFO - moznetwork == 0.27 05:52:33 INFO - mozprocess == 0.22 05:52:33 INFO - mozprofile == 0.28 05:52:33 INFO - mozrunner == 6.11 05:52:33 INFO - mozscreenshot == 0.1 05:52:33 INFO - mozsystemmonitor == 0.0 05:52:33 INFO - moztest == 0.7 05:52:33 INFO - mozversion == 1.4 05:52:33 INFO - psutil == 3.1.1 05:52:33 INFO - requests == 1.2.3 05:52:33 INFO - wsgiref == 0.1.2 05:52:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:52: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:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:33 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 0x7f771ec3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e19480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8660>, '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 0x1ea9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', '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:52:33 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:52:33 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:52:33 INFO - Using env: {'DISPLAY': ':0', 05:52:33 INFO - 'HOME': '/home/cltbld', 05:52:33 INFO - 'LANG': 'en_US.UTF-8', 05:52:33 INFO - 'LANGUAGE': 'en_US:en', 05:52:33 INFO - 'LOGNAME': 'cltbld', 05:52:33 INFO - 'MAIL': '/var/mail/cltbld', 05:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:33 INFO - 'MOZ_NO_REMOTE': '1', 05:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:33 INFO - 'NO_EM_RESTART': '1', 05:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:33 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:33 INFO - 'SHELL': '/bin/bash', 05:52:33 INFO - 'SHLVL': '1', 05:52:33 INFO - 'TERM': 'linux', 05:52:33 INFO - 'TMOUT': '86400', 05:52:33 INFO - 'USER': 'cltbld', 05:52:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', 05:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:33 INFO - '_': '/tools/buildbot/bin/python'} 05:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:33 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:52:33 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:52:33 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:52:33 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:52:33 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:52:33 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:52:33 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:52:33 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:52:33 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:52:33 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:52:33 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:52:33 INFO - Cleaning up... 05:52:33 INFO - Return code: 0 05:52:33 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:52: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:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:33 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 0x7f771ec3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e19480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8660>, '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 0x1ea9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', '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:52:33 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:52:33 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:52:33 INFO - Using env: {'DISPLAY': ':0', 05:52:33 INFO - 'HOME': '/home/cltbld', 05:52:33 INFO - 'LANG': 'en_US.UTF-8', 05:52:33 INFO - 'LANGUAGE': 'en_US:en', 05:52:33 INFO - 'LOGNAME': 'cltbld', 05:52:33 INFO - 'MAIL': '/var/mail/cltbld', 05:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:33 INFO - 'MOZ_NO_REMOTE': '1', 05:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:33 INFO - 'NO_EM_RESTART': '1', 05:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:33 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:33 INFO - 'SHELL': '/bin/bash', 05:52:33 INFO - 'SHLVL': '1', 05:52:33 INFO - 'TERM': 'linux', 05:52:33 INFO - 'TMOUT': '86400', 05:52:33 INFO - 'USER': 'cltbld', 05:52:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', 05:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:33 INFO - '_': '/tools/buildbot/bin/python'} 05:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:34 INFO - Downloading/unpacking jsonschema 05:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:52:35 INFO - Downloading/unpacking functools32 (from jsonschema) 05:52:35 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:52:35 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:52:35 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:52:35 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:52:35 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:52:35 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:52:35 INFO - Downloading functools32-3.2.3-2.tar.gz 05:52:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:52:36 INFO - warning: no files found matching '*.txt' 05:52:36 INFO - no previously-included directories found matching 'build' 05:52:36 INFO - no previously-included directories found matching 'dist' 05:52:36 INFO - no previously-included directories found matching '.git*' 05:52:36 INFO - Installing collected packages: jsonschema, functools32 05:52:36 INFO - Running setup.py install for functools32 05:52:36 INFO - warning: no files found matching '*.txt' 05:52:36 INFO - no previously-included directories found matching 'build' 05:52:36 INFO - no previously-included directories found matching 'dist' 05:52:36 INFO - no previously-included directories found matching '.git*' 05:52:36 INFO - Successfully installed jsonschema functools32 05:52:36 INFO - Cleaning up... 05:52:36 INFO - Return code: 0 05:52:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:36 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 0x7f771ec3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e19480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea8660>, '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 0x1ea9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', '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:52:36 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:52:36 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:52:36 INFO - Using env: {'DISPLAY': ':0', 05:52:36 INFO - 'HOME': '/home/cltbld', 05:52:36 INFO - 'LANG': 'en_US.UTF-8', 05:52:36 INFO - 'LANGUAGE': 'en_US:en', 05:52:36 INFO - 'LOGNAME': 'cltbld', 05:52:36 INFO - 'MAIL': '/var/mail/cltbld', 05:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:36 INFO - 'MOZ_NO_REMOTE': '1', 05:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:36 INFO - 'NO_EM_RESTART': '1', 05:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:36 INFO - 'SHELL': '/bin/bash', 05:52:36 INFO - 'SHLVL': '1', 05:52:36 INFO - 'TERM': 'linux', 05:52:36 INFO - 'TMOUT': '86400', 05:52:36 INFO - 'USER': 'cltbld', 05:52:36 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', 05:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:36 INFO - '_': '/tools/buildbot/bin/python'} 05:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:36 INFO - Downloading/unpacking flake8 05:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:52:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:52:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:52:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:52:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:52:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:52:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:52:38 INFO - no previously-included directories found matching 'docs/_build' 05:52:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:52:38 INFO - Running setup.py install for pep8 05:52:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:52:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:52:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:52:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:52:39 INFO - no previously-included directories found matching 'docs/_build' 05:52:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:52:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:52:39 INFO - Cleaning up... 05:52:39 INFO - Return code: 0 05:52:39 INFO - Running post-action listener: _resource_record_post_action 05:52:39 INFO - Running post-action listener: _start_resource_monitoring 05:52:39 INFO - Starting resource monitoring. 05:52:39 INFO - ##### 05:52:39 INFO - ##### Running install step. 05:52:39 INFO - ##### 05:52:39 INFO - Running pre-action listener: _resource_record_pre_action 05:52:39 INFO - Running main action method: install 05:52:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:52:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:52:39 INFO - Reading from file tmpfile_stdout 05:52:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:52:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:52:39 INFO - Reading from file tmpfile_stdout 05:52:39 INFO - Output received: 05:52:39 INFO - Usage: mozinstall [options] installer 05:52:39 INFO - Options: 05:52:39 INFO - -h, --help show this help message and exit 05:52:39 INFO - -d DEST, --destination=DEST 05:52:39 INFO - Directory to install application into. [default: 05:52:39 INFO - "/builds/slave/test-pgo"] 05:52:39 INFO - --app=APP Application being installed. [default: firefox] 05:52:39 INFO - mkdir: /builds/slave/test-pgo/build/application 05:52:39 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:52:39 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:52:55 INFO - Reading from file tmpfile_stdout 05:52:55 INFO - Output received: 05:52:55 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:52:55 INFO - Running post-action listener: _resource_record_post_action 05:52:55 INFO - ##### 05:52:55 INFO - ##### Running run-tests step. 05:52:55 INFO - ##### 05:52:55 INFO - Running pre-action listener: _resource_record_pre_action 05:52:55 INFO - Running main action method: run_tests 05:52:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:52:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:52:55 INFO - Python 2.7.3 05:52:55 INFO - Return code: 0 05:52:55 INFO - grabbing minidump binary from tooltool 05:52: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:52:55 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 0x1ea8660>, '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 0x1ea9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:52:55 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:52:55 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:52:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:52:55 INFO - Return code: 0 05:52:55 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:52:55 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:52:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:52:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:52:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:52:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:52:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:52:56 INFO - Return code: 0 05:52:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:52:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:52:56 INFO - Using env: {'DISPLAY': ':0', 05:52:56 INFO - 'HOME': '/home/cltbld', 05:52:56 INFO - 'LANG': 'en_US.UTF-8', 05:52:56 INFO - 'LANGUAGE': 'en_US:en', 05:52:56 INFO - 'LOGNAME': 'cltbld', 05:52:56 INFO - 'MAIL': '/var/mail/cltbld', 05:52:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:52:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:56 INFO - 'MOZ_NO_REMOTE': '1', 05:52:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:56 INFO - 'NO_EM_RESTART': '1', 05:52:56 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:56 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:52:56 INFO - 'SHELL': '/bin/bash', 05:52:56 INFO - 'SHLVL': '1', 05:52:56 INFO - 'TERM': 'linux', 05:52:56 INFO - 'TMOUT': '86400', 05:52:56 INFO - 'USER': 'cltbld', 05:52:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689', 05:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:56 INFO - '_': '/tools/buildbot/bin/python'} 05:52:56 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:52:56 INFO - mozversion application_buildid: 20160127030236 05:52:56 INFO - mozversion application_changeset: 211a4c710fb6af2cad10102c4cabc7cb525998b8 05:52:56 INFO - mozversion application_display_name: Nightly 05:52:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:52:56 INFO - mozversion application_name: Firefox 05:52:56 INFO - mozversion application_remotingname: firefox 05:52:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:52:56 INFO - mozversion application_vendor: Mozilla 05:52:56 INFO - mozversion application_version: 47.0a1 05:52:56 INFO - mozversion platform_buildid: 20160127030236 05:52:56 INFO - mozversion platform_changeset: 211a4c710fb6af2cad10102c4cabc7cb525998b8 05:52:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:52:56 INFO - mozversion platform_version: 47.0a1 05:52:56 INFO - using testdate: 1453902776 05:52:56 INFO - actual date: 1453902776 05:52:56 INFO - starting webserver on 'localhost:39423' 05:52:56 INFO - SUITE-START | Running 3 tests 05:52:56 INFO - TEST-START | dromaeo_css 05:52:56 INFO - operating with platform_type : linux_ 05:52:56 INFO - Initialising browser for dromaeo_css test... 05:52:56 INFO - TEST-INFO | started process 32570 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnxq_fF/profile http://localhost:39423/getInfo.html) 05:53:00 INFO - PROCESS | 32570 | 05:53:00 INFO - PROCESS | 32570 | (process:32654): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:53:01 INFO - PROCESS | 32570 | __metrics Screen width/height:1600/1200 05:53:01 INFO - PROCESS | 32570 | colorDepth:24 05:53:01 INFO - PROCESS | 32570 | Browser inner width/height: 1024/697 05:53:01 INFO - PROCESS | 32570 | __metrics 05:53:01 INFO - PROCESS | 32570 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:53:02 INFO - TEST-INFO | 32570: exit 0 05:53:02 INFO - Browser initialized. 05:53:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:02 INFO - TEST-INFO | started process 32703 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnxq_fF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:03 INFO - PROCESS | 32703 | 05:53:03 INFO - PROCESS | 32703 | (process:32761): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:53:14 INFO - PROCESS | 32703 | RSS: Main: 150945792 05:53:14 INFO - PROCESS | 32703 | 05:54:04 INFO - PROCESS | 32703 | 1453902844097 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:56:12 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:39423/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39423/tests/dromaeo/cssquery-ext.html) 05:56:13 INFO - PROCESS | 32703 | RSS: Main: 161386496 05:56:13 INFO - PROCESS | 32703 | 05:59:15 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:39423/tests/dromaeo/cssquery-ext.html (next: http://localhost:39423/tests/dromaeo/cssquery-jquery.html) 05:59:16 INFO - PROCESS | 32703 | RSS: Main: 158253056 05:59:16 INFO - PROCESS | 32703 | 06:02:18 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:39423/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39423/tests/dromaeo/cssquery-mootools.html) 06:02:18 INFO - PROCESS | 32703 | RSS: Main: 156794880 06:02:18 INFO - PROCESS | 32703 | 06:05:20 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:39423/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39423/tests/dromaeo/cssquery-prototype.html) 06:05:20 INFO - PROCESS | 32703 | RSS: Main: 154845184 06:05:20 INFO - PROCESS | 32703 | 06:08:23 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:39423/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39423/tests/dromaeo/cssquery-yui.html) 06:08:23 INFO - PROCESS | 32703 | RSS: Main: 154652672 06:08:23 INFO - PROCESS | 32703 | 06:11:26 INFO - PROCESS | 32703 | Cycle 1(1): loaded http://localhost:39423/tests/dromaeo/cssquery-yui.html (next: http://localhost:39423/tests/dromaeo/cssquery-dojo.html) 06:11:26 INFO - PROCESS | 32703 | RSS: Main: 158621696 06:11:26 INFO - PROCESS | 32703 | 06:11:26 INFO - PROCESS | 32703 | __start_tp_report 06:11:26 INFO - PROCESS | 32703 | _x_x_mozilla_page_load 06:11:26 INFO - PROCESS | 32703 | _x_x_mozilla_page_load_details 06:11:26 INFO - PROCESS | 32703 | |i|pagename|runs| 06:11:26 INFO - PROCESS | 32703 | |0;dojo.html;3105.5496952941826;3134.279115803365;3155.857986390612;3165.1770539659688;3174.285785698217;5260.631755777097;5300.496452836984;5306.87838569208;5313.149896016638;5329.387120481146;5255.605829562788;5352.866178345544;5353;5365.248865158871;5371.946280537193;4528.320751887227;4785.234362502;4917;4919.557239848413;4919.975400123012;4759.976200118995;4838.782254798525;4885.633577481685;4894.755761473022;4922.975385123087;4749.358836557072;4820;4847;4873.293372460991;4884.413870335582;4720.079584481027;4729.858104256878;4764.380630518011;4775.689580177277;4823.155947709172;4644.489106198315;4692.967547139624;4747.287906813971;4766.594839438651;4794.448638406593;5129.871753206163;5143.459936706629;5175.378954525443;5175.534201921845;5190.273361729361;5699.173619825144;5733.942660573382;5742.138679198112;5757.712114394263;5772.278465191851;5650.265465489501;5675.63108397957;5727.656340619576;5758.62568933018;5811.070228763378;5302.2841916341185;5309.8938021239355;5313.8937221255355;5319.946800531945;5365.436629153922;5708.20085188074;5761.827145185651;5763.8559036024435;5764;5782.479576838105;5486.396496385394;5538.113901775697;5637.802676906289;5662.462066103713;5751.5398768099285;5737.426257374313;5746.655200687972;5751.166080918243;5760.971195144081;5764.020116580192;5673.517750991129;5690.833379157263;5692.288463942007;5711.029125048752;5719.628224165416;5641.238432811518;5641.802536911188;5643.040683083886;5673.290838645169;5722.971385143131;4408.448943882015;4415.66882483815;4421.579949904753;4423.51341352451;4457.420535330386;3860.8069596520063;3920.4903362562686;3943.940840887389;3947.6447119758786;3984.183242435294;5290.074237008508;5299.284596579412;5317.946820531823;5376.4085950545405;5395.406505284494;5764.711764411846;5766.567507436959;5798.594098413155;5823.505002074787;5825.446582574648;5247.921281180786;5256.92114618281;5335.146376579806;5401.783928642811;5428.077226871442;4828.61371090312;4837.637177211724;4853.02939412119;4859.246816743411;4915.21356582945;5710.828675139753;5764.5676574257095;5819.621724587803;5833.270841144857;5878.177055212273;5532.778688852401;5574.414686458026;5630.887382252414;5643.492085712305;5698.6580805151825;5944.673042982505;5962.284525856925;5962.731677074629;5973.074173503114;5995.9700201500455;5652.85867853307;5677.801276955452;5683.2895888014;5690.857728556819;5693.601447898773;5549.861253468695;5634.211210430461;5664.773409063591;5754.884902302014;5786.884262314814;5577.525910297508;5617.101263797773;5628.071368224361;5646.689432081275;5670.603057785916;5560.082586373365;5577.4701403368235;5590.748416321357;5607.411221821813;5642.294713160855;5294.205869119509;5330.387005494418;5336.493033161843;5371.274877891435;5415.323084614423;5627.240322556402;5645.661260324394;5680.318361796611;5695.772169113189;5711;5313.946860531345;5551.333839939233;5565.415631358649;5586.13414920688;5610.298712660918 06:11:26 INFO - PROCESS | 32703 | |1;ext.html;516.452560286097;562.943705629437;565.821766143665;572.4504475703325;577.3764334518718;25790.35524111898;26344.73655263447;33884.32231355371;33996.320073598545;34112.147196320104;36088.45867311986;36156.45765313522;36273.45589816148;36323.2735345293;36358.999999999935;8272.834543309145;8543.786405339884;8553.615087321086;8584.356173286997;8595.3553483489;8362.874556881652;8365.749027529184;8415.957920210421;8489.44818586793;8523.914760852374;8413.747587572383;8527;8676.956615216946;8703.695370662028;8713.564321783917;8590.78523036926;8608.139186081404;8625.051244363147;8651.740447786546;8665.653373865038;8381.45520541169;8579.270761985239;8593.699220527315;8618.612162452704;8643.481391116553;38119.428208576894;38186.236275274336;38332.80833595814;38440.231195375934;38604;2845.502037143512;3037;3089.691030896915;3139.372125574894;3439.226174110805;28183.859080704464;28221.576676349872;28573.857130714423;28725.85637071801;28742;3821.9617803821884;3878.4182372644045;4016.016433217739;4027.7986100694848;4086.4891888513935;201536;202120;202218.99999999852;202324;202627;48171.27743083856;48924;55569.444305556426;55831;55870.720646396505;61253.38746612566;62361.376386236465;62535.37464625386;62607;62798;14031.438742450187;14042.1574705518;14127.576172714835;14181.14913105217;14230.217338046506;11193.832092518618;11225.101991840633;11234.045106165904;11251.043661288883;11255.099592032619;18928.81071189298;19101.2359505621;19210.711839322423;19681;19799.30702425408;7607.35337496308;7847.6468558914985;7939.722109726132;7954.204579542;7967.322777563856;874.9825003500022;901.2789768185426;928.8281667891462;945.394947233771;970.0590427285522;25050.123245686314;25082.623760643604;25834.483310334064;25840.483190336465;26036.73963260381;1012.104287705386;1046.659835553433;1050.107408702612;1052.5105825791045;1109.3066833229232;13718.794218086736;13885.86114138866;15090.24548772557;15507;15699.607509812346;295625;295636;299814;300468;301404;49636.50363496391;50188.749056254484;50206;50253.24620130701;50392;1315.3423288355823;1331.287761047854;1337.4917531338028;1347.9663008424673;1456.2281990545027;28082.297942550784;28799;28874.061635226408;28965.275868103465;29140.27149321284;44444;44715.21139154398;44892.55107448884;44971.1005779876;44996.32505512486;288280;290446;290908;290940;292254;30331.545026825057;30991;31228.687713122577;31547;31978.68021319757;36651;36726.63273367232;37159;37415.25169496649;37794;31125.377492450476;31210.21974450657;31532.527012095296;31645.525317119802;31806.84096579502;34025.25722170609;34781.65218347784;35353.292934140656;35790.28419431649;35875;33243.833780830944;33860.830695846365;34014.149646259044;34040.82979585086;34164.14589635279;29279.268018299714;30195.547066794454;31515.52726709147;31606.209844753146;31726;24176.75823241745;24191.516169676157;24237.63643545313;24298;24470 06:11:26 INFO - PROCESS | 32703 | |2;jquery.html;363.95996440391554;364.95438070241204;365.8335457366898;366.159663572102;368.2487725040917;15658.84341156588;16098.1950902455;16375.344986200553;16988.74516882248;17439.21523531441;10213.0297621726;10510.159187265019;10527.894721052806;10856.077233435168;10925.945370273157;4880.511948805118;5007.098722229997;5015.5486006259425;5055.696658200502;5456.399796022454;5282.445343238962;5377.4084850666595;5378.623496355257;5424.05079111154;5428.728563571825;4963.578095861856;5135.35808023997;5344.625876188668;5360.9463905361035;5408.945910540883;5184.351956005499;5225.477452254782;5273.472652734715;5639.887202255973;6131.233595800525;5397.568194544467;5404.756785944642;5412.891742165135;5418.729063546846;5423.132298832207;15104.471343502924;18918.243270269173;19438.611227775506;19472.80527194724;19808;2058.7323647925673;2060.1862264405477;2187.9890600547055;2192.4299682082774;2196.7034450349156;6966.9303306966785;9455.479948602824;10267.562541244231;10823.891761082366;12378.938105309506;1668.799744030712;1743.555393374694;1797.757302764123;1855.4875847505818;1900.5818719881604;53101;54420.455795441536;56014.71992640052;56491;56769.71615141898;9681.806363872824;9854.359466634645;9912.702618921443;9938.602455901682;9940.502974851228;12974.481020759064;13013.414396352187;13166.802497962539;13185.868141318655;13222.404991775393;6831.419329357061;6899.448044156456;7328.413726901835;7579.317861392501;7592.734254301073;7198.316159964795;7200.927990720026;7213.206547279795;7238.384737297389;7254.709811607582;4264.594863487963;4333.371661109121;4350.129974005212;4366.410534577792;4368.279233926367;1662.5760431090237;1737.556922984656;1755.2276998121042;1797.2900704221759;1816.2281030562222;920.4293338130268;936.7096200177966;1002.2583288366557;1027.3476342522551;1048.2766890845292;15684;15733.213339332988;16105.516834494983;16510.587235319214;16601.086940218403;830.0247209528779;904.674317245791;905.8595917632778;937.5640327247862;966.6713317472094;8222.342212622976;8591.09793471689;8820.2061814437;8947.776305592412;9039.864402033843;514633;518017;528055;537648.8705338846;537934;44851.775741121084;52055.47944520582;71968.64015679888;73418.63290683512;73706.63146684339;1132.17351333527;1141.6175581180232;1147.1511081799574;1166.912481563886;1167.8073117935446;13763.105398149088;13775.242361670204;14605.415783368546;14800.703985920436;14857.628559286104;29018.56472152877;29049.564256536592;29855.850720746257;30166.396672066876;30324.090277291718;34675.65324346825;35499.64500354963;36057;36077.45883811797;37463.62536374601;7298.781036568911;7515.849683006419;7567.962160189164;7613.467057306157;7799.883001755092;9973.45146016947;10719.571217151226;11464.885351146382;11617.535298587962;12140.93929530382;3799.943000855045;7175.174854891754;7471.813204669927;8619.8707019396;9915.504224788876;9426.670066547638;9781.364211326241;9917.65288214909;9958.55186516623;10082.8487572685;9047.411918225294;9198.126178013077;9665.275104367342;9762.463064531235;9771.657991970247;6911.688973996082;7015.614141222281;7203.963980180066;7303.196648368781;7340.889886651597;9185.908140918506;9504.239660827256;9653.03469653029;9670.419774813534;9732.70801875945 06:11:26 INFO - PROCESS | 32703 | |3;mootools.html;1417.6243295526683;1428.4000719697726;1545.1887758926568;1686.924088416022;1687.8396552327524;7387.335139837413;7536.585487798169;7553.395728341733;7836.4906281091835;8022.358211343093;8109.351251899849;8137.593120343989;8158.224968627986;8170.959145204266;8173.264406203441;2291.5875142474347;2315.3517015235675;2321.1063740459876;2323.907043718249;2327.55776402483;2319.93040208794;2349.612313968193;2350.2596682045187;2355.4464700795297;2358.292512246328;1990.5720270141917;2035.9592808143827;2227.2984010036866;2308.549832782608;2334.2180369576213;2280.6579013147993;2281.475260690034;2286.3598192506124;2289.461976435536;2295.483516208848;2266.7393249776324;2333.4749681321737;2333.6849525314205;2333.8366314358;2337.3922780077132;7947.960260198662;8052.557109358983;8060.435769496137;8063.395245356622;8137.75586732399;4715.740634265114;4782.665213435061;4805.063012712522;4827;4836.443808961979;2960.6003189569346;2962.3186667066693;2962.3482833776534;2980.3145276586506;3048.634163900324;920.5305294299956;948.6537413843967;962.2254085461201;965.5461932891529;987.1017374189524;10618.150547956146;10691.732706682318;10708.732281692943;10755.569777208902;10765.83851242232;4124.876253712333;4154.189932963043;4175.83296668136;4186.937195942063;4282.614564689193;8676.956615216883;8698.434601750865;8710.085441028728;8767.605457754416;8776.385653004356;4729.030548737501;4732.124556956974;4744.5492678195515;4753.191957367256;4757.619390448755;4336.588024137702;4350.1734670412525;4355.695101342875;4372.23485889968;4381.956180438218;3510.227749895019;3514.806685632315;3516.6834984851484;3530.894073177809;3544.8936531904083;1070.357785328812;1095.1293721491434;1097.1771171621283;1097.3415950429678;1101.5593762494907;864.4856310495245;923.7598224461689;969.0503306759415;1026.973026973027;1195.8325834383193;7013.544119632207;7217.530860494051;7231.529950553302;7235.2764723527225;7238.348548630648;609.4697613076563;620.0358442621676;626.7148447456397;629.8677277771627;764.8947271193184;5561.63849349791;5594.24477695514;5644.8871022579315;5655.236543066633;5662.320521537442;9251.352405331561;9680.854787178198;9700.805983880284;9709.563069661883;9716.708498745049;9369.859452108223;9526.476043817518;9541.427514349023;9644.421334719798;9646.18007469359;7339.412846972229;7351.485396022227;7464.626768661546;7486.251374862471;7544.396448284124;7213.855722885408;7284.307990740871;7311.524750891388;7339.229380915141;7354.558726476214;8478.728190771433;8563.785905352415;8759.91240087591;8873.112688731333;8940.195382415613;8868.600912958804;8869.955650221707;8886.511241881759;8942.06108358613;9031.412958157698;6834.624095674786;6858.5199036067;6871.209810871814;6990;7146.857062858818;7617.619119044137;7675.462717609714;7680;7680.846383072419;7685.538867667958;7002.7899163025195;7047.224805271519;7074.504784665024;7144.3927266182955;7183.928160718326;6220.377962203744;6896.448284137357;6914.55055421396;7016.263292354433;7055.470839686941;6620;6704.329567043256;6767.221769496571;6813.318668133147;6820.454363650995;6061.7575296987625;6159.692015399301;6164.599301045418;6168.722407491584;6173.9073913892225;6103.938960610337;6230.844228894314;6237.5009999200865;6255.093011513214;6260.968695156495 06:11:26 INFO - PROCESS | 32703 | |4;prototype.html;333.2302381498738;334.909574414908;337.6724577160154;345.2077482178401;345.57321707691;6230.84422889428;6297.937020629793;6354.745810167594;6377.6173429594255;6481.027845823129;6255.906161407571;6297.181366422359;6311.621302721828;6312.526560507958;6317.810465686037;4801.855944321667;4804.111239420701;4805.927911081337;4806;4806.086843499741;4791.3531673224015;4797.7840997155035;4797.808087676506;4804.567588916997;4807.879803004936;4654.255319148937;4763.833265835697;4767.1657459944545;4767.451743049559;4767.880802979918;4750.762461876927;4754.904901901978;4756.9286460703115;4758.738269395182;4761.761911904408;4133.173365326947;4145.357469592218;4146.979265103655;4153.190127925056;4163.604457576525;5980.372060933583;6002.189704389895;6004.159417681484;6007;6012.909806352908;5423.918641220384;5552.472515111058;5557.360903496069;5564.415736347666;5567.47109024642;6536.444402225817;6601.63690996995;6625.238097618787;6632.469402447792;6657.7669781557415;4583.175028494869;4587.7706114694465;4589.655775816794;4590.678652494326;4598.126355992351;6796.864062718718;6884.311568843075;6928.722851086001;6956.408705260059;6963.442924566022;4644.047970166108;4645.9303110453375;4652.13935421948;4653.837115700934;4657;4670.042641258534;4692.741899195577;4695.671303008757;4714.740689262055;4723.716577005391;5397.2443857859935;5464.426235245242;5478.726063696799;5515.531179849758;5518.724063796794;6623.602583844985;6674.866502669919;6705.564138330993;6706.966465167643;6707.396334329934;1627.113223293308;1651.6531528379176;1666.5500314915148;1667.3664007677005;1673.9246733897003;1072.3083611070972;1079.794838980591;1104.867415910096;1109.6005438042298;1110.3282514079028;6135.785247516315;6174.25908890936;6181.690915454209;6217.751289948352;6239.937600624026;6733.293004234582;6733.562318449285;6784.151981002375;6787.932120678829;6805.115335006517;6123.9387606124255;6171.84570385744;6190.566660333823;6209.59637623553;6220.657863817533;3678.179301245847;3693.7229707772026;3700.7232504785807;3702.833372498244;3704.6665800077585;7041.964790176016;7051.1186101737285;7103.076600041962;7107.715691372287;7128.108986376703;6727.360900714424;6902.654867256617;6912.965435172792;6917.13535808024;6933.1333583302085;7069.469789765788;7072.504924655224;7114.928850711427;7115.786526404217;7126.35862772353;6742.69657865407;6745.055692202997;6766.4248538874745;6797.490188236001;6802.183737951477;6557.770478033246;6703;6736.966315168393;6742.6628668567355;6743.15710536183;7055.223925368103;7060.364567188978;7083.291670833081;7109.324614161646;7116.928830711627;4610.608098311681;4631.282151266559;4643.257078867365;4644.674872758875;4655.4180727409075;6757.493188011017;6770.898436523555;6771.3905748482875;6787.151606049244;6904.792856214322;6752.459803215633;6761.594304341756;6762.289959554176;6778.118844550177;6800.591964482147;6707.966460167668;6717.328267173439;6739.05653208561;6750.5274630775375;6784.423324017514;6454.5159113065765;6615.603063815994;6643.601383916787;6648.5678430901835;6650.966745166436;6745.089412929192;6753.3921947025;6761.425278851156;6788.7284508619105;6830.214525329452;6555.2789193189665;6563.442107420732;6572.981187915881;6583.736650534117;6625 06:11:26 INFO - PROCESS | 32703 | |5;yui.html;675.3314218923265;705.5096707788086;721.2967356827094;733.2740586819049;769.8691222492175;12873.098883078188;12990.28553429561;13039.804402933953;13041.152325098874;13045.347732613354;11186.105111591074;11188.160887933396;11190.66428007159;11196;11224.775504489906;564.2946317103621;569.6382796923941;772.4399810137647;775.1008829757483;779.4388040610751;751.8233215194425;776.6000509737489;777.2227772227773;777.8988731464901;778.0468925566192;804.5213098206586;808.9595520223995;812.273015650992;817.9018517777874;818.1409520004001;794.1899262751989;802.2338666573438;804.0271271761176;807.3621838747412;808.6037841457702;589.228111174363;592.4667798980909;593.1636392686335;593.6823799267371;595.7468076067697;11734.765304693858;11846.111541634413;11848.585299514561;11864.703382415422;11900.345480998541;11866.347350895698;12673.112882098258;12685.873141268561;12715.87284127156;12950.352482375843;9067.546622668906;9289.814203715956;9397.812043759155;9410.294227932933;9431.339806213567;3546.556680414948;3579.1767893384667;3600.981995090034;3691.667749902495;3700.1674623209833;46161.53838461606;46235.30647040263;46366.30450543245;46740;47642.5235747645;9964.25268104895;10072.697819065439;10089.041541053588;10193.490325483695;10227.7443063924;17379.91310043467;17498.737518937225;17561.034143121997;17605.295788168587;17608.295668173385;7388.778336649909;7524.435667324863;7670.117936437269;7695.076590809139;7747.651355689008;4120.587941205916;4155.085881106152;4163.084121493267;4176.728512646729;4303.397524346594;2937.500624893773;2963.8962636308056;2968.346963668033;2984.492636251842;2996.2509372656837;552.111101127185;570.0337927213334;571.5741772379521;577.9219805326311;580.756082445374;514.6680391147689;525.7528961388141;574.6781802190786;632.3170975346615;678.1895634716467;8243.25810677042;8380.622871970776;8739.344549158839;8851.291896648252;9331.253499720005;506.25327641728154;518.3598256153647;520.0223579670196;563.7829435667297;590.5688847141611;3770.8680196193;3772.962270377316;3851.788151651686;3876.592957739453;3928.6660633846445;51827.74086129621;54430.727846361304;55197;55252.447475525536;55422;46719.76640116778;48651.75674121678;48807.75596121997;49447;49524.25713614299;44388.3341749874;44952.55047449549;45121;46664.533354666695;46722.76638616853;8651.221390074923;8742.256908162877;8898.73303800887;8946.642134314554;8959.372843900865;34635;35411.645883540834;35857;35887.46168807522;36311.63688363188;40988.385174223;41108.79445602753;42917;44895.77552112219;45525.089498209185;10456.902025287236;10784.892151078702;10905.727356816144;11055.889441105486;11070.39112848801;12398.380080996094;12442.129050966707;12763.808542871679;12794.488220471078;12835.935820321212;11084.445777711244;11104.444777760918;11254;11383.829242561535;11855.288682679067;11034.172437067413;11263.380514071478;11287.266327688674;11407.885921140682;11836.644900652995;10247.94876025645;10445.738856528344;10560.471976400995;10586.311889727143;10655.57377704883;9270.351075424656;9338.766530836783;9407;9439.150476457151;9501.192398646193;8739.38824282294;8958.462492250486;9333.346665733334;9583.281253905845;9601.231901448007 06:11:26 INFO - PROCESS | 32703 | __end_tp_report 06:11:26 INFO - PROCESS | 32703 | __start_cc_report 06:11:26 INFO - PROCESS | 32703 | _x_x_mozilla_cycle_collect,330 06:11:26 INFO - PROCESS | 32703 | __end_cc_report 06:11:26 INFO - PROCESS | 32703 | __startTimestamp1453903886583__endTimestamp 06:11:26 INFO - PROCESS | 32703 | 06:11:26 INFO - PROCESS | 32703 | ------- Summary: start ------- 06:11:26 INFO - PROCESS | 32703 | Number of tests: 6 06:11:26 INFO - PROCESS | 32703 | 06:11:26 INFO - PROCESS | 32703 | [#0] dojo.html Cycles:165 Average:5285.47 Median:5532.78 stddev:598.05 (10.8%) stddev-sans-first:574.92 06:11:26 INFO - PROCESS | 32703 | Values: 3105.5 3134.3 3155.9 3165.2 3174.3 5260.6 5300.5 5306.9 5313.1 5329.4 5255.6 5352.9 5353.0 5365.2 5371.9 4528.3 4785.2 4917.0 4919.6 4920.0 4760.0 4838.8 4885.6 4894.8 4923.0 4749.4 4820.0 4847.0 4873.3 4884.4 4720.1 4729.9 4764.4 4775.7 4823.2 4644.5 4693.0 4747.3 4766.6 4794.4 5129.9 5143.5 5175.4 5175.5 5190.3 5699.2 5733.9 5742.1 5757.7 5772.3 5650.3 5675.6 5727.7 5758.6 5811.1 5302.3 5309.9 5313.9 5319.9 5365.4 5708.2 5761.8 5763.9 5764.0 5782.5 5486.4 5538.1 5637.8 5662.5 5751.5 5737.4 5746.7 5751.2 5761.0 5764.0 5673.5 5690.8 5692.3 5711.0 5719.6 5641.2 5641.8 5643.0 5673.3 5723.0 4408.4 4415.7 4421.6 4423.5 4457.4 3860.8 3920.5 3943.9 3947.6 3984.2 5290.1 5299.3 5317.9 5376.4 5395.4 5764.7 5766.6 5798.6 5823.5 5825.4 5247.9 5256.9 5335.1 5401.8 5428.1 4828.6 4837.6 4853.0 4859.2 4915.2 5710.8 5764.6 5819.6 5833.3 5878.2 5532.8 5574.4 5630.9 5643.5 5698.7 5944.7 5962.3 5962.7 5973.1 5996.0 5652.9 5677.8 5683.3 5690.9 5693.6 5549.9 5634.2 5664.8 5754.9 5786.9 5577.5 5617.1 5628.1 5646.7 5670.6 5560.1 5577.5 5590.7 5607.4 5642.3 5294.2 5330.4 5336.5 5371.3 5415.3 5627.2 5645.7 5680.3 5695.8 5711.0 5313.9 5551.3 5565.4 5586.1 5610.3 06:11:26 INFO - PROCESS | 32703 | 06:11:26 INFO - PROCESS | 32703 | [#1] ext.html Cycles:180 Average:42631.32 Median:34019.70 stddev:69903.58 (205.5%) stddev-sans-first:70028.16 06:11:26 INFO - PROCESS | 32703 | Values: 516.5 562.9 565.8 572.5 577.4 25790.4 26344.7 33884.3 33996.3 34112.1 36088.5 36156.5 36273.5 36323.3 36359.0 8272.8 8543.8 8553.6 8584.4 8595.4 8362.9 8365.7 8416.0 8489.4 8523.9 8413.7 8527.0 8677.0 8703.7 8713.6 8590.8 8608.1 8625.1 8651.7 8665.7 8381.5 8579.3 8593.7 8618.6 8643.5 38119.4 38186.2 38332.8 38440.2 38604.0 2845.5 3037.0 3089.7 3139.4 3439.2 28183.9 28221.6 28573.9 28725.9 28742.0 3822.0 3878.4 4016.0 4027.8 4086.5 201536.0 202120.0 202219.0 202324.0 202627.0 48171.3 48924.0 55569.4 55831.0 55870.7 61253.4 62361.4 62535.4 62607.0 62798.0 14031.4 14042.2 14127.6 14181.1 14230.2 11193.8 11225.1 11234.0 11251.0 11255.1 18928.8 19101.2 19210.7 19681.0 19799.3 7607.4 7847.6 7939.7 7954.2 7967.3 875.0 901.3 928.8 945.4 970.1 25050.1 25082.6 25834.5 25840.5 26036.7 1012.1 1046.7 1050.1 1052.5 1109.3 13718.8 13885.9 15090.2 15507.0 15699.6 295625.0 295636.0 299814.0 300468.0 301404.0 49636.5 50188.7 50206.0 50253.2 50392.0 1315.3 1331.3 1337.5 1348.0 1456.2 28082.3 28799.0 28874.1 28965.3 29140.3 44444.0 44715.2 44892.6 44971.1 44996.3 288280.0 290446.0 290908.0 290940.0 292254.0 30331.5 30991.0 31228.7 31547.0 31978.7 36651.0 36726.6 37159.0 37415.3 37794.0 31125.4 31210.2 31532.5 31645.5 31806.8 34025.3 34781.7 35353.3 35790.3 35875.0 33243.8 33860.8 34014.1 34040.8 34164.1 29279.3 30195.5 31515.5 31606.2 31726.0 24176.8 24191.5 24237.6 24298.0 24470.0 06:11:26 INFO - PROCESS | 32703 | 06:11:26 INFO - PROCESS | 32703 | [#2] jquery.html Cycles:180 Average:26276.81 Median:261600.68 stddev:86055.98 (32.9%) stddev-sans-first:86275.39 06:11:26 INFO - PROCESS | 32703 | Values: 364.0 365.0 365.8 366.2 368.2 15658.8 16098.2 16375.3 16988.7 17439.2 10213.0 10510.2 10527.9 10856.1 10925.9 4880.5 5007.1 5015.5 5055.7 5456.4 5282.4 5377.4 5378.6 5424.1 5428.7 4963.6 5135.4 5344.6 5360.9 5408.9 5184.4 5225.5 5273.5 5639.9 6131.2 5397.6 5404.8 5412.9 5418.7 5423.1 15104.5 18918.2 19438.6 19472.8 19808.0 2058.7 2060.2 2188.0 2192.4 2196.7 6966.9 9455.5 10267.6 10823.9 12378.9 1668.8 1743.6 1797.8 1855.5 1900.6 53101.0 54420.5 56014.7 56491.0 56769.7 9681.8 9854.4 9912.7 9938.6 9940.5 12974.5 13013.4 13166.8 13185.9 13222.4 6831.4 6899.4 7328.4 7579.3 7592.7 7198.3 7200.9 7213.2 7238.4 7254.7 4264.6 4333.4 4350.1 4366.4 4368.3 1662.6 1737.6 1755.2 1797.3 1816.2 920.4 936.7 1002.3 1027.3 1048.3 15684.0 15733.2 16105.5 16510.6 16601.1 830.0 904.7 905.9 937.6 966.7 8222.3 8591.1 8820.2 8947.8 9039.9 514633.0 518017.0 528055.0 537648.9 537934.0 44851.8 52055.5 71968.6 73418.6 73706.6 1132.2 1141.6 1147.2 1166.9 1167.8 13763.1 13775.2 14605.4 14800.7 14857.6 29018.6 29049.6 29855.9 30166.4 30324.1 34675.7 35499.6 36057.0 36077.5 37463.6 7298.8 7515.8 7568.0 7613.5 7799.9 9973.5 10719.6 11464.9 11617.5 12140.9 3799.9 7175.2 7471.8 8619.9 9915.5 9426.7 9781.4 9917.7 9958.6 10082.8 9047.4 9198.1 9665.3 9762.5 9771.7 6911.7 7015.6 7204.0 7303.2 7340.9 9185.9 9504.2 9653.0 9670.4 9732.7 06:11:26 INFO - PROCESS | 32703 | 06:11:26 INFO - PROCESS | 32703 | [#3] mootools.html Cycles:180 Average:5460.16 Median:3445.42 stddev:2895.42 (84.0%) stddev-sans-first:2887.60 06:11:26 INFO - PROCESS | 32703 | Values: 1417.6 1428.4 1545.2 1686.9 1687.8 7387.3 7536.6 7553.4 7836.5 8022.4 8109.4 8137.6 8158.2 8171.0 8173.3 2291.6 2315.4 2321.1 2323.9 2327.6 2319.9 2349.6 2350.3 2355.4 2358.3 1990.6 2036.0 2227.3 2308.5 2334.2 2280.7 2281.5 2286.4 2289.5 2295.5 2266.7 2333.5 2333.7 2333.8 2337.4 7948.0 8052.6 8060.4 8063.4 8137.8 4715.7 4782.7 4805.1 4827.0 4836.4 2960.6 2962.3 2962.3 2980.3 3048.6 920.5 948.7 962.2 965.5 987.1 10618.2 10691.7 10708.7 10755.6 10765.8 4124.9 4154.2 4175.8 4186.9 4282.6 8677.0 8698.4 8710.1 8767.6 8776.4 4729.0 4732.1 4744.5 4753.2 4757.6 4336.6 4350.2 4355.7 4372.2 4382.0 3510.2 3514.8 3516.7 3530.9 3544.9 1070.4 1095.1 1097.2 1097.3 1101.6 864.5 923.8 969.1 1027.0 1195.8 7013.5 7217.5 7231.5 7235.3 7238.3 609.5 620.0 626.7 629.9 764.9 5561.6 5594.2 5644.9 5655.2 5662.3 9251.4 9680.9 9700.8 9709.6 9716.7 9369.9 9526.5 9541.4 9644.4 9646.2 7339.4 7351.5 7464.6 7486.3 7544.4 7213.9 7284.3 7311.5 7339.2 7354.6 8478.7 8563.8 8759.9 8873.1 8940.2 8868.6 8870.0 8886.5 8942.1 9031.4 6834.6 6858.5 6871.2 6990.0 7146.9 7617.6 7675.5 7680.0 7680.8 7685.5 7002.8 7047.2 7074.5 7144.4 7183.9 6220.4 6896.4 6914.6 7016.3 7055.5 6620.0 6704.3 6767.2 6813.3 6820.5 6061.8 6159.7 6164.6 6168.7 6173.9 6103.9 6230.8 6237.5 6255.1 6261.0 06:11:26 INFO - PROCESS | 32703 | 06:11:26 INFO - PROCESS | 32703 | [#4] prototype.html Cycles:180 Average:5541.75 Median:6247.92 stddev:1680.16 (26.9%) stddev-sans-first:1638.76 06:11:26 INFO - PROCESS | 32703 | Values: 333.2 334.9 337.7 345.2 345.6 6230.8 6297.9 6354.7 6377.6 6481.0 6255.9 6297.2 6311.6 6312.5 6317.8 4801.9 4804.1 4805.9 4806.0 4806.1 4791.4 4797.8 4797.8 4804.6 4807.9 4654.3 4763.8 4767.2 4767.5 4767.9 4750.8 4754.9 4756.9 4758.7 4761.8 4133.2 4145.4 4147.0 4153.2 4163.6 5980.4 6002.2 6004.2 6007.0 6012.9 5423.9 5552.5 5557.4 5564.4 5567.5 6536.4 6601.6 6625.2 6632.5 6657.8 4583.2 4587.8 4589.7 4590.7 4598.1 6796.9 6884.3 6928.7 6956.4 6963.4 4644.0 4645.9 4652.1 4653.8 4657.0 4670.0 4692.7 4695.7 4714.7 4723.7 5397.2 5464.4 5478.7 5515.5 5518.7 6623.6 6674.9 6705.6 6707.0 6707.4 1627.1 1651.7 1666.6 1667.4 1673.9 1072.3 1079.8 1104.9 1109.6 1110.3 6135.8 6174.3 6181.7 6217.8 6239.9 6733.3 6733.6 6784.2 6787.9 6805.1 6123.9 6171.8 6190.6 6209.6 6220.7 3678.2 3693.7 3700.7 3702.8 3704.7 7042.0 7051.1 7103.1 7107.7 7128.1 6727.4 6902.7 6913.0 6917.1 6933.1 7069.5 7072.5 7114.9 7115.8 7126.4 6742.7 6745.1 6766.4 6797.5 6802.2 6557.8 6703.0 6737.0 6742.7 6743.2 7055.2 7060.4 7083.3 7109.3 7116.9 4610.6 4631.3 4643.3 4644.7 4655.4 6757.5 6770.9 6771.4 6787.2 6904.8 6752.5 6761.6 6762.3 6778.1 6800.6 6708.0 6717.3 6739.1 6750.5 6784.4 6454.5 6615.6 6643.6 6648.6 6651.0 6745.1 6753.4 6761.4 6788.7 6830.2 6555.3 6563.4 6573.0 6583.7 6625.0 06:11:26 INFO - PROCESS | 32703 | 06:11:26 INFO - PROCESS | 32703 | [#5] yui.html Cycles:180 Average:13353.70 Median:46692.15 stddev:15382.45 (32.9%) stddev-sans-first:15396.14 06:11:26 INFO - PROCESS | 32703 | Values: 675.3 705.5 721.3 733.3 769.9 12873.1 12990.3 13039.8 13041.2 13045.3 11186.1 11188.2 11190.7 11196.0 11224.8 564.3 569.6 772.4 775.1 779.4 751.8 776.6 777.2 777.9 778.0 804.5 809.0 812.3 817.9 818.1 794.2 802.2 804.0 807.4 808.6 589.2 592.5 593.2 593.7 595.7 11734.8 11846.1 11848.6 11864.7 11900.3 11866.3 12673.1 12685.9 12715.9 12950.4 9067.5 9289.8 9397.8 9410.3 9431.3 3546.6 3579.2 3601.0 3691.7 3700.2 46161.5 46235.3 46366.3 46740.0 47642.5 9964.3 10072.7 10089.0 10193.5 10227.7 17379.9 17498.7 17561.0 17605.3 17608.3 7388.8 7524.4 7670.1 7695.1 7747.7 4120.6 4155.1 4163.1 4176.7 4303.4 2937.5 2963.9 2968.3 2984.5 2996.3 552.1 570.0 571.6 577.9 580.8 514.7 525.8 574.7 632.3 678.2 8243.3 8380.6 8739.3 8851.3 9331.3 506.3 518.4 520.0 563.8 590.6 3770.9 3773.0 3851.8 3876.6 3928.7 51827.7 54430.7 55197.0 55252.4 55422.0 46719.8 48651.8 48807.8 49447.0 49524.3 44388.3 44952.6 45121.0 46664.5 46722.8 8651.2 8742.3 8898.7 8946.6 8959.4 34635.0 35411.6 35857.0 35887.5 36311.6 40988.4 41108.8 42917.0 44895.8 45525.1 10456.9 10784.9 10905.7 11055.9 11070.4 12398.4 12442.1 12763.8 12794.5 12835.9 11084.4 11104.4 11254.0 11383.8 11855.3 11034.2 11263.4 11287.3 11407.9 11836.6 10247.9 10445.7 10560.5 10586.3 10655.6 9270.4 9338.8 9407.0 9439.2 9501.2 8739.4 8958.5 9333.3 9583.3 9601.2 06:11:26 INFO - PROCESS | 32703 | -------- Summary: end -------- 06:11:26 INFO - PROCESS | 32703 | 06:11:27 INFO - TEST-INFO | 32703: exit 0 06:11:27 INFO - TEST-OK | dromaeo_css | took 1110389ms 06:11:27 INFO - TEST-START | kraken 06:11:27 INFO - operating with platform_type : linux_ 06:11:27 INFO - Initialising browser for kraken test... 06:11:27 INFO - TEST-INFO | started process 478 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNsl3pB/profile http://localhost:39423/getInfo.html) 06:11:30 INFO - PROCESS | 478 | 06:11:30 INFO - PROCESS | 478 | (process:551): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:11:31 INFO - PROCESS | 478 | __metrics Screen width/height:1600/1200 06:11:31 INFO - PROCESS | 478 | colorDepth:24 06:11:31 INFO - PROCESS | 478 | Browser inner width/height: 1024/697 06:11:31 INFO - PROCESS | 478 | __metrics 06:11:31 INFO - PROCESS | 478 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:11:32 INFO - TEST-INFO | 478: exit 0 06:11:32 INFO - Browser initialized. 06:11:32 INFO - Running cycle 1/1 for kraken test... 06:11:32 INFO - TEST-INFO | started process 603 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNsl3pB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:34 INFO - PROCESS | 603 | 06:11:34 INFO - PROCESS | 603 | (process:663): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:11:44 INFO - PROCESS | 603 | RSS: Main: 152109056 06:11:44 INFO - PROCESS | 603 | 06:11:47 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39423/tests/kraken/driver.html?testName=audio-beat-detection) 06:11:47 INFO - PROCESS | 603 | RSS: Main: 156229632 06:11:47 INFO - PROCESS | 603 | 06:11:50 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39423/tests/kraken/driver.html?testName=audio-dft) 06:11:50 INFO - PROCESS | 603 | RSS: Main: 158531584 06:11:50 INFO - PROCESS | 603 | 06:11:53 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39423/tests/kraken/driver.html?testName=audio-fft) 06:11:54 INFO - PROCESS | 603 | RSS: Main: 153169920 06:11:54 INFO - PROCESS | 603 | 06:11:56 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39423/tests/kraken/driver.html?testName=audio-oscillator) 06:11:57 INFO - PROCESS | 603 | RSS: Main: 154066944 06:11:57 INFO - PROCESS | 603 | 06:11:59 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39423/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:00 INFO - PROCESS | 603 | RSS: Main: 154628096 06:12:00 INFO - PROCESS | 603 | 06:12:03 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39423/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:03 INFO - PROCESS | 603 | RSS: Main: 154546176 06:12:03 INFO - PROCESS | 603 | 06:12:07 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39423/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:07 INFO - PROCESS | 603 | RSS: Main: 155013120 06:12:07 INFO - PROCESS | 603 | 06:12:10 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39423/tests/kraken/driver.html?testName=json-parse-financial) 06:12:11 INFO - PROCESS | 603 | RSS: Main: 153427968 06:12:11 INFO - PROCESS | 603 | 06:12:12 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39423/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:13 INFO - PROCESS | 603 | RSS: Main: 153862144 06:12:13 INFO - PROCESS | 603 | 06:12:15 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39423/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:12:15 INFO - PROCESS | 603 | RSS: Main: 155078656 06:12:15 INFO - PROCESS | 603 | 06:12:17 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39423/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:18 INFO - PROCESS | 603 | RSS: Main: 154140672 06:12:18 INFO - PROCESS | 603 | 06:12:20 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:21 INFO - PROCESS | 603 | RSS: Main: 153939968 06:12:21 INFO - PROCESS | 603 | 06:12:24 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:24 INFO - PROCESS | 603 | RSS: Main: 154165248 06:12:24 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | Cycle 1(1): loaded http://localhost:39423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39423/tests/kraken/driver.html?testName=ai-astar) 06:12:26 INFO - PROCESS | 603 | RSS: Main: 155668480 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | __start_tp_report 06:12:26 INFO - PROCESS | 603 | _x_x_mozilla_page_load 06:12:26 INFO - PROCESS | 603 | _x_x_mozilla_page_load_details 06:12:26 INFO - PROCESS | 603 | |i|pagename|runs| 06:12:26 INFO - PROCESS | 603 | |0;ai-astar;111;107;113;111;112;121;110;110;111;111 06:12:26 INFO - PROCESS | 603 | |1;audio-beat-detection;155;128;152;166;135;157;150;131;168;128 06:12:26 INFO - PROCESS | 603 | |2;audio-dft;162;162;162;161;163;162;159;162;166;164 06:12:26 INFO - PROCESS | 603 | |3;audio-fft;78;76;76;73;73;142;74;76;75;74 06:12:26 INFO - PROCESS | 603 | |4;audio-oscillator;96;97;142;96;96;95;144;97;96;143 06:12:26 INFO - PROCESS | 603 | |5;imaging-gaussian-blur;120;116;116;115;115;115;115;116;116;116 06:12:26 INFO - PROCESS | 603 | |6;imaging-darkroom;149;150;149;151;150;151;150;150;149;158 06:12:26 INFO - PROCESS | 603 | |7;imaging-desaturate;96;97;97;102;96;96;96;97;96;97 06:12:26 INFO - PROCESS | 603 | |8;json-parse-financial;62;61;61;61;62;60;60;60;70;59 06:12:26 INFO - PROCESS | 603 | |9;json-stringify-tinderbox;67;68;72;67;69;67;67;68;67;68 06:12:26 INFO - PROCESS | 603 | |10;stanford-crypto-aes;81;87;83;84;83;83;81;83;83;84 06:12:26 INFO - PROCESS | 603 | |11;stanford-crypto-ccm;117;122;127;123;116;121;120;114;130;118 06:12:26 INFO - PROCESS | 603 | |12;stanford-crypto-pbkdf2;141;142;136;146;141;133;147;142;142;139 06:12:26 INFO - PROCESS | 603 | |13;stanford-crypto-sha256-iterative;74;70;71;73;68;68;69;69;69;68 06:12:26 INFO - PROCESS | 603 | __end_tp_report 06:12:26 INFO - PROCESS | 603 | __start_cc_report 06:12:26 INFO - PROCESS | 603 | _x_x_mozilla_cycle_collect,729 06:12:26 INFO - PROCESS | 603 | __end_cc_report 06:12:26 INFO - PROCESS | 603 | __startTimestamp1453903946615__endTimestamp 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | ------- Summary: start ------- 06:12:26 INFO - PROCESS | 603 | Number of tests: 14 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.00 stddev:3.62 (3.3%) stddev-sans-first:3.83 06:12:26 INFO - PROCESS | 603 | Values: 111.0 107.0 113.0 111.0 112.0 121.0 110.0 110.0 111.0 111.0 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:153.50 stddev:15.36 (10.0%) stddev-sans-first:16.01 06:12:26 INFO - PROCESS | 603 | Values: 155.0 128.0 152.0 166.0 135.0 157.0 150.0 131.0 168.0 128.0 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.83 (1.1%) stddev-sans-first:1.94 06:12:26 INFO - PROCESS | 603 | Values: 162.0 162.0 162.0 161.0 163.0 162.0 159.0 162.0 166.0 164.0 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:21.24 (28.1%) stddev-sans-first:22.49 06:12:26 INFO - PROCESS | 603 | Values: 78.0 76.0 76.0 73.0 73.0 142.0 74.0 76.0 75.0 74.0 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.00 stddev:22.65 (23.6%) stddev-sans-first:23.43 06:12:26 INFO - PROCESS | 603 | Values: 96.0 97.0 142.0 96.0 96.0 95.0 144.0 97.0 96.0 143.0 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:116.00 stddev:1.49 (1.3%) stddev-sans-first:0.53 06:12:26 INFO - PROCESS | 603 | Values: 120.0 116.0 116.0 115.0 115.0 115.0 115.0 116.0 116.0 116.0 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:150.00 stddev:2.67 (1.8%) stddev-sans-first:2.76 06:12:26 INFO - PROCESS | 603 | Values: 149.0 150.0 149.0 151.0 150.0 151.0 150.0 150.0 149.0 158.0 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.50 stddev:1.83 (1.9%) stddev-sans-first:1.90 06:12:26 INFO - PROCESS | 603 | Values: 96.0 97.0 97.0 102.0 96.0 96.0 96.0 97.0 96.0 97.0 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:61.00 stddev:3.10 (5.1%) stddev-sans-first:3.28 06:12:26 INFO - PROCESS | 603 | Values: 62.0 61.0 61.0 61.0 62.0 60.0 60.0 60.0 70.0 59.0 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:1.56 (2.3%) stddev-sans-first:1.62 06:12:26 INFO - PROCESS | 603 | Values: 67.0 68.0 72.0 67.0 69.0 67.0 67.0 68.0 67.0 68.0 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:1.69 (2.0%) stddev-sans-first:1.59 06:12:26 INFO - PROCESS | 603 | Values: 81.0 87.0 83.0 84.0 83.0 83.0 81.0 83.0 83.0 84.0 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:121.50 stddev:4.96 (4.1%) stddev-sans-first:5.07 06:12:26 INFO - PROCESS | 603 | Values: 117.0 122.0 127.0 123.0 116.0 121.0 120.0 114.0 130.0 118.0 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.90 Median:142.00 stddev:4.18 (2.9%) stddev-sans-first:4.43 06:12:26 INFO - PROCESS | 603 | Values: 141.0 142.0 136.0 146.0 141.0 133.0 147.0 142.0 142.0 139.0 06:12:26 INFO - PROCESS | 603 | 06:12:26 INFO - PROCESS | 603 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.50 stddev:2.13 (3.1%) stddev-sans-first:1.67 06:12:26 INFO - PROCESS | 603 | Values: 74.0 70.0 71.0 73.0 68.0 68.0 69.0 69.0 69.0 68.0 06:12:26 INFO - PROCESS | 603 | -------- Summary: end -------- 06:12:26 INFO - PROCESS | 603 | 06:12:27 INFO - TEST-INFO | 603: exit 0 06:12:27 INFO - TEST-OK | kraken | took 60285ms 06:12:27 INFO - TEST-START | v8_7 06:12:27 INFO - operating with platform_type : linux_ 06:12:27 INFO - Initialising browser for v8_7 test... 06:12:27 INFO - TEST-INFO | started process 901 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvHCk0h/profile http://localhost:39423/getInfo.html) 06:12:31 INFO - PROCESS | 901 | 06:12:31 INFO - PROCESS | 901 | (process:970): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:12:32 INFO - PROCESS | 901 | __metrics Screen width/height:1600/1200 06:12:32 INFO - PROCESS | 901 | colorDepth:24 06:12:32 INFO - PROCESS | 901 | Browser inner width/height: 1024/697 06:12:32 INFO - PROCESS | 901 | __metrics 06:12:32 INFO - PROCESS | 901 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:12:33 INFO - TEST-INFO | 901: exit 0 06:12:33 INFO - Browser initialized. 06:12:33 INFO - Running cycle 1/1 for v8_7 test... 06:12:33 INFO - TEST-INFO | started process 1019 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvHCk0h/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:34 INFO - PROCESS | 1019 | 06:12:34 INFO - PROCESS | 1019 | (process:1087): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:12:44 INFO - PROCESS | 1019 | RSS: Main: 152018944 06:12:44 INFO - PROCESS | 1019 | 06:13:07 INFO - PROCESS | 1019 | Cycle 1(1): loaded http://localhost:39423/tests/v8_7/run.html (next: http://localhost:39423/tests/v8_7/run.html) 06:13:07 INFO - PROCESS | 1019 | RSS: Main: 150937600 06:13:07 INFO - PROCESS | 1019 | 06:13:07 INFO - PROCESS | 1019 | __start_tp_report 06:13:07 INFO - PROCESS | 1019 | _x_x_mozilla_page_load 06:13:07 INFO - PROCESS | 1019 | _x_x_mozilla_page_load_details 06:13:07 INFO - PROCESS | 1019 | |i|pagename|runs| 06:13:07 INFO - PROCESS | 1019 | |0;Richards;166.77785190126752 06:13:07 INFO - PROCESS | 1019 | |1;DeltaBlue;189.8614011771407 06:13:07 INFO - PROCESS | 1019 | |2;Encrypt;274.19797093501506 06:13:07 INFO - PROCESS | 1019 | |3;Decrypt;5268.421052631579 06:13:07 INFO - PROCESS | 1019 | |4;RayTrace;1074.1138560687432 06:13:07 INFO - PROCESS | 1019 | |5;Earley;737.4631268436578 06:13:07 INFO - PROCESS | 1019 | |6;Boyer;12345.67901234568 06:13:07 INFO - PROCESS | 1019 | |7;RegExp;41160 06:13:07 INFO - PROCESS | 1019 | |8;Splay;629.8377028714108 06:13:07 INFO - PROCESS | 1019 | |9;NavierStokes;4822.115384615385 06:13:07 INFO - PROCESS | 1019 | __end_tp_report 06:13:07 INFO - PROCESS | 1019 | __startTimestamp1453903987638__endTimestamp 06:13:07 INFO - PROCESS | 1019 | 06:13:07 INFO - PROCESS | 1019 | ------- Summary: start ------- 06:13:07 INFO - PROCESS | 1019 | Number of tests: 10 06:13:07 INFO - PROCESS | 1019 | 06:13:07 INFO - PROCESS | 1019 | [#0] Richards Cycles:1 Average:166.78 Median:166.78 stddev:0.00 (0.0%) 06:13:07 INFO - PROCESS | 1019 | Values: 166.8 06:13:07 INFO - PROCESS | 1019 | 06:13:07 INFO - PROCESS | 1019 | [#1] DeltaBlue Cycles:1 Average:189.86 Median:189.86 stddev:0.00 (0.0%) 06:13:07 INFO - PROCESS | 1019 | Values: 189.9 06:13:07 INFO - PROCESS | 1019 | 06:13:07 INFO - PROCESS | 1019 | [#2] Encrypt Cycles:1 Average:274.20 Median:274.20 stddev:0.00 (0.0%) 06:13:07 INFO - PROCESS | 1019 | Values: 274.2 06:13:07 INFO - PROCESS | 1019 | 06:13:07 INFO - PROCESS | 1019 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 06:13:07 INFO - PROCESS | 1019 | Values: 5268.4 06:13:07 INFO - PROCESS | 1019 | 06:13:07 INFO - PROCESS | 1019 | [#4] RayTrace Cycles:1 Average:1074.11 Median:1074.11 stddev:0.00 (0.0%) 06:13:07 INFO - PROCESS | 1019 | Values: 1074.1 06:13:07 INFO - PROCESS | 1019 | 06:13:07 INFO - PROCESS | 1019 | [#5] Earley Cycles:1 Average:737.46 Median:737.46 stddev:0.00 (0.0%) 06:13:07 INFO - PROCESS | 1019 | Values: 737.5 06:13:07 INFO - PROCESS | 1019 | 06:13:07 INFO - PROCESS | 1019 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 06:13:07 INFO - PROCESS | 1019 | Values: 12345.7 06:13:07 INFO - PROCESS | 1019 | 06:13:07 INFO - PROCESS | 1019 | [#7] RegExp Cycles:1 Average:41160.00 Median:41160.00 stddev:0.00 (0.0%) 06:13:07 INFO - PROCESS | 1019 | Values: 41160.0 06:13:07 INFO - PROCESS | 1019 | 06:13:07 INFO - PROCESS | 1019 | [#8] Splay Cycles:1 Average:629.84 Median:629.84 stddev:0.00 (0.0%) 06:13:07 INFO - PROCESS | 1019 | Values: 629.8 06:13:07 INFO - PROCESS | 1019 | 06:13:07 INFO - PROCESS | 1019 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 06:13:07 INFO - PROCESS | 1019 | Values: 4822.1 06:13:07 INFO - PROCESS | 1019 | -------- Summary: end -------- 06:13:07 INFO - PROCESS | 1019 | 06:13:08 INFO - TEST-INFO | 1019: exit 0 06:13:08 INFO - TEST-OK | v8_7 | took 41003ms 06:13:08 INFO - SUITE-END | took 1211s 06:13:08 INFO - Completed test suite (00:20:11) 06:13:08 INFO - Working with test: dromaeo_css 06:13:08 INFO - Generating results file: dromaeo_css 06:13:08 INFO - Working with test: kraken 06:13:08 INFO - Generating results file: kraken 06:13:08 INFO - javascript benchmark 06:13:08 INFO - Working with test: v8_7 06:13:08 INFO - Generating results file: v8_7 06:13:08 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:08 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:13:08 INFO - process_Request line: dromaeo_css 6761.98 graph.html#tests=[[72,1,43]] 06:13:08 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:08 INFO - process_Request line: kraken 1521.00 graph.html#tests=[[232,1,43]] 06:13:08 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:08 INFO - process_Request line: v8_7 20200.26 graph.html#tests=[[230,1,43]] 06:13:08 INFO - RETURN: dromaeo_css: 6761.98 06:13:08 INFO - RETURN: kraken: 1521.00 06:13:08 INFO - RETURN: v8_7: 20200.26 06:13:08 INFO - javascript benchmark 06:13:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3105.5496952941826, 3134.279115803365, 3155.857986390612, 3165.1770539659688, 3174.285785698217, 5260.631755777097, 5300.496452836984, 5306.87838569208, 5313.149896016638, 5329.387120481146, 5255.605829562788, 5352.866178345544, 5353.0, 5365.248865158871, 5371.946280537193, 4528.320751887227, 4785.234362502, 4917.0, 4919.557239848413, 4919.975400123012, 4759.976200118995, 4838.782254798525, 4885.633577481685, 4894.755761473022, 4922.975385123087, 4749.358836557072, 4820.0, 4847.0, 4873.293372460991, 4884.413870335582, 4720.079584481027, 4729.858104256878, 4764.380630518011, 4775.689580177277, 4823.155947709172, 4644.489106198315, 4692.967547139624, 4747.287906813971, 4766.594839438651, 4794.448638406593, 5129.871753206163, 5143.459936706629, 5175.378954525443, 5175.534201921845, 5190.273361729361, 5699.173619825144, 5733.942660573382, 5742.138679198112, 5757.712114394263, 5772.278465191851, 5650.265465489501, 5675.63108397957, 5727.656340619576, 5758.62568933018, 5811.070228763378, 5302.2841916341185, 5309.8938021239355, 5313.8937221255355, 5319.946800531945, 5365.436629153922, 5708.20085188074, 5761.827145185651, 5763.8559036024435, 5764.0, 5782.479576838105, 5486.396496385394, 5538.113901775697, 5637.802676906289, 5662.462066103713, 5751.5398768099285, 5737.426257374313, 5746.655200687972, 5751.166080918243, 5760.971195144081, 5764.020116580192, 5673.517750991129, 5690.833379157263, 5692.288463942007, 5711.029125048752, 5719.628224165416, 5641.238432811518, 5641.802536911188, 5643.040683083886, 5673.290838645169, 5722.971385143131, 4408.448943882015, 4415.66882483815, 4421.579949904753, 4423.51341352451, 4457.420535330386, 3860.8069596520063, 3920.4903362562686, 3943.940840887389, 3947.6447119758786, 3984.183242435294, 5290.074237008508, 5299.284596579412, 5317.946820531823, 5376.4085950545405, 5395.406505284494, 5764.711764411846, 5766.567507436959, 5798.594098413155, 5823.505002074787, 5825.446582574648, 5247.921281180786, 5256.92114618281, 5335.146376579806, 5401.783928642811, 5428.077226871442, 4828.61371090312, 4837.637177211724, 4853.02939412119, 4859.246816743411, 4915.21356582945, 5710.828675139753, 5764.5676574257095, 5819.621724587803, 5833.270841144857, 5878.177055212273, 5532.778688852401, 5574.414686458026, 5630.887382252414, 5643.492085712305, 5698.6580805151825, 5944.673042982505, 5962.284525856925, 5962.731677074629, 5973.074173503114, 5995.9700201500455, 5652.85867853307, 5677.801276955452, 5683.2895888014, 5690.857728556819, 5693.601447898773, 5549.861253468695, 5634.211210430461, 5664.773409063591, 5754.884902302014, 5786.884262314814, 5577.525910297508, 5617.101263797773, 5628.071368224361, 5646.689432081275, 5670.603057785916, 5560.082586373365, 5577.4701403368235, 5590.748416321357, 5607.411221821813, 5642.294713160855, 5294.205869119509, 5330.387005494418, 5336.493033161843, 5371.274877891435, 5415.323084614423, 5627.240322556402, 5645.661260324394, 5680.318361796611, 5695.772169113189, 5711.0, 5313.946860531345, 5551.333839939233, 5565.415631358649, 5586.13414920688, 5610.298712660918], "unit": "score", "name": "dojo.html", "value": 5245.97794749893}, {"lowerIsBetter": false, "replicates": [516.452560286097, 562.943705629437, 565.821766143665, 572.4504475703325, 577.3764334518718, 25790.35524111898, 26344.73655263447, 33884.32231355371, 33996.320073598545, 34112.147196320104, 36088.45867311986, 36156.45765313522, 36273.45589816148, 36323.2735345293, 36358.999999999935, 8272.834543309145, 8543.786405339884, 8553.615087321086, 8584.356173286997, 8595.3553483489, 8362.874556881652, 8365.749027529184, 8415.957920210421, 8489.44818586793, 8523.914760852374, 8413.747587572383, 8527.0, 8676.956615216946, 8703.695370662028, 8713.564321783917, 8590.78523036926, 8608.139186081404, 8625.051244363147, 8651.740447786546, 8665.653373865038, 8381.45520541169, 8579.270761985239, 8593.699220527315, 8618.612162452704, 8643.481391116553, 38119.428208576894, 38186.236275274336, 38332.80833595814, 38440.231195375934, 38604.0, 2845.502037143512, 3037.0, 3089.691030896915, 3139.372125574894, 3439.226174110805, 28183.859080704464, 28221.576676349872, 28573.857130714423, 28725.85637071801, 28742.0, 3821.9617803821884, 3878.4182372644045, 4016.016433217739, 4027.7986100694848, 4086.4891888513935, 201536.0, 202120.0, 202218.99999999852, 202324.0, 202627.0, 48171.27743083856, 48924.0, 55569.444305556426, 55831.0, 55870.720646396505, 61253.38746612566, 62361.376386236465, 62535.37464625386, 62607.0, 62798.0, 14031.438742450187, 14042.1574705518, 14127.576172714835, 14181.14913105217, 14230.217338046506, 11193.832092518618, 11225.101991840633, 11234.045106165904, 11251.043661288883, 11255.099592032619, 18928.81071189298, 19101.2359505621, 19210.711839322423, 19681.0, 19799.30702425408, 7607.35337496308, 7847.6468558914985, 7939.722109726132, 7954.204579542, 7967.322777563856, 874.9825003500022, 901.2789768185426, 928.8281667891462, 945.394947233771, 970.0590427285522, 25050.123245686314, 25082.623760643604, 25834.483310334064, 25840.483190336465, 26036.73963260381, 1012.104287705386, 1046.659835553433, 1050.107408702612, 1052.5105825791045, 1109.3066833229232, 13718.794218086736, 13885.86114138866, 15090.24548772557, 15507.0, 15699.607509812346, 295625.0, 295636.0, 299814.0, 300468.0, 301404.0, 49636.50363496391, 50188.749056254484, 50206.0, 50253.24620130701, 50392.0, 1315.3423288355823, 1331.287761047854, 1337.4917531338028, 1347.9663008424673, 1456.2281990545027, 28082.297942550784, 28799.0, 28874.061635226408, 28965.275868103465, 29140.27149321284, 44444.0, 44715.21139154398, 44892.55107448884, 44971.1005779876, 44996.32505512486, 288280.0, 290446.0, 290908.0, 290940.0, 292254.0, 30331.545026825057, 30991.0, 31228.687713122577, 31547.0, 31978.68021319757, 36651.0, 36726.63273367232, 37159.0, 37415.25169496649, 37794.0, 31125.377492450476, 31210.21974450657, 31532.527012095296, 31645.525317119802, 31806.84096579502, 34025.25722170609, 34781.65218347784, 35353.292934140656, 35790.28419431649, 35875.0, 33243.833780830944, 33860.830695846365, 34014.149646259044, 34040.82979585086, 34164.14589635279, 29279.268018299714, 30195.547066794454, 31515.52726709147, 31606.209844753146, 31726.0, 24176.75823241745, 24191.516169676157, 24237.63643545313, 24298.0, 24470.0], "unit": "score", "name": "ext.html", "value": 17503.385430173847}, {"lowerIsBetter": false, "replicates": [363.95996440391554, 364.95438070241204, 365.8335457366898, 366.159663572102, 368.2487725040917, 15658.84341156588, 16098.1950902455, 16375.344986200553, 16988.74516882248, 17439.21523531441, 10213.0297621726, 10510.159187265019, 10527.894721052806, 10856.077233435168, 10925.945370273157, 4880.511948805118, 5007.098722229997, 5015.5486006259425, 5055.696658200502, 5456.399796022454, 5282.445343238962, 5377.4084850666595, 5378.623496355257, 5424.05079111154, 5428.728563571825, 4963.578095861856, 5135.35808023997, 5344.625876188668, 5360.9463905361035, 5408.945910540883, 5184.351956005499, 5225.477452254782, 5273.472652734715, 5639.887202255973, 6131.233595800525, 5397.568194544467, 5404.756785944642, 5412.891742165135, 5418.729063546846, 5423.132298832207, 15104.471343502924, 18918.243270269173, 19438.611227775506, 19472.80527194724, 19808.0, 2058.7323647925673, 2060.1862264405477, 2187.9890600547055, 2192.4299682082774, 2196.7034450349156, 6966.9303306966785, 9455.479948602824, 10267.562541244231, 10823.891761082366, 12378.938105309506, 1668.799744030712, 1743.555393374694, 1797.757302764123, 1855.4875847505818, 1900.5818719881604, 53101.0, 54420.455795441536, 56014.71992640052, 56491.0, 56769.71615141898, 9681.806363872824, 9854.359466634645, 9912.702618921443, 9938.602455901682, 9940.502974851228, 12974.481020759064, 13013.414396352187, 13166.802497962539, 13185.868141318655, 13222.404991775393, 6831.419329357061, 6899.448044156456, 7328.413726901835, 7579.317861392501, 7592.734254301073, 7198.316159964795, 7200.927990720026, 7213.206547279795, 7238.384737297389, 7254.709811607582, 4264.594863487963, 4333.371661109121, 4350.129974005212, 4366.410534577792, 4368.279233926367, 1662.5760431090237, 1737.556922984656, 1755.2276998121042, 1797.2900704221759, 1816.2281030562222, 920.4293338130268, 936.7096200177966, 1002.2583288366557, 1027.3476342522551, 1048.2766890845292, 15684.0, 15733.213339332988, 16105.516834494983, 16510.587235319214, 16601.086940218403, 830.0247209528779, 904.674317245791, 905.8595917632778, 937.5640327247862, 966.6713317472094, 8222.342212622976, 8591.09793471689, 8820.2061814437, 8947.776305592412, 9039.864402033843, 514633.0, 518017.0, 528055.0, 537648.8705338846, 537934.0, 44851.775741121084, 52055.47944520582, 71968.64015679888, 73418.63290683512, 73706.63146684339, 1132.17351333527, 1141.6175581180232, 1147.1511081799574, 1166.912481563886, 1167.8073117935446, 13763.105398149088, 13775.242361670204, 14605.415783368546, 14800.703985920436, 14857.628559286104, 29018.56472152877, 29049.564256536592, 29855.850720746257, 30166.396672066876, 30324.090277291718, 34675.65324346825, 35499.64500354963, 36057.0, 36077.45883811797, 37463.62536374601, 7298.781036568911, 7515.849683006419, 7567.962160189164, 7613.467057306157, 7799.883001755092, 9973.45146016947, 10719.571217151226, 11464.885351146382, 11617.535298587962, 12140.93929530382, 3799.943000855045, 7175.174854891754, 7471.813204669927, 8619.8707019396, 9915.504224788876, 9426.670066547638, 9781.364211326241, 9917.65288214909, 9958.55186516623, 10082.8487572685, 9047.411918225294, 9198.126178013077, 9665.275104367342, 9762.463064531235, 9771.657991970247, 6911.688973996082, 7015.614141222281, 7203.963980180066, 7303.196648368781, 7340.889886651597, 9185.908140918506, 9504.239660827256, 9653.03469653029, 9670.419774813534, 9732.70801875945], "unit": "score", "name": "jquery.html", "value": 7850.133524750684}, {"lowerIsBetter": false, "replicates": [1417.6243295526683, 1428.4000719697726, 1545.1887758926568, 1686.924088416022, 1687.8396552327524, 7387.335139837413, 7536.585487798169, 7553.395728341733, 7836.4906281091835, 8022.358211343093, 8109.351251899849, 8137.593120343989, 8158.224968627986, 8170.959145204266, 8173.264406203441, 2291.5875142474347, 2315.3517015235675, 2321.1063740459876, 2323.907043718249, 2327.55776402483, 2319.93040208794, 2349.612313968193, 2350.2596682045187, 2355.4464700795297, 2358.292512246328, 1990.5720270141917, 2035.9592808143827, 2227.2984010036866, 2308.549832782608, 2334.2180369576213, 2280.6579013147993, 2281.475260690034, 2286.3598192506124, 2289.461976435536, 2295.483516208848, 2266.7393249776324, 2333.4749681321737, 2333.6849525314205, 2333.8366314358, 2337.3922780077132, 7947.960260198662, 8052.557109358983, 8060.435769496137, 8063.395245356622, 8137.75586732399, 4715.740634265114, 4782.665213435061, 4805.063012712522, 4827.0, 4836.443808961979, 2960.6003189569346, 2962.3186667066693, 2962.3482833776534, 2980.3145276586506, 3048.634163900324, 920.5305294299956, 948.6537413843967, 962.2254085461201, 965.5461932891529, 987.1017374189524, 10618.150547956146, 10691.732706682318, 10708.732281692943, 10755.569777208902, 10765.83851242232, 4124.876253712333, 4154.189932963043, 4175.83296668136, 4186.937195942063, 4282.614564689193, 8676.956615216883, 8698.434601750865, 8710.085441028728, 8767.605457754416, 8776.385653004356, 4729.030548737501, 4732.124556956974, 4744.5492678195515, 4753.191957367256, 4757.619390448755, 4336.588024137702, 4350.1734670412525, 4355.695101342875, 4372.23485889968, 4381.956180438218, 3510.227749895019, 3514.806685632315, 3516.6834984851484, 3530.894073177809, 3544.8936531904083, 1070.357785328812, 1095.1293721491434, 1097.1771171621283, 1097.3415950429678, 1101.5593762494907, 864.4856310495245, 923.7598224461689, 969.0503306759415, 1026.973026973027, 1195.8325834383193, 7013.544119632207, 7217.530860494051, 7231.529950553302, 7235.2764723527225, 7238.348548630648, 609.4697613076563, 620.0358442621676, 626.7148447456397, 629.8677277771627, 764.8947271193184, 5561.63849349791, 5594.24477695514, 5644.8871022579315, 5655.236543066633, 5662.320521537442, 9251.352405331561, 9680.854787178198, 9700.805983880284, 9709.563069661883, 9716.708498745049, 9369.859452108223, 9526.476043817518, 9541.427514349023, 9644.421334719798, 9646.18007469359, 7339.412846972229, 7351.485396022227, 7464.626768661546, 7486.251374862471, 7544.396448284124, 7213.855722885408, 7284.307990740871, 7311.524750891388, 7339.229380915141, 7354.558726476214, 8478.728190771433, 8563.785905352415, 8759.91240087591, 8873.112688731333, 8940.195382415613, 8868.600912958804, 8869.955650221707, 8886.511241881759, 8942.06108358613, 9031.412958157698, 6834.624095674786, 6858.5199036067, 6871.209810871814, 6990.0, 7146.857062858818, 7617.619119044137, 7675.462717609714, 7680.0, 7680.846383072419, 7685.538867667958, 7002.7899163025195, 7047.224805271519, 7074.504784665024, 7144.3927266182955, 7183.928160718326, 6220.377962203744, 6896.448284137357, 6914.55055421396, 7016.263292354433, 7055.470839686941, 6620.0, 6704.329567043256, 6767.221769496571, 6813.318668133147, 6820.454363650995, 6061.7575296987625, 6159.692015399301, 6164.599301045418, 6168.722407491584, 6173.9073913892225, 6103.938960610337, 6230.844228894314, 6237.5009999200865, 6255.093011513214, 6260.968695156495], "unit": "score", "name": "mootools.html", "value": 4395.959627877977}, {"lowerIsBetter": false, "replicates": [333.2302381498738, 334.909574414908, 337.6724577160154, 345.2077482178401, 345.57321707691, 6230.84422889428, 6297.937020629793, 6354.745810167594, 6377.6173429594255, 6481.027845823129, 6255.906161407571, 6297.181366422359, 6311.621302721828, 6312.526560507958, 6317.810465686037, 4801.855944321667, 4804.111239420701, 4805.927911081337, 4806.0, 4806.086843499741, 4791.3531673224015, 4797.7840997155035, 4797.808087676506, 4804.567588916997, 4807.879803004936, 4654.255319148937, 4763.833265835697, 4767.1657459944545, 4767.451743049559, 4767.880802979918, 4750.762461876927, 4754.904901901978, 4756.9286460703115, 4758.738269395182, 4761.761911904408, 4133.173365326947, 4145.357469592218, 4146.979265103655, 4153.190127925056, 4163.604457576525, 5980.372060933583, 6002.189704389895, 6004.159417681484, 6007.0, 6012.909806352908, 5423.918641220384, 5552.472515111058, 5557.360903496069, 5564.415736347666, 5567.47109024642, 6536.444402225817, 6601.63690996995, 6625.238097618787, 6632.469402447792, 6657.7669781557415, 4583.175028494869, 4587.7706114694465, 4589.655775816794, 4590.678652494326, 4598.126355992351, 6796.864062718718, 6884.311568843075, 6928.722851086001, 6956.408705260059, 6963.442924566022, 4644.047970166108, 4645.9303110453375, 4652.13935421948, 4653.837115700934, 4657.0, 4670.042641258534, 4692.741899195577, 4695.671303008757, 4714.740689262055, 4723.716577005391, 5397.2443857859935, 5464.426235245242, 5478.726063696799, 5515.531179849758, 5518.724063796794, 6623.602583844985, 6674.866502669919, 6705.564138330993, 6706.966465167643, 6707.396334329934, 1627.113223293308, 1651.6531528379176, 1666.5500314915148, 1667.3664007677005, 1673.9246733897003, 1072.3083611070972, 1079.794838980591, 1104.867415910096, 1109.6005438042298, 1110.3282514079028, 6135.785247516315, 6174.25908890936, 6181.690915454209, 6217.751289948352, 6239.937600624026, 6733.293004234582, 6733.562318449285, 6784.151981002375, 6787.932120678829, 6805.115335006517, 6123.9387606124255, 6171.84570385744, 6190.566660333823, 6209.59637623553, 6220.657863817533, 3678.179301245847, 3693.7229707772026, 3700.7232504785807, 3702.833372498244, 3704.6665800077585, 7041.964790176016, 7051.1186101737285, 7103.076600041962, 7107.715691372287, 7128.108986376703, 6727.360900714424, 6902.654867256617, 6912.965435172792, 6917.13535808024, 6933.1333583302085, 7069.469789765788, 7072.504924655224, 7114.928850711427, 7115.786526404217, 7126.35862772353, 6742.69657865407, 6745.055692202997, 6766.4248538874745, 6797.490188236001, 6802.183737951477, 6557.770478033246, 6703.0, 6736.966315168393, 6742.6628668567355, 6743.15710536183, 7055.223925368103, 7060.364567188978, 7083.291670833081, 7109.324614161646, 7116.928830711627, 4610.608098311681, 4631.282151266559, 4643.257078867365, 4644.674872758875, 4655.4180727409075, 6757.493188011017, 6770.898436523555, 6771.3905748482875, 6787.151606049244, 6904.792856214322, 6752.459803215633, 6761.594304341756, 6762.289959554176, 6778.118844550177, 6800.591964482147, 6707.966460167668, 6717.328267173439, 6739.05653208561, 6750.5274630775375, 6784.423324017514, 6454.5159113065765, 6615.603063815994, 6643.601383916787, 6648.5678430901835, 6650.966745166436, 6745.089412929192, 6753.3921947025, 6761.425278851156, 6788.7284508619105, 6830.214525329452, 6555.2789193189665, 6563.442107420732, 6572.981187915881, 6583.736650534117, 6625.0], "unit": "score", "name": "prototype.html", "value": 4988.371520579706}, {"lowerIsBetter": false, "replicates": [675.3314218923265, 705.5096707788086, 721.2967356827094, 733.2740586819049, 769.8691222492175, 12873.098883078188, 12990.28553429561, 13039.804402933953, 13041.152325098874, 13045.347732613354, 11186.105111591074, 11188.160887933396, 11190.66428007159, 11196.0, 11224.775504489906, 564.2946317103621, 569.6382796923941, 772.4399810137647, 775.1008829757483, 779.4388040610751, 751.8233215194425, 776.6000509737489, 777.2227772227773, 777.8988731464901, 778.0468925566192, 804.5213098206586, 808.9595520223995, 812.273015650992, 817.9018517777874, 818.1409520004001, 794.1899262751989, 802.2338666573438, 804.0271271761176, 807.3621838747412, 808.6037841457702, 589.228111174363, 592.4667798980909, 593.1636392686335, 593.6823799267371, 595.7468076067697, 11734.765304693858, 11846.111541634413, 11848.585299514561, 11864.703382415422, 11900.345480998541, 11866.347350895698, 12673.112882098258, 12685.873141268561, 12715.87284127156, 12950.352482375843, 9067.546622668906, 9289.814203715956, 9397.812043759155, 9410.294227932933, 9431.339806213567, 3546.556680414948, 3579.1767893384667, 3600.981995090034, 3691.667749902495, 3700.1674623209833, 46161.53838461606, 46235.30647040263, 46366.30450543245, 46740.0, 47642.5235747645, 9964.25268104895, 10072.697819065439, 10089.041541053588, 10193.490325483695, 10227.7443063924, 17379.91310043467, 17498.737518937225, 17561.034143121997, 17605.295788168587, 17608.295668173385, 7388.778336649909, 7524.435667324863, 7670.117936437269, 7695.076590809139, 7747.651355689008, 4120.587941205916, 4155.085881106152, 4163.084121493267, 4176.728512646729, 4303.397524346594, 2937.500624893773, 2963.8962636308056, 2968.346963668033, 2984.492636251842, 2996.2509372656837, 552.111101127185, 570.0337927213334, 571.5741772379521, 577.9219805326311, 580.756082445374, 514.6680391147689, 525.7528961388141, 574.6781802190786, 632.3170975346615, 678.1895634716467, 8243.25810677042, 8380.622871970776, 8739.344549158839, 8851.291896648252, 9331.253499720005, 506.25327641728154, 518.3598256153647, 520.0223579670196, 563.7829435667297, 590.5688847141611, 3770.8680196193, 3772.962270377316, 3851.788151651686, 3876.592957739453, 3928.6660633846445, 51827.74086129621, 54430.727846361304, 55197.0, 55252.447475525536, 55422.0, 46719.76640116778, 48651.75674121678, 48807.75596121997, 49447.0, 49524.25713614299, 44388.3341749874, 44952.55047449549, 45121.0, 46664.533354666695, 46722.76638616853, 8651.221390074923, 8742.256908162877, 8898.73303800887, 8946.642134314554, 8959.372843900865, 34635.0, 35411.645883540834, 35857.0, 35887.46168807522, 36311.63688363188, 40988.385174223, 41108.79445602753, 42917.0, 44895.77552112219, 45525.089498209185, 10456.902025287236, 10784.892151078702, 10905.727356816144, 11055.889441105486, 11070.39112848801, 12398.380080996094, 12442.129050966707, 12763.808542871679, 12794.488220471078, 12835.935820321212, 11084.445777711244, 11104.444777760918, 11254.0, 11383.829242561535, 11855.288682679067, 11034.172437067413, 11263.380514071478, 11287.266327688674, 11407.885921140682, 11836.644900652995, 10247.94876025645, 10445.738856528344, 10560.471976400995, 10586.311889727143, 10655.57377704883, 9270.351075424656, 9338.766530836783, 9407.0, 9439.150476457151, 9501.192398646193, 8739.38824282294, 8958.462492250486, 9333.346665733334, 9583.281253905845, 9601.231901448007], "unit": "score", "name": "yui.html", "value": 6047.410477472805}], "name": "dromaeo_css", "value": 6761.978521000914}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 113.0, 111.0, 112.0, 121.0, 110.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [155.0, 128.0, 152.0, 166.0, 135.0, 157.0, 150.0, 131.0, 168.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 161.0, 163.0, 162.0, 159.0, 162.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 76.0, 73.0, 73.0, 142.0, 74.0, 76.0, 75.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 142.0, 96.0, 96.0, 95.0, 144.0, 97.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 116.0, 115.0, 115.0, 115.0, 115.0, 116.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.0}, {"lowerIsBetter": true, "replicates": [149.0, 150.0, 149.0, 151.0, 150.0, 151.0, 150.0, 150.0, 149.0, 158.0], "unit": "score", "name": "imaging-darkroom", "value": 150.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 102.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 61.0, 61.0, 62.0, 60.0, 60.0, 60.0, 70.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 61.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 72.0, 67.0, 69.0, 67.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [81.0, 87.0, 83.0, 84.0, 83.0, 83.0, 81.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [117.0, 122.0, 127.0, 123.0, 116.0, 121.0, 120.0, 114.0, 130.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [141.0, 142.0, 136.0, 146.0, 141.0, 133.0, 147.0, 142.0, 142.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.9}, {"lowerIsBetter": true, "replicates": [74.0, 70.0, 71.0, 73.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1521.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.77785190126752], "unit": "score", "name": "Richards", "value": 211.67079199999998}, {"lowerIsBetter": false, "replicates": [189.8614011771407], "unit": "score", "name": "DeltaBlue", "value": 348.24350599999997}, {"lowerIsBetter": false, "replicates": [274.19797093501506], "unit": "score", "name": "Encrypt", "value": 970.762107}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [1074.1138560687432], "unit": "score", "name": "RayTrace", "value": 688.9297590000002}, {"lowerIsBetter": false, "replicates": [737.4631268436578], "unit": "score", "name": "Earley", "value": 903.7238279999999}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [41160.0], "unit": "score", "name": "RegExp", "value": 22.132774538386794}, {"lowerIsBetter": false, "replicates": [629.8377028714108], "unit": "score", "name": "Splay", "value": 129.384124876115}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20200.25791989963}]} 06:13:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20200.26"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1521.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6761.98"}}} 06:13:08 INFO - Return code: 0 06:13:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:13:08 INFO - # TBPL SUCCESS # 06:13:08 INFO - Running post-action listener: _resource_record_post_action 06:13:08 INFO - Running post-run listener: _resource_record_post_run 06:13:09 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 20480; Write bytes: 549834752; Read time: 364; Write time: 783364 06:13:09 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 236306432; Read time: 0; Write time: 428048 06:13:09 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 313528320; Read time: 364; Write time: 355316 06:13:09 INFO - Running post-run listener: _upload_blobber_files 06:13:09 INFO - Blob upload gear active. 06:13:09 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:13:09 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 06:13:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:13:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:13:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:13:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:13:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:11 INFO - (blobuploader) - INFO - Done attempting. 06:13:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:13:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:13:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:12 INFO - (blobuploader) - INFO - Done attempting. 06:13:12 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:12 INFO - Return code: 0 06:13:12 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:13:12 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/380bb752b2d9b8495f0084dcb44eaa11cc6a8b2b8c71976789b2fd2bcd69ff8efbdf54ee55f92b75c45c9e67453fbb7d206290dfc228baff46c2368741a85d74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/874cfb3debf12d29721fb0534b34bd96d06818fc99200bfb9838ddbd883c6791f6dfb332797d9daaccaa54e98a54a7f8d6eb29882ed9df5f7ab065a469a16d45"} 06:13:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:13:12 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:13:12 INFO - Contents: 06:13:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/380bb752b2d9b8495f0084dcb44eaa11cc6a8b2b8c71976789b2fd2bcd69ff8efbdf54ee55f92b75c45c9e67453fbb7d206290dfc228baff46c2368741a85d74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/874cfb3debf12d29721fb0534b34bd96d06818fc99200bfb9838ddbd883c6791f6dfb332797d9daaccaa54e98a54a7f8d6eb29882ed9df5f7ab065a469a16d45"} 06:13:12 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:12 INFO - Copying logs to upload dir... 06:13:12 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:13:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.223086 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-27 06:13:11.870343) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 06:13:11.874084) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/380bb752b2d9b8495f0084dcb44eaa11cc6a8b2b8c71976789b2fd2bcd69ff8efbdf54ee55f92b75c45c9e67453fbb7d206290dfc228baff46c2368741a85d74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/874cfb3debf12d29721fb0534b34bd96d06818fc99200bfb9838ddbd883c6791f6dfb332797d9daaccaa54e98a54a7f8d6eb29882ed9df5f7ab065a469a16d45"} build_url:https://queue.taskcluster.net/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/T_IB7BHDQWeRLwToxUY1KQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/380bb752b2d9b8495f0084dcb44eaa11cc6a8b2b8c71976789b2fd2bcd69ff8efbdf54ee55f92b75c45c9e67453fbb7d206290dfc228baff46c2368741a85d74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/874cfb3debf12d29721fb0534b34bd96d06818fc99200bfb9838ddbd883c6791f6dfb332797d9daaccaa54e98a54a7f8d6eb29882ed9df5f7ab065a469a16d45"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 06:13:11.898931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 06:13:11.899267) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453901893.185001-815162689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 06:13:11.987313) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 06:13:11.987696) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 06:13:11.988201) ========= ========= Total master_lag: 0.30 =========