builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1453521080.94 results: success (0) buildid: 20160122173005 builduid: 3ee8159f7f8a4a09b0d872f4b0a830f3 revision: be005c69fbb61cfb10e544c0a6a0b9d5e6193a81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:20.938445) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:20.938981) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:20.939367) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006265 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:20.964228) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:20.964576) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:20.993042) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:20.993498) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:21.044267) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:21.044627) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:21.045059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:21.045428) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 19:51:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.4M=0s 2016-01-22 19:51:21 (77.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163223 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:21.221563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:21.221968) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014942 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:21.272591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:21.273002) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev be005c69fbb61cfb10e544c0a6a0b9d5e6193a81 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev be005c69fbb61cfb10e544c0a6a0b9d5e6193a81 --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=edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 19:51:21,527 truncating revision to first 12 chars 2016-01-22 19:51:21,527 Setting DEBUG logging. 2016-01-22 19:51:21,527 attempt 1/10 2016-01-22 19:51:21,527 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/be005c69fbb6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 19:51:21,805 unpacking tar archive at: fx-team-be005c69fbb6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571777 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:21.858086) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:21.858452) ========= echo be005c69fbb61cfb10e544c0a6a0b9d5e6193a81 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'be005c69fbb61cfb10e544c0a6a0b9d5e6193a81'] 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=edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False be005c69fbb61cfb10e544c0a6a0b9d5e6193a81 program finished with exit code 0 elapsedTime=0.004219 script_repo_revision: 'be005c69fbb61cfb10e544c0a6a0b9d5e6193a81' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:21.909829) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:21.910151) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 19:51:21.920952) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-22 19:51:21.921264) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:51:22 INFO - MultiFileLogger online at 20160122 19:51:22 in /builds/slave/test-pgo 19:51:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:51:22 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:51:22 INFO - {'append_to_log': False, 19:51:22 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:51:22 INFO - 'blob_upload_branch': 'Fx-Team', 19:51:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:51:22 INFO - 'branch': 'Fx-Team', 19:51:22 INFO - 'buildbot_json_path': 'buildprops.json', 19:51:22 INFO - 'config_files': ('talos/linux_config.py',), 19:51:22 INFO - 'default_actions': ('clobber', 19:51:22 INFO - 'read-buildbot-config', 19:51:22 INFO - 'download-and-extract', 19:51:22 INFO - 'populate-webroot', 19:51:22 INFO - 'create-virtualenv', 19:51:22 INFO - 'install', 19:51:22 INFO - 'run-tests'), 19:51:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:51:22 INFO - 'download_minidump_stackwalk': True, 19:51:22 INFO - 'download_symbols': 'ondemand', 19:51:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:51:22 INFO - 'tooltool.py': '/tools/tooltool.py', 19:51:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:51:22 INFO - '/tools/misc-python/virtualenv.py')}, 19:51:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:51:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:51:22 INFO - 'installer_path': 'installer.exe', 19:51:22 INFO - 'log_level': 'info', 19:51:22 INFO - 'log_name': 'talos', 19:51:22 INFO - 'log_to_console': True, 19:51:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:51:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:51:22 INFO - 'opt_config_files': (), 19:51:22 INFO - 'pip_index': False, 19:51:22 INFO - 'sps_profile': False, 19:51:22 INFO - 'sps_profile_interval': 0, 19:51:22 INFO - 'suite': 'dromaeojs', 19:51:22 INFO - 'system_bits': '32', 19:51:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:51:22 INFO - 'title': 'talos-linux64-ix-033', 19:51:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:51:22 INFO - 'use_talos_json': True, 19:51:22 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:51:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:51:22 INFO - 'work_dir': 'build'} 19:51:22 INFO - ##### 19:51:22 INFO - ##### Running clobber step. 19:51:22 INFO - ##### 19:51:22 INFO - Running pre-action listener: _resource_record_pre_action 19:51:22 INFO - Running main action method: clobber 19:51:22 INFO - rmtree: /builds/slave/test-pgo/build 19:51:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:51:23 INFO - Running post-action listener: _resource_record_post_action 19:51:23 INFO - ##### 19:51:23 INFO - ##### Running read-buildbot-config step. 19:51:23 INFO - ##### 19:51:23 INFO - Running pre-action listener: _resource_record_pre_action 19:51:23 INFO - Running main action method: read_buildbot_config 19:51:23 INFO - Using buildbot properties: 19:51:23 INFO - { 19:51:23 INFO - "project": "", 19:51:23 INFO - "product": "firefox", 19:51:23 INFO - "script_repo_revision": "production", 19:51:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:51:23 INFO - "repository": "", 19:51:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:51:23 INFO - "buildid": "20160122173005", 19:51:23 INFO - "pgo_build": "True", 19:51:23 INFO - "basedir": "/builds/slave/test-pgo", 19:51:23 INFO - "buildnumber": 441, 19:51:23 INFO - "slavename": "talos-linux64-ix-033", 19:51:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:51:23 INFO - "platform": "ubuntu64_hw", 19:51:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:51:23 INFO - "branch": "fx-team", 19:51:23 INFO - "repo_path": "integration/fx-team", 19:51:23 INFO - "revision": "be005c69fbb61cfb10e544c0a6a0b9d5e6193a81", 19:51:23 INFO - "stage_platform": "linux64-pgo", 19:51:23 INFO - "builduid": "3ee8159f7f8a4a09b0d872f4b0a830f3", 19:51:23 INFO - "slavebuilddir": "test" 19:51:23 INFO - } 19:51:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:51:23 INFO - Running post-action listener: _resource_record_post_action 19:51:23 INFO - ##### 19:51:23 INFO - ##### Running download-and-extract step. 19:51:23 INFO - ##### 19:51:23 INFO - Running pre-action listener: _resource_record_pre_action 19:51:23 INFO - Running main action method: download_and_extract 19:51:23 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:51: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')]} 19:51:23 INFO - https://queue.taskcluster.net/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/test_packages.json 19:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/test_packages.json 19:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:51:23 INFO - Downloaded 1448 bytes. 19:51:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:51:23 INFO - Using the following test package requirements: 19:51:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:51:23 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:51:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'jsshell-linux-x86_64.zip'], 19:51:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:51:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:51:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:51:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:51:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:51:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:51: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')]} 19:51:23 INFO - https://queue.taskcluster.net/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:51:25 INFO - Downloaded 22488787 bytes. 19:51:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:51:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:51:26 INFO - Return code: 0 19:51:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:51: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')]} 19:51:26 INFO - https://queue.taskcluster.net/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:51:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:51:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:51:29 INFO - Downloaded 22488787 bytes. 19:51:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:51:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:51:30 INFO - Return code: 0 19:51:30 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')]} 19:51:30 INFO - https://queue.taskcluster.net/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:51:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:51:31 INFO - Downloaded 10706572 bytes. 19:51:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:51:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:51:32 INFO - Return code: 0 19:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:32 INFO - https://queue.taskcluster.net/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:51:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:51:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:51:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:51:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:51:33 INFO - Downloaded 55958949 bytes. 19:51:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:51:33 INFO - mkdir: /builds/slave/test-pgo/properties 19:51:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:51:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:51:33 INFO - Contents: 19:51:33 INFO - build_url:https://queue.taskcluster.net/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:51:33 INFO - Running post-action listener: _resource_record_post_action 19:51:33 INFO - Running post-action listener: set_extra_try_arguments 19:51:33 INFO - ##### 19:51:33 INFO - ##### Running populate-webroot step. 19:51:33 INFO - ##### 19:51:33 INFO - Running pre-action listener: _resource_record_pre_action 19:51:33 INFO - Running main action method: populate_webroot 19:51:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:51:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:51:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:51:33 INFO - '--tppagecycles', 19:51:33 INFO - '7'], 19:51:33 INFO - 'tests': ['tsvgm']}}, 19:51:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:51:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:51:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:51:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:51:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:51:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:51:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:33 INFO - 'talos_options': ['--e10s'], 19:51:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:33 INFO - 'tests': ['damp', 'tps']}, 19:51:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:33 INFO - 'talos_options': ['--e10s'], 19:51:33 INFO - 'tests': ['damp', 'tps']}, 19:51:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:51:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:51:33 INFO - 'other': {'tests': ['a11yr', 19:51:33 INFO - 'ts_paint', 19:51:33 INFO - 'tpaint', 19:51:33 INFO - 'sessionrestore', 19:51:33 INFO - 'sessionrestore_no_auto_restore']}, 19:51:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:51:33 INFO - 'tests': ['a11yr', 19:51:33 INFO - 'ts_paint', 19:51:33 INFO - 'tpaint', 19:51:33 INFO - 'sessionrestore', 19:51:33 INFO - 'sessionrestore_no_auto_restore']}, 19:51:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:51:33 INFO - 'tests': ['a11yr', 19:51:33 INFO - 'ts_paint', 19:51:33 INFO - 'tpaint', 19:51:33 INFO - 'sessionrestore', 19:51:33 INFO - 'sessionrestore_no_auto_restore']}, 19:51:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:51:33 INFO - 'tests': ['a11yr', 19:51:33 INFO - 'ts_paint', 19:51:33 INFO - 'tpaint', 19:51:33 INFO - 'sessionrestore', 19:51:33 INFO - 'sessionrestore_no_auto_restore']}, 19:51:33 INFO - 'other_l64': {'tests': ['a11yr', 19:51:33 INFO - 'ts_paint', 19:51:33 INFO - 'tpaint', 19:51:33 INFO - 'sessionrestore', 19:51:33 INFO - 'sessionrestore_no_auto_restore']}, 19:51:33 INFO - 'other_nol64': {'tests': ['a11yr', 19:51:33 INFO - 'ts_paint', 19:51:33 INFO - 'tpaint', 19:51:33 INFO - 'sessionrestore', 19:51:33 INFO - 'sessionrestore_no_auto_restore']}, 19:51:33 INFO - 'svgr': {'tests': ['tsvgx', 19:51:33 INFO - 'tsvgr_opacity', 19:51:33 INFO - 'tart', 19:51:33 INFO - 'tscrollx', 19:51:33 INFO - 'cart']}, 19:51:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:51:33 INFO - 'tests': ['tsvgx', 19:51:33 INFO - 'tsvgr_opacity', 19:51:33 INFO - 'tart', 19:51:33 INFO - 'tscrollx', 19:51:33 INFO - 'cart']}, 19:51:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:33 INFO - 'tests': ['tp5o']}, 19:51:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:33 INFO - 'talos_options': ['--e10s'], 19:51:33 INFO - 'tests': ['tp5o']}, 19:51:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:33 INFO - 'talos_options': ['--xperf_path', 19:51:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:33 INFO - 'tests': ['tp5n']}, 19:51:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:33 INFO - 'talos_options': ['--e10s', 19:51:33 INFO - '--xperf_path', 19:51:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:33 INFO - 'tests': ['tp5n']}}, 19:51:33 INFO - 'talos.zip': {'path': '', 19:51:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:51:33 INFO - Running post-action listener: _resource_record_post_action 19:51:33 INFO - ##### 19:51:33 INFO - ##### Running create-virtualenv step. 19:51:33 INFO - ##### 19:51:33 INFO - Running pre-action listener: _resource_record_pre_action 19:51:33 INFO - Running main action method: create_virtualenv 19:51:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:51:33 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 19:51:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:51:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:51:33 INFO - Using real prefix '/usr' 19:51:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:51:34 INFO - Installing distribute.............................................................................................................................................................................................done. 19:51:35 INFO - Installing pip.................done. 19:51:36 INFO - Return code: 0 19:51:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:51: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')]} 19:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff659fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391840>, '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 0x22fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22feb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', '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 19:51: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:51: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 pip>=1.5 19:51:36 INFO - Using env: {'DISPLAY': ':0', 19:51:36 INFO - 'HOME': '/home/cltbld', 19:51:36 INFO - 'LANG': 'en_US.UTF-8', 19:51:36 INFO - 'LANGUAGE': 'en_US:en', 19:51:36 INFO - 'LOGNAME': 'cltbld', 19:51:36 INFO - 'MAIL': '/var/mail/cltbld', 19:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:36 INFO - 'MOZ_NO_REMOTE': '1', 19:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:36 INFO - 'NO_EM_RESTART': '1', 19:51:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:36 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:36 INFO - 'SHELL': '/bin/bash', 19:51:36 INFO - 'SHLVL': '1', 19:51:36 INFO - 'TERM': 'linux', 19:51:36 INFO - 'TMOUT': '86400', 19:51:36 INFO - 'USER': 'cltbld', 19:51:36 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', 19:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:36 INFO - '_': '/tools/buildbot/bin/python'} 19:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:36 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 19:51:36 INFO - Cleaning up... 19:51:36 INFO - Return code: 0 19:51:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:51: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')]} 19:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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', '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 0x7ff659fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391840>, '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 0x22fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22feb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', '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 19:51: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:51: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 psutil>=0.7.1 19:51:36 INFO - Using env: {'DISPLAY': ':0', 19:51:36 INFO - 'HOME': '/home/cltbld', 19:51:36 INFO - 'LANG': 'en_US.UTF-8', 19:51:36 INFO - 'LANGUAGE': 'en_US:en', 19:51:36 INFO - 'LOGNAME': 'cltbld', 19:51:36 INFO - 'MAIL': '/var/mail/cltbld', 19:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:36 INFO - 'MOZ_NO_REMOTE': '1', 19:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:36 INFO - 'NO_EM_RESTART': '1', 19:51:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:36 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:36 INFO - 'SHELL': '/bin/bash', 19:51:36 INFO - 'SHLVL': '1', 19:51:36 INFO - 'TERM': 'linux', 19:51:36 INFO - 'TMOUT': '86400', 19:51:36 INFO - 'USER': 'cltbld', 19:51:36 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', 19:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:36 INFO - '_': '/tools/buildbot/bin/python'} 19:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:36 INFO - Downloading/unpacking psutil>=0.7.1 19:51: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 19:51: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 19:51: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 19:51: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 19:51: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 19:51: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 19:51:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:51:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:38 INFO - Installing collected packages: psutil 19:51:38 INFO - Running setup.py install for psutil 19:51:38 INFO - building 'psutil._psutil_linux' extension 19:51:38 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 19:51:38 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 19:51:38 INFO - building 'psutil._psutil_posix' extension 19:51:38 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 19:51:38 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 19:51:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:38 INFO - Successfully installed psutil 19:51:38 INFO - Cleaning up... 19:51:38 INFO - Return code: 0 19:51:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:51:38 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')]} 19:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:38 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')]} 19:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:38 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 0x7ff659fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391840>, '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 0x22fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22feb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', '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 19:51:38 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 19:51:38 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 19:51:38 INFO - Using env: {'DISPLAY': ':0', 19:51:38 INFO - 'HOME': '/home/cltbld', 19:51:38 INFO - 'LANG': 'en_US.UTF-8', 19:51:38 INFO - 'LANGUAGE': 'en_US:en', 19:51:38 INFO - 'LOGNAME': 'cltbld', 19:51:38 INFO - 'MAIL': '/var/mail/cltbld', 19:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:38 INFO - 'MOZ_NO_REMOTE': '1', 19:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:38 INFO - 'NO_EM_RESTART': '1', 19:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:38 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:38 INFO - 'SHELL': '/bin/bash', 19:51:38 INFO - 'SHLVL': '1', 19:51:38 INFO - 'TERM': 'linux', 19:51:38 INFO - 'TMOUT': '86400', 19:51:38 INFO - 'USER': 'cltbld', 19:51:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', 19:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:38 INFO - '_': '/tools/buildbot/bin/python'} 19:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:51:39 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 19:51:39 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 19:51:39 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 19:51:39 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 19:51:39 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 19:51:39 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 19:51:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:51:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:51:40 INFO - Installing collected packages: mozsystemmonitor 19:51:40 INFO - Running setup.py install for mozsystemmonitor 19:51:40 INFO - Successfully installed mozsystemmonitor 19:51:40 INFO - Cleaning up... 19:51:41 INFO - Return code: 0 19:51:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff659fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391840>, '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 0x22fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22feb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', '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 19:51:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:51:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:51:41 INFO - Using env: {'DISPLAY': ':0', 19:51:41 INFO - 'HOME': '/home/cltbld', 19:51:41 INFO - 'LANG': 'en_US.UTF-8', 19:51:41 INFO - 'LANGUAGE': 'en_US:en', 19:51:41 INFO - 'LOGNAME': 'cltbld', 19:51:41 INFO - 'MAIL': '/var/mail/cltbld', 19:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:41 INFO - 'MOZ_NO_REMOTE': '1', 19:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:41 INFO - 'NO_EM_RESTART': '1', 19:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:41 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:41 INFO - 'SHELL': '/bin/bash', 19:51:41 INFO - 'SHLVL': '1', 19:51:41 INFO - 'TERM': 'linux', 19:51:41 INFO - 'TMOUT': '86400', 19:51:41 INFO - 'USER': 'cltbld', 19:51:41 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', 19:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:41 INFO - '_': '/tools/buildbot/bin/python'} 19:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:41 INFO - Downloading/unpacking blobuploader==1.2.4 19:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:42 INFO - Downloading blobuploader-1.2.4.tar.gz 19:51:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:51:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:51:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:43 INFO - Downloading docopt-0.6.1.tar.gz 19:51:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:51:43 INFO - Installing collected packages: blobuploader, requests, docopt 19:51:43 INFO - Running setup.py install for blobuploader 19:51:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:51:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:51:43 INFO - Running setup.py install for requests 19:51:44 INFO - Running setup.py install for docopt 19:51:44 INFO - Successfully installed blobuploader requests docopt 19:51:44 INFO - Cleaning up... 19:51:44 INFO - Return code: 0 19:51:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:44 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 0x7ff659fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391840>, '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 0x22fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22feb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', '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 19:51:44 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 19:51:44 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 19:51:44 INFO - Using env: {'DISPLAY': ':0', 19:51:44 INFO - 'HOME': '/home/cltbld', 19:51:44 INFO - 'LANG': 'en_US.UTF-8', 19:51:44 INFO - 'LANGUAGE': 'en_US:en', 19:51:44 INFO - 'LOGNAME': 'cltbld', 19:51:44 INFO - 'MAIL': '/var/mail/cltbld', 19:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:44 INFO - 'MOZ_NO_REMOTE': '1', 19:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:44 INFO - 'NO_EM_RESTART': '1', 19:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:44 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:44 INFO - 'SHELL': '/bin/bash', 19:51:44 INFO - 'SHLVL': '1', 19:51:44 INFO - 'TERM': 'linux', 19:51:44 INFO - 'TMOUT': '86400', 19:51:44 INFO - 'USER': 'cltbld', 19:51:44 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', 19:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:44 INFO - '_': '/tools/buildbot/bin/python'} 19:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:44 INFO - Running setup.py (path:/tmp/pip-WRkbYU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:44 INFO - Running setup.py (path:/tmp/pip-CfIYd2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:44 INFO - Running setup.py (path:/tmp/pip-fogS5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:44 INFO - Running setup.py (path:/tmp/pip-eqfO1G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:44 INFO - Running setup.py (path:/tmp/pip-dFrxKd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:44 INFO - Running setup.py (path:/tmp/pip-aOtoHe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:44 INFO - Running setup.py (path:/tmp/pip-ABKDmc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:44 INFO - Running setup.py (path:/tmp/pip-hbFoQ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:45 INFO - Running setup.py (path:/tmp/pip-Hl3gVt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:45 INFO - Running setup.py (path:/tmp/pip-SoSSLY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:45 INFO - Running setup.py (path:/tmp/pip-j7qzwA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:45 INFO - Running setup.py (path:/tmp/pip-jl08Kl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:45 INFO - Running setup.py (path:/tmp/pip-R9iABV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:45 INFO - Running setup.py (path:/tmp/pip-nCDbIs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:45 INFO - Running setup.py (path:/tmp/pip-DxcKOD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:45 INFO - Running setup.py (path:/tmp/pip-qj6CcU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:45 INFO - Running setup.py (path:/tmp/pip-Mk3VF9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:51:45 INFO - Running setup.py install for manifestparser 19:51:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:51:45 INFO - Running setup.py install for mozcrash 19:51:45 INFO - Running setup.py install for mozdebug 19:51:46 INFO - Running setup.py install for mozdevice 19:51:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:51:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:51:46 INFO - Running setup.py install for mozfile 19:51:46 INFO - Running setup.py install for mozhttpd 19:51:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:51:46 INFO - Running setup.py install for mozinfo 19:51:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:51:46 INFO - Running setup.py install for mozInstall 19:51:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:51:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:51:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:51:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:51:46 INFO - Running setup.py install for mozleak 19:51:46 INFO - Running setup.py install for mozlog 19:51:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:51:46 INFO - Running setup.py install for moznetwork 19:51:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:51:46 INFO - Running setup.py install for mozprocess 19:51:46 INFO - Running setup.py install for mozprofile 19:51:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:51:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:51:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:51:47 INFO - Running setup.py install for mozrunner 19:51:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:51:47 INFO - Running setup.py install for mozscreenshot 19:51:47 INFO - Running setup.py install for moztest 19:51:47 INFO - Running setup.py install for mozversion 19:51:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:51:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:51:47 INFO - Cleaning up... 19:51:47 INFO - Return code: 0 19:51:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:47 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 0x7ff659fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391840>, '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 0x22fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22feb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', '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 19:51:47 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 19:51:47 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 19:51:47 INFO - Using env: {'DISPLAY': ':0', 19:51:47 INFO - 'HOME': '/home/cltbld', 19:51:47 INFO - 'LANG': 'en_US.UTF-8', 19:51:47 INFO - 'LANGUAGE': 'en_US:en', 19:51:47 INFO - 'LOGNAME': 'cltbld', 19:51:47 INFO - 'MAIL': '/var/mail/cltbld', 19:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:47 INFO - 'MOZ_NO_REMOTE': '1', 19:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:47 INFO - 'NO_EM_RESTART': '1', 19:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:47 INFO - 'SHELL': '/bin/bash', 19:51:47 INFO - 'SHLVL': '1', 19:51:47 INFO - 'TERM': 'linux', 19:51:47 INFO - 'TMOUT': '86400', 19:51:47 INFO - 'USER': 'cltbld', 19:51:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', 19:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:47 INFO - '_': '/tools/buildbot/bin/python'} 19:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:47 INFO - Running setup.py (path:/tmp/pip-5yz7Is-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:47 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)) 19:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:47 INFO - Running setup.py (path:/tmp/pip-nGIFS7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:47 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)) 19:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:47 INFO - Running setup.py (path:/tmp/pip-kuauc5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:47 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)) 19:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:47 INFO - Running setup.py (path:/tmp/pip-FmT4jf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:47 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)) 19:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:48 INFO - Running setup.py (path:/tmp/pip-f4yrcv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:48 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)) 19:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:48 INFO - Running setup.py (path:/tmp/pip-C0tzBa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:48 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)) 19:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:48 INFO - Running setup.py (path:/tmp/pip-m1kF7w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:48 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)) 19:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:48 INFO - Running setup.py (path:/tmp/pip-fQEMvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:48 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)) 19:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:48 INFO - Running setup.py (path:/tmp/pip-PPNDvL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:48 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)) 19:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:48 INFO - Running setup.py (path:/tmp/pip-btP7BK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:48 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)) 19:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:48 INFO - Running setup.py (path:/tmp/pip-KIbQh4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:48 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)) 19:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:48 INFO - Running setup.py (path:/tmp/pip-8MsZLy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:48 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)) 19:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:48 INFO - Running setup.py (path:/tmp/pip-I6gTp9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:48 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)) 19:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:48 INFO - Running setup.py (path:/tmp/pip-3j9J3i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:48 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)) 19:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:48 INFO - Running setup.py (path:/tmp/pip-8E1s02-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:48 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)) 19:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:48 INFO - Running setup.py (path:/tmp/pip-fdFJT0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:48 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)) 19:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:48 INFO - Running setup.py (path:/tmp/pip-rPi3zQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:48 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)) 19:51:48 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)) 19:51:48 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)) 19:51:48 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)) 19:51:48 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)) 19:51:48 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)) 19:51:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:50 INFO - Downloading blessings-1.6.tar.gz 19:51:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:51:50 INFO - Installing collected packages: blessings 19:51:50 INFO - Running setup.py install for blessings 19:51:50 INFO - Successfully installed blessings 19:51:50 INFO - Cleaning up... 19:51:50 INFO - Return code: 0 19:51:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:51:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:51:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:51:51 INFO - Reading from file tmpfile_stdout 19:51:51 INFO - Current package versions: 19:51:51 INFO - argparse == 1.2.1 19:51:51 INFO - blessings == 1.6 19:51:51 INFO - blobuploader == 1.2.4 19:51:51 INFO - docopt == 0.6.1 19:51:51 INFO - manifestparser == 1.1 19:51:51 INFO - mozInstall == 1.12 19:51:51 INFO - mozcrash == 0.16 19:51:51 INFO - mozdebug == 0.1 19:51:51 INFO - mozdevice == 0.48 19:51:51 INFO - mozfile == 1.2 19:51:51 INFO - mozhttpd == 0.7 19:51:51 INFO - mozinfo == 0.9 19:51:51 INFO - mozleak == 0.1 19:51:51 INFO - mozlog == 3.1 19:51:51 INFO - moznetwork == 0.27 19:51:51 INFO - mozprocess == 0.22 19:51:51 INFO - mozprofile == 0.28 19:51:51 INFO - mozrunner == 6.11 19:51:51 INFO - mozscreenshot == 0.1 19:51:51 INFO - mozsystemmonitor == 0.0 19:51:51 INFO - moztest == 0.7 19:51:51 INFO - mozversion == 1.4 19:51:51 INFO - psutil == 3.1.1 19:51:51 INFO - requests == 1.2.3 19:51:51 INFO - wsgiref == 0.1.2 19:51:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19: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')]} 19:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19: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')]} 19:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:51 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 0x7ff659fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391840>, '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 0x22fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22feb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', '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 19:51:51 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 19:51:51 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 19:51:51 INFO - Using env: {'DISPLAY': ':0', 19:51:51 INFO - 'HOME': '/home/cltbld', 19:51:51 INFO - 'LANG': 'en_US.UTF-8', 19:51:51 INFO - 'LANGUAGE': 'en_US:en', 19:51:51 INFO - 'LOGNAME': 'cltbld', 19:51:51 INFO - 'MAIL': '/var/mail/cltbld', 19:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:51 INFO - 'MOZ_NO_REMOTE': '1', 19:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:51 INFO - 'NO_EM_RESTART': '1', 19:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:51 INFO - 'SHELL': '/bin/bash', 19:51:51 INFO - 'SHLVL': '1', 19:51:51 INFO - 'TERM': 'linux', 19:51:51 INFO - 'TMOUT': '86400', 19:51:51 INFO - 'USER': 'cltbld', 19:51:51 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', 19:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:51 INFO - '_': '/tools/buildbot/bin/python'} 19:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:51 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)) 19:51:51 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)) 19:51:51 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)) 19:51:51 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)) 19:51:51 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)) 19:51:51 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)) 19:51:51 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)) 19:51:51 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)) 19:51:51 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)) 19:51:51 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)) 19:51:51 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)) 19:51:51 INFO - Cleaning up... 19:51:51 INFO - Return code: 0 19:51:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19: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')]} 19:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19: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')]} 19:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:51 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 0x7ff659fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391840>, '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 0x22fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22feb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', '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 19:51:51 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 19:51:51 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 19:51:51 INFO - Using env: {'DISPLAY': ':0', 19:51:51 INFO - 'HOME': '/home/cltbld', 19:51:51 INFO - 'LANG': 'en_US.UTF-8', 19:51:51 INFO - 'LANGUAGE': 'en_US:en', 19:51:51 INFO - 'LOGNAME': 'cltbld', 19:51:51 INFO - 'MAIL': '/var/mail/cltbld', 19:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:51 INFO - 'MOZ_NO_REMOTE': '1', 19:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:51 INFO - 'NO_EM_RESTART': '1', 19:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:51 INFO - 'SHELL': '/bin/bash', 19:51:51 INFO - 'SHLVL': '1', 19:51:51 INFO - 'TERM': 'linux', 19:51:51 INFO - 'TMOUT': '86400', 19:51:51 INFO - 'USER': 'cltbld', 19:51:51 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', 19:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:51 INFO - '_': '/tools/buildbot/bin/python'} 19:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:51 INFO - Downloading/unpacking jsonschema 19:51:51 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 19:51:51 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 19:51:51 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 19:51:51 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 19:51:51 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 19:51:51 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 19:51:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:51:53 INFO - Downloading/unpacking functools32 (from jsonschema) 19:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:53 INFO - Downloading functools32-3.2.3-2.tar.gz 19:51:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:51:53 INFO - warning: no files found matching '*.txt' 19:51:53 INFO - no previously-included directories found matching 'build' 19:51:53 INFO - no previously-included directories found matching 'dist' 19:51:53 INFO - no previously-included directories found matching '.git*' 19:51:53 INFO - Installing collected packages: jsonschema, functools32 19:51:53 INFO - Running setup.py install for functools32 19:51:53 INFO - warning: no files found matching '*.txt' 19:51:53 INFO - no previously-included directories found matching 'build' 19:51:53 INFO - no previously-included directories found matching 'dist' 19:51:53 INFO - no previously-included directories found matching '.git*' 19:51:53 INFO - Successfully installed jsonschema functools32 19:51:53 INFO - Cleaning up... 19:51:53 INFO - Return code: 0 19:51:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff659fd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2391840>, '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 0x22fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22feb60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', '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 19:51:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:51:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:51:53 INFO - Using env: {'DISPLAY': ':0', 19:51:53 INFO - 'HOME': '/home/cltbld', 19:51:53 INFO - 'LANG': 'en_US.UTF-8', 19:51:53 INFO - 'LANGUAGE': 'en_US:en', 19:51:53 INFO - 'LOGNAME': 'cltbld', 19:51:53 INFO - 'MAIL': '/var/mail/cltbld', 19:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:53 INFO - 'MOZ_NO_REMOTE': '1', 19:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:53 INFO - 'NO_EM_RESTART': '1', 19:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:53 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:53 INFO - 'SHELL': '/bin/bash', 19:51:53 INFO - 'SHLVL': '1', 19:51:53 INFO - 'TERM': 'linux', 19:51:53 INFO - 'TMOUT': '86400', 19:51:53 INFO - 'USER': 'cltbld', 19:51:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', 19:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:53 INFO - '_': '/tools/buildbot/bin/python'} 19:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:54 INFO - Downloading/unpacking flake8 19:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:51:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:51:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:51:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:51:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:51:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:51:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:51:56 INFO - no previously-included directories found matching 'docs/_build' 19:51:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:51:56 INFO - Running setup.py install for pep8 19:51:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:51:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:51:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:51:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:51:56 INFO - no previously-included directories found matching 'docs/_build' 19:51:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:51:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:51:56 INFO - Cleaning up... 19:51:56 INFO - Return code: 0 19:51:56 INFO - Running post-action listener: _resource_record_post_action 19:51:56 INFO - Running post-action listener: _start_resource_monitoring 19:51:56 INFO - Starting resource monitoring. 19:51:56 INFO - ##### 19:51:56 INFO - ##### Running install step. 19:51:56 INFO - ##### 19:51:56 INFO - Running pre-action listener: _resource_record_pre_action 19:51:56 INFO - Running main action method: install 19:51:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:51:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:51:57 INFO - Reading from file tmpfile_stdout 19:51:57 INFO - Detecting whether we're running mozinstall >=1.0... 19:51:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:51:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:51:57 INFO - Reading from file tmpfile_stdout 19:51:57 INFO - Output received: 19:51:57 INFO - Usage: mozinstall [options] installer 19:51:57 INFO - Options: 19:51:57 INFO - -h, --help show this help message and exit 19:51:57 INFO - -d DEST, --destination=DEST 19:51:57 INFO - Directory to install application into. [default: 19:51:57 INFO - "/builds/slave/test-pgo"] 19:51:57 INFO - --app=APP Application being installed. [default: firefox] 19:51:57 INFO - mkdir: /builds/slave/test-pgo/build/application 19:51:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:51:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:52:13 INFO - Reading from file tmpfile_stdout 19:52:13 INFO - Output received: 19:52:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:52:13 INFO - Running post-action listener: _resource_record_post_action 19:52:13 INFO - ##### 19:52:13 INFO - ##### Running run-tests step. 19:52:13 INFO - ##### 19:52:13 INFO - Running pre-action listener: _resource_record_pre_action 19:52:13 INFO - Running main action method: run_tests 19:52:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:52:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:52:13 INFO - Python 2.7.3 19:52:13 INFO - Return code: 0 19:52:13 INFO - grabbing minidump binary from tooltool 19: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')]} 19:52:13 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 0x2391840>, '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 0x22fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22feb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:52:13 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 19:52:13 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 19:52:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:52:13 INFO - Return code: 0 19:52:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:52:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:52:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:52:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:52:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:52:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:52:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:52:14 INFO - Return code: 0 19:52:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 19:52:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 19:52:14 INFO - Using env: {'DISPLAY': ':0', 19:52:14 INFO - 'HOME': '/home/cltbld', 19:52:14 INFO - 'LANG': 'en_US.UTF-8', 19:52:14 INFO - 'LANGUAGE': 'en_US:en', 19:52:14 INFO - 'LOGNAME': 'cltbld', 19:52:14 INFO - 'MAIL': '/var/mail/cltbld', 19:52:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:52:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:14 INFO - 'MOZ_NO_REMOTE': '1', 19:52:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:14 INFO - 'NO_EM_RESTART': '1', 19:52:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:52:14 INFO - 'PWD': '/builds/slave/test-pgo', 19:52:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:52:14 INFO - 'SHELL': '/bin/bash', 19:52:14 INFO - 'SHLVL': '1', 19:52:14 INFO - 'TERM': 'linux', 19:52:14 INFO - 'TMOUT': '86400', 19:52:14 INFO - 'USER': 'cltbld', 19:52:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322', 19:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:14 INFO - '_': '/tools/buildbot/bin/python'} 19:52:14 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:52:14 INFO - mozversion application_buildid: 20160122173005 19:52:14 INFO - mozversion application_changeset: be005c69fbb61cfb10e544c0a6a0b9d5e6193a81 19:52:14 INFO - mozversion application_display_name: Nightly 19:52:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:52:14 INFO - mozversion application_name: Firefox 19:52:14 INFO - mozversion application_remotingname: firefox 19:52:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:52:14 INFO - mozversion application_vendor: Mozilla 19:52:14 INFO - mozversion application_version: 46.0a1 19:52:14 INFO - mozversion platform_buildid: 20160122173005 19:52:14 INFO - mozversion platform_changeset: be005c69fbb61cfb10e544c0a6a0b9d5e6193a81 19:52:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:52:14 INFO - mozversion platform_version: 46.0a1 19:52:14 INFO - using testdate: 1453521134 19:52:14 INFO - actual date: 1453521134 19:52:14 INFO - starting webserver on 'localhost:43109' 19:52:14 INFO - SUITE-START | Running 3 tests 19:52:14 INFO - TEST-START | dromaeo_css 19:52:14 INFO - operating with platform_type : linux_ 19:52:14 INFO - Initialising browser for dromaeo_css test... 19:52:14 INFO - TEST-INFO | started process 2579 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFhwpQ9/profile http://localhost:43109/getInfo.html) 19:52:19 INFO - PROCESS | 2579 | __metrics Screen width/height:1600/1200 19:52:19 INFO - PROCESS | 2579 | colorDepth:24 19:52:19 INFO - PROCESS | 2579 | Browser inner width/height: 1024/697 19:52:19 INFO - PROCESS | 2579 | __metrics 19:52:19 INFO - PROCESS | 2579 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:52:19 INFO - PROCESS | 2579 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:52:20 INFO - TEST-INFO | 2579: exit 0 19:52:20 INFO - Browser initialized. 19:52:20 INFO - Running cycle 1/1 for dromaeo_css test... 19:52:20 INFO - TEST-INFO | started process 2683 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFhwpQ9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:32 INFO - PROCESS | 2683 | RSS: Main: 148398080 19:52:32 INFO - PROCESS | 2683 | 19:53:23 INFO - PROCESS | 2683 | 1453521203638 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] 19:55:31 INFO - PROCESS | 2683 | Cycle 1(1): loaded http://localhost:43109/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43109/tests/dromaeo/cssquery-ext.html) 19:55:33 INFO - PROCESS | 2683 | RSS: Main: 274292736 19:55:33 INFO - PROCESS | 2683 | 19:58:35 INFO - PROCESS | 2683 | Cycle 1(1): loaded http://localhost:43109/tests/dromaeo/cssquery-ext.html (next: http://localhost:43109/tests/dromaeo/cssquery-jquery.html) 19:58:36 INFO - PROCESS | 2683 | RSS: Main: 242442240 19:58:36 INFO - PROCESS | 2683 | 20:01:38 INFO - PROCESS | 2683 | Cycle 1(1): loaded http://localhost:43109/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43109/tests/dromaeo/cssquery-mootools.html) 20:01:38 INFO - PROCESS | 2683 | RSS: Main: 233000960 20:01:38 INFO - PROCESS | 2683 | 20:04:40 INFO - PROCESS | 2683 | Cycle 1(1): loaded http://localhost:43109/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43109/tests/dromaeo/cssquery-prototype.html) 20:04:41 INFO - PROCESS | 2683 | RSS: Main: 215326720 20:04:41 INFO - PROCESS | 2683 | 20:07:43 INFO - PROCESS | 2683 | Cycle 1(1): loaded http://localhost:43109/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43109/tests/dromaeo/cssquery-yui.html) 20:07:44 INFO - PROCESS | 2683 | RSS: Main: 219369472 20:07:44 INFO - PROCESS | 2683 | 20:10:47 INFO - PROCESS | 2683 | Cycle 1(1): loaded http://localhost:43109/tests/dromaeo/cssquery-yui.html (next: http://localhost:43109/tests/dromaeo/cssquery-dojo.html) 20:10:47 INFO - PROCESS | 2683 | RSS: Main: 272359424 20:10:47 INFO - PROCESS | 2683 | 20:10:47 INFO - PROCESS | 2683 | __start_tp_report 20:10:47 INFO - PROCESS | 2683 | _x_x_mozilla_page_load 20:10:47 INFO - PROCESS | 2683 | _x_x_mozilla_page_load_details 20:10:47 INFO - PROCESS | 2683 | |i|pagename|runs| 20:10:47 INFO - PROCESS | 2683 | |0;dojo.html;3100.2094465911196;3137.309791845796;3174;3182.936341273176;3199.040287913626;4982.750862456872;5028.723420211887;5068.569171620407;5070.163423035199;5080.949190508094;5096.38843338799;5162.586993040557;5191.610629202806;5209.817656382027;5211.921821172686;4634.212183928724;4641.976790116045;4675.976620116895;4726.0547890421885;4745.193317136095;4762.285657151438;4763.642726795487;4775.092732380836;4800.255960326138;4823.951760482403;4524.773761311922;4583.679142460029;4593.081383723252;4596.816127354902;4706.3411122442885;4599.31010348447;4607.285870690015;4615.076984603059;4625.606823420013;4664.720116793003;4583.977080114578;4590.265557510782;4600.723956562583;4622.168009758242;4631.0506346198945;4855.32025516428;4924.433690125646;4928.359313289249;4997.900041999176;5003.249512573107;5517.972410137963;5520.503154716095;5520.613557051008;5532.695701736403;5533.861653458655;5425.26758887553;5600.859978500529;5601.943980560183;5605.103183490663;5606.495415412592;5090.694558326512;5212.6611770235195;5264.894702105975;5270.92093618596;5292.126799078109;5651.180578816131;5659.434056594308;5669.34802497718;5673.290838645169;5717.313922329347;5443.891122177534;5467.507924286833;5475.753591088411;5483.75323110461;5486.231927530149;5397.3523177218985;5469.480399362054;5481;5515.889682206333;5557.916631250535;5477.178423236546;5477.233187353773;5480.972595136999;5483.369412517532;5483.396826349099;5359.383670877821;5502.119660854244;5507.807226747124;5511.972440137773;5522.641028333145;4293.506246781598;4295.3771703102875;4310.051788606502;4378.934315985262;4405.867823965222;3870.2259548090497;3871.9612803872164;3874.2251549690177;3912.941305880414;3921.1569512554365;4972.129877271463;5104.3619547556555;5119.411267704188;5139.794408223704;5187.377514698261;5424.593155513352;5451.100568406168;5494.890102197934;5564.582656300794;5567.526760225345;5110.718910459886;5112.079825631422;5125.487451254845;5126.564242039394;5130.127878260705;4738.47876733559;4744.312074749211;4752.1921273383605;4776.95223047772;4811.687240329367;5613.410591887793;5682.374938756733;5695.088785794253;5740.368559458456;5849.8245052647635;5531.391546929754;5539.362973258127;5540.058190107611;5547.306586676666;5559.58303127259;5717.37108918027;5766.365699773106;5774.105013722879;5781.248437703071;5785.305763308262;5307.336582927134;5379.946200537945;5380.219868119023;5436.891262174813;5496.340439147328;5460.645058071372;5487.341519017744;5513.558915286848;5514;5535.114381698909;5295.4969277918535;5387.892242155213;5398.028354896156;5411.6211865170635;5443.156310771837;5357.919631205457;5370.865728356823;5386.919196211981;5413.945860541344;5450.427705091067;5295.602829787705;5330.147176451749;5342.973285133549;5363.678179309254;5394.32570928634;5273.973630131824;5307.203919412119;5421.403645598902;5424.674519528841;5441.156620723794;5126.666766660155;5128.615353848401;5149.48505149482;5167.58659307262;5170.508801663836 20:10:47 INFO - PROCESS | 2683 | |1;ext.html;525.1125597739822;528;538.4991957479544;558.4164548047291;560.8485708858611;28572;29123.126306210823;29162.854185729095;35115.64884351156;35957.280854382894;39295;39976.600233997655;39989.80005099978;40021.799891000504;40022.59977400225;8291.58542072897;8378.622961966727;8435.536045517494;8438.57807109642;8451.070382257978;8176.1415051419635;8314.376421768362;8366.83266334673;8368.623411946477;8371;8560.14398560142;8633.09352517983;8658.61036253367;8659.95670021649;8659.956700216522;8519.616617252208;8579.699710510165;8594.441361311494;8597.05432402432;8603.182697643713;8453.535055571941;8624.482531048157;8625.26685231756;8626.698065567738;8629.741107766777;39619.8019009906;40074.198516029806;40090.398644020366;40169.59830401688;40216.79891600523;2981.567672687448;3071;3075.2773098321877;3291.555639988595;3743.831527581265;29429.41141177186;29495.726922884573;29962.400751985057;30345.69654303473;31026;3389.3729660012978;3406.4379377402697;3507.0881570791776;3582.731295152848;3727.925441491182;270317;270780;271619;271730.999999998;272853;50833.23750143751;51385.48614513882;57029.42970570324;57332;57481.71259143677;51841.2223816643;52122.436326910254;52197.47802522002;52240;52248.47751522436;13578.25319607431;13793.379297931617;13940.37268322928;13954.58136255914;13958.441662333393;10115;10167.593296268215;10167.898321016695;10694.465276736288;10839.83740243897;18136.45590632283;18256.178471968793;18308.084595770426;18334.81665183331;18358.44924652236;7197.568145911157;7408.296211859864;7417.184109747924;7427.18300986891;7557.2820582044615;898.8022635020285;992.846108853129;1004.7538353103537;1032.4476405123223;1033.834586466162;27800.58299125515;28127.859360703067;28193.71806281911;28410;28489;1056.3503445381036;1067.770429357692;1073.525523667953;1114.3258328711174;1170.4089434835353;14669.413223471154;14749.336279867432;14822.258887055605;14945.850541494447;15004.099754014795;317161;320466;321442;321893;322491;50809;51426.74286628543;51525.48474515282;51548;51613.22580161301;1285.5500574798932;1292.069709808936;1301.6225294664441;1304.928228947398;1308.8809068246703;26901.327466812705;28265.15204543867;28307.858460708387;28461.573076403456;29248;42103.36844947267;42306.15387692291;42428.787856060524;42436.575634244495;42564.36153457639;242956;246964;247887;248791;248944;28145.859270703517;33514.99455016354;34233.657663423044;34492.82753586216;34532.65467345395;39419.40870886882;40239.597604024755;40290.59709402986;40587;40603.79698101491;33762.831185844894;34906.30187396187;35292.47061294031;35891.46162807508;36053.27893442064;27338.316542086606;30306.393872122873;31766.205844854063;34274.48588271228;34880.30239395147;31064.844675776476;31345.686543134278;31537.52693709642;31540;31985.68014319827;24285.271441856774;25255.36861578475;25607.743922560538;25616.743832561435;26193.607095893956;24275.393115171555;24406.755932440446;24846.78830292427;26534.867325663246;26718 20:10:47 INFO - PROCESS | 2683 | |2;jquery.html;354.97160227181826;361.56250936366996;361.7070173159739;361.97647152935076;363.492927366324;13006;13347.799783003238;15399.076055436668;16182.838171618281;17333.046682432476;14895.553133405989;14967.401303947829;16025.759613605805;16028.519144425656;16064.83935160648;5073.670211436254;5389.703566303851;5394.1908713693065;5394.298741163643;5403.378611459673;3952.584978577251;4052.412400201969;5318.388385335678;5670.06443936752;5894.793682221123;5613.354464236604;5786.074228123501;5803.709814509279;5854.824355269348;5857.121431785224;5690.430956904318;5727;5747.195392644991;5750.3962083981205;5752.942470575304;4757.452892917289;4953.554180123806;4955.554000140005;4959.231319145538;5086.974565127188;11695.766084678258;11744.378273945871;18808.34170804029;18809.341673041377;18968.336108236144;2030.7969203079574;2154.9784502154935;2162.7188465499385;2339.9704130182663;2598.7661110500144;9224.769380765467;9739.366941148874;9956.402615843;10043.246756493292;12232.143749937508;1819.2813838533705;1830.3044842959723;1831.1851226204344;1867.6544839204792;1885.7737071551364;48350.7582462089;49680.25479617809;50196.24705629418;50490.495095049315;50499;9310.162085412345;9629.470379129076;9809.460479673686;9904.504774761233;9917.801643967225;12734.490620375267;12823.230606163661;12876.742465150832;12892.872676008541;12927.353632318347;6758.493113016543;6959.1996920353795;7072.8939065914055;7082.114735658043;7102.934559816069;6821.488388370793;6829.351211634887;6833.282505336868;6872.656367181621;6876.828079298058;3909.354956432157;3992.5608183099835;4015.0966032642423;4039.4748682671066;4103.343465045578;1651.7274649682909;1721.5782133377152;1832.39799484732;1845.391020963079;1857.5634725839418;780.1535334162497;793.920607939213;821.8972628421448;855.2089317381522;906.6146887572755;10474.109700675375;10541.947290263499;10582.523786429629;10806.297590656583;14761.114333140045;451.884769383805;454.5704309427625;459.3867187304985;461.8245066874566;471.8298619423848;5525.419830917776;5536.52939500147;5709.914351284734;5723.59934804568;5888.558358123158;382510;387062;389796;455477;485283;74099;74143;77013.61493192498;77056.61471692605;79076;447.74702293204234;457.1930542592327;459.4211293769874;459.648368997717;461.3702296365437;8597.742067737978;9543.665971690958;10030;10157.238207134347;10244.64143754965;33470.75919897515;33857.3228535423;34046.82976585101;34102.658973410944;34468.82765586156;39623.80188099041;39686;39692.603073968894;42899.78550107229;42958.14083718371;3043.589115469383;7039.54242974205;7042.647867606497;7187.353138217585;7317.317017085994;10258.487075646337;10497.212709047004;10870.510827012646;10981.560737570728;10996.395198264172;9425.38734982224;9565.33042687033;9702.223822094356;9726.076022777825;9730.610775569181;9358.29812764059;9399.953000234955;9418.952905235705;9771.267154963549;9829.950850245703;9692.079252471003;9851.408915464808;10065.144462720458;10096.444695541815;10188.643397481053;7379.889301660587;7420.109586849612;7427.368673662583;7429.108506979197;7440.776776696708;8128.87806682912;9169.816603667756;9906.910239873752;10024.749381265527;10088 20:10:47 INFO - PROCESS | 2683 | |3;mootools.html;1305.9085863989512;1441.7404867123917;1459.9416023359065;1586.6985272798167;1759.4281858396016;6617.536772425932;6759.12131422915;7616.543007419552;7732.226777322265;7743.535387876731;7346.706131754737;7349;7371.336579707825;7416.925830741691;7417.740379086733;2001.8198362147405;2045.4988527810633;2306.665533497646;2334.101370972171;2335.1243283768504;2310.5378924215142;2355.222776483756;2358.151065616377;2359.09174967637;2359.1860808021206;2282.3609389370918;2301.470661747799;2336.1122773346106;2338.707661542307;2339.6490526421003;2298.0922535598347;2314.7338056123594;2318.0727708916484;2345.7067866516686;2345.824063195267;2321.6401457774073;2321.6633588129794;2322.3613506285737;2330.487292795582;2367.6922000140044;7695.538267703956;7737.651805668702;7738.264864837832;7740.26467485588;7741.458097933147;4855.708657480563;4972.776225069844;5001.874953126165;5004.149294619923;5006.199008158677;3033.8786448542032;3067.1871953932227;3085.676004019568;3117.9688203117908;3122.656507784142;891.5809569502323;912.0651332384293;926.2404828041009;926.402470406584;946.4415994563171;10990.340579565252;11042.447877606088;11046.005859472605;11051;11057.50241239146;4397.1205758848355;4435.778211089432;4500.549945005473;4511.142882852248;4530.275155975094;9319.254459643213;9339.299552533586;9369.953150234205;9379.859302110473;9391.765205869771;4879.756012199376;4906.043321552334;4906.288588154769;4912.8771780705765;4915.16442204826;4387.670924680598;4426.026274219731;4430.778461076933;4431.512533621299;4433.423654924839;3470.0630829675847;3560.608333083359;3668.5230919980763;3794.165283637595;3811.8094095295123;1192.2429257421427;1232.9568465103678;1235.5428491458217;1237.103100252328;1249.6688377579949;1216.7323188898606;1232.778099942019;1243.875612438749;1324.0731487958276;1324.602619214232;6961.547499412522;7043.542169758949;7054.118235220598;7061.329173728487;7064.046353742179;1091.5360971587045;1105.3202280597536;1107.141964977133;1108.8004159251411;1114.5318966034285;5700.4299570043495;5756.769729210869;5782.479576838105;5793.159991801165;5799.2750906136735;9474.38416502925;9573.473458959685;9821.901780982242;9830.262730295113;9837.852432213522;9581.089796469325;9596.568154433067;9682.273829462818;9712.951435242778;9713.125818676353;7291.197968223491;7426.220246874109;7481.3266805988815;7492.700291988368;7510.887336689954;7284.781456556312;7296.7446139384865;7301.233370496234;7334.083239595051;7351.081114860643;8389.748307550783;8433.704820331504;8622.051574326944;8718.694845680371;8724.127587241224;8716.651333946571;8992.68525601627;9000.234980026771;9007.954960225157;9015.729528114167;7126.2873712628325;7200.963995179991;7201.675924583302;7201.891971620325;7202.171750248579;6261.843453913506;6345.777897773556;7191.280871912767;7491.175970643116;7500.36246919018;6908.1364829396325;6977.546459480118;7095.148582170173;7163.4269258460245;7200.243974382614;7065.540739851893;7137.072180616487;7147.678354474165;7152.713891444284;7158.928410716035;6647.567908086153;7190.7483238086415;7232.168300645493;7232.927670723226;7247.601381924045;6338.524610654312;6358.554901156875;6368.363163683594;6369.108324834619;6388.616682999035;6364.586301890362;6409.647469389229;6411.8397040072505;6425.1968503937005;6432.710528026344 20:10:47 INFO - PROCESS | 2683 | |4;prototype.html;334.1645885286783;338.2389623347468;339.71463970265006;343.47791357137146;346.50449856704904;5639.238702775124;5783.074708046708;5790.5946583739105;5819.214406055181;5865.266841644794;5593.440655934404;5737.627054241471;5762.798302059428;5777.335606405265;5780.971095144519;4491.348754430597;4493.46078470584;4495.9325610115875;4499.437570303712;4501.504834468205;4284.378765079062;4332.090261045184;4395.890102747425;4416.160929423415;4484.686071974963;4142.937855932163;4318.179545886272;4356.150550642626;4363.192809330269;4392.824287028515;4323.373110898933;4383.802728877208;4384.057427653054;4384.386185933972;4391.934120988188;3902.7853468059247;3907.8632247871474;3944.447777311179;3947.013246688328;3949.822257998368;5480.451954804527;5531.668099914018;5532;5532.225488431623;5556.361018482886;5085.23721441783;5155.896882062375;5176.715280659562;5188.610854185951;5189.273501709764;6105.45050945417;6112.938870611281;6117.143599896018;6126.448619624255;6130.233720784902;4316.007318316773;4320.978395108035;4321.416608757809;4322.222000039991;4349.565043495625;6116.541259405562;6265.624062556216;6285.560010799246;6408;6413.7755178569;4413.22768515515;4431.33529970507;4435.844745433958;4436.245838207513;4439.023414848728;4485.663575231871;4489.349044388546;4491.46102467706;4491.528389519119;4494.12364588902;5042;5082.923756143661;5101.617378696613;5139.381094955077;5141.074606570854;6141.416565426277;6157.291911430153;6163.722632481549;6174.8147555573405;6176.320604733476;1579.202502736111;1600.4958438091965;1603.3346161343145;1603.9814717654374;1604.3422196899214;1063.186662203415;1076.262760009396;1077.7844431113808;1100.6312885183554;1101.4878081692052;5784.855378615568;5790.536757059509;5798.8550286242335;5821.825345239565;5823.5341172706085;6302.306746257908;6342.238931328178;6344.333844946306;6346.079818426302;6353.078803573456;5809.651420914759;5810.157527158538;5814.941850581525;5815.505682017076;5819.709014549256;3300.8019518828946;3426.2119712466274;3427.862885484553;3432.9141771455916;3434.0213039283685;6609.966950165219;6619.470442364599;6622.437092847162;6623.668816559153;6624.403803657598;6464.903026454607;6473.805785826433;6475.287718350977;6480.157579514633;6492.870142597121;6396.42432181106;6568.1789776277965;6616.801495955129;6642.535022548472;6675.265720770614;6352.174217351715;6388.233411990591;6389.456896163692;6399.296077431386;6406.583572067801;6064.908316503072;6323.747050118128;6325.082862984934;6332.588381755171;6337.429631333202;6499.675016249074;6529.771457998947;6613.173353330833;6680.532362734756;6683;4314.805833737552;4349.608535231844;4354.194474022316;4357.433533640607;4364.803583838671;6316.494680425463;6359.17330747;6367.108604795239;6379.298277189599;6379.362063793584;6086.878262434815;6256.499480041677;6259.78090766821;6267.1539342188225;6277.089821975696;6235.96882015587;6238.594491358047;6242.500599952084;6247.156633854554;6267.2479302484;6035.081408651935;6135.079738039151;6142.447179753844;6144.2319710036245;6146.508279337731;6226.221722284715;6267.843303917256;6268.874622507616;6280.403361680633;6286.968565157145;6141.293751218488;6198.194234749454;6202.503799695924;6207.6275423474735;6209.161763162096 20:10:47 INFO - PROCESS | 2683 | |5;yui.html;774.2373761844584;814.3485211830535;842.1031601344571;847.3052097280229;865.3553102938308;13473.595792126227;13513.864861351383;13598.864011359883;13624.591262262124;13627.795583066238;12557.811632825493;12600.306983115925;12616.810747838766;12620.432080556375;12632.242065476077;643.0450780590819;652.849844535757;794.2335646101511;795.0896223823732;812.10262659761;804.4248362420868;812.2405550809982;812.2567850416862;814.1370147643487;814.3281792521194;837.3385025829588;837.7821766340764;842.5408152556871;844.9788755281137;846.0693237438829;680.1022650101868;691.5021184746975;828.5691440450962;842.2293601354753;842.3135144856922;623.479394705417;625.0124802811547;625.5527297981964;626.564537646336;626.6741294526867;12169.817452738216;12208.938955305255;12280.508779648804;12306.569270075594;12369.62891113259;12013.459394327188;12542.310172940484;12583.559575414816;12656.55702050433;13049.478020879153;10631.415272160028;10671.573137074507;10741.731456713645;10781.5687372505;10802.243842930999;3584.551931008624;3655.3603119453987;3719.3119272934323;3724.3296206682785;3759.642833930772;45923.31115033244;47407.28889066667;47727.52272477266;47762.76118619419;47852.52147478516;10198.18414526836;10332.483375831178;10419.426931518688;10517.211209159344;10517.52671129801;18076.367327143485;18256.087195640164;18289.63420731578;18300.26798928028;18303.35938242155;7376.889346659805;7385.22455142213;7530.698772049166;7674.577898215652;7674.577898215652;4083.71414001023;4197.769122698281;4228.175505776344;4273.615374616299;4345.065810850619;3102.37952409519;3115.610548681415;3127.827969461656;3131.373725254958;3132.3578666373337;531.3889027618193;543.982752253281;545.5390195284978;548.2434240747742;561.4806304168709;496.4910966259613;523.9318888544541;550.9724513774376;590;592.5703864698146;8199.754007379788;8365.372597055246;8501.787455313543;8506.106858779864;8615.741527754177;586.519054375408;591.4617697894895;600.3126420248877;620.2742790934617;621.4531212532942;3837.76973381598;3979.6816254699556;3980.2238563479846;4526.88682782933;4579.839705610288;52050.21924671133;52199;52291.21563176555;54671;56089;44959;45468.3179752304;45485.7725711376;45812.3128153078;45895.770521147184;42353;42649.57350426456;42782.358264626055;42949.57050429518;43374.349384759254;8988.775280617776;9008.324375671982;9138.13187747163;9160.358774885693;9279.68819134079;32141;32372.190695232806;33077.66922330746;33189.50215746718;33377.99866004024;38781.03047423837;40530.1893962125;42293.36559951665;42635.3604695936;42958;11041.447927603427;11112.611058612909;11230.66308010761;11427.428628568372;11741.941290293495;11104.5558177672;11129;11588.420578970849;12497;12538.185017973803;10774.24580279373;10947.945260273647;10999.505022273857;11508.13688973347;11675;11702.88297117018;11993.760124797629;12018.75962480763;12123.333216672814;12396;11596.188266821242;11888.28670279786;11976.76046479083;12048.096392770753;12351.69120771988;9109.544522773702;9155.954220228856;9255.76860578491;9302.069793020644;9433.575489103145;9303.534823258675;9352.53237338144;10017.348872323275;10363.740906477398;10463.11063559606 20:10:47 INFO - PROCESS | 2683 | __end_tp_report 20:10:47 INFO - PROCESS | 2683 | __start_cc_report 20:10:47 INFO - PROCESS | 2683 | _x_x_mozilla_cycle_collect,1003 20:10:47 INFO - PROCESS | 2683 | __end_cc_report 20:10:47 INFO - PROCESS | 2683 | __startTimestamp1453522247332__endTimestamp 20:10:47 INFO - PROCESS | 2683 | 20:10:47 INFO - PROCESS | 2683 | ------- Summary: start ------- 20:10:47 INFO - PROCESS | 2683 | Number of tests: 6 20:10:47 INFO - PROCESS | 2683 | 20:10:47 INFO - PROCESS | 2683 | [#0] dojo.html Cycles:165 Average:5115.93 Median:5295.60 stddev:554.10 (10.5%) stddev-sans-first:532.76 20:10:47 INFO - PROCESS | 2683 | Values: 3100.2 3137.3 3174.0 3182.9 3199.0 4982.8 5028.7 5068.6 5070.2 5080.9 5096.4 5162.6 5191.6 5209.8 5211.9 4634.2 4642.0 4676.0 4726.1 4745.2 4762.3 4763.6 4775.1 4800.3 4824.0 4524.8 4583.7 4593.1 4596.8 4706.3 4599.3 4607.3 4615.1 4625.6 4664.7 4584.0 4590.3 4600.7 4622.2 4631.1 4855.3 4924.4 4928.4 4997.9 5003.2 5518.0 5520.5 5520.6 5532.7 5533.9 5425.3 5600.9 5601.9 5605.1 5606.5 5090.7 5212.7 5264.9 5270.9 5292.1 5651.2 5659.4 5669.3 5673.3 5717.3 5443.9 5467.5 5475.8 5483.8 5486.2 5397.4 5469.5 5481.0 5515.9 5557.9 5477.2 5477.2 5481.0 5483.4 5483.4 5359.4 5502.1 5507.8 5512.0 5522.6 4293.5 4295.4 4310.1 4378.9 4405.9 3870.2 3872.0 3874.2 3912.9 3921.2 4972.1 5104.4 5119.4 5139.8 5187.4 5424.6 5451.1 5494.9 5564.6 5567.5 5110.7 5112.1 5125.5 5126.6 5130.1 4738.5 4744.3 4752.2 4777.0 4811.7 5613.4 5682.4 5695.1 5740.4 5849.8 5531.4 5539.4 5540.1 5547.3 5559.6 5717.4 5766.4 5774.1 5781.2 5785.3 5307.3 5379.9 5380.2 5436.9 5496.3 5460.6 5487.3 5513.6 5514.0 5535.1 5295.5 5387.9 5398.0 5411.6 5443.2 5357.9 5370.9 5386.9 5413.9 5450.4 5295.6 5330.1 5343.0 5363.7 5394.3 5274.0 5307.2 5421.4 5424.7 5441.2 5126.7 5128.6 5149.5 5167.6 5170.5 20:10:47 INFO - PROCESS | 2683 | 20:10:47 INFO - PROCESS | 2683 | [#1] ext.html Cycles:180 Average:43840.18 Median:18576.10 stddev:73579.80 (396.1%) stddev-sans-first:73714.34 20:10:47 INFO - PROCESS | 2683 | Values: 525.1 528.0 538.5 558.4 560.8 28572.0 29123.1 29162.9 35115.6 35957.3 39295.0 39976.6 39989.8 40021.8 40022.6 8291.6 8378.6 8435.5 8438.6 8451.1 8176.1 8314.4 8366.8 8368.6 8371.0 8560.1 8633.1 8658.6 8660.0 8660.0 8519.6 8579.7 8594.4 8597.1 8603.2 8453.5 8624.5 8625.3 8626.7 8629.7 39619.8 40074.2 40090.4 40169.6 40216.8 2981.6 3071.0 3075.3 3291.6 3743.8 29429.4 29495.7 29962.4 30345.7 31026.0 3389.4 3406.4 3507.1 3582.7 3727.9 270317.0 270780.0 271619.0 271731.0 272853.0 50833.2 51385.5 57029.4 57332.0 57481.7 51841.2 52122.4 52197.5 52240.0 52248.5 13578.3 13793.4 13940.4 13954.6 13958.4 10115.0 10167.6 10167.9 10694.5 10839.8 18136.5 18256.2 18308.1 18334.8 18358.4 7197.6 7408.3 7417.2 7427.2 7557.3 898.8 992.8 1004.8 1032.4 1033.8 27800.6 28127.9 28193.7 28410.0 28489.0 1056.4 1067.8 1073.5 1114.3 1170.4 14669.4 14749.3 14822.3 14945.9 15004.1 317161.0 320466.0 321442.0 321893.0 322491.0 50809.0 51426.7 51525.5 51548.0 51613.2 1285.6 1292.1 1301.6 1304.9 1308.9 26901.3 28265.2 28307.9 28461.6 29248.0 42103.4 42306.2 42428.8 42436.6 42564.4 242956.0 246964.0 247887.0 248791.0 248944.0 28145.9 33515.0 34233.7 34492.8 34532.7 39419.4 40239.6 40290.6 40587.0 40603.8 33762.8 34906.3 35292.5 35891.5 36053.3 27338.3 30306.4 31766.2 34274.5 34880.3 31064.8 31345.7 31537.5 31540.0 31985.7 24285.3 25255.4 25607.7 25616.7 26193.6 24275.4 24406.8 24846.8 26534.9 26718.0 20:10:47 INFO - PROCESS | 2683 | 20:10:47 INFO - PROCESS | 2683 | [#2] jquery.html Cycles:180 Average:23419.55 Median:466.83 stddev:69279.63 (14840.5%) stddev-sans-first:69452.33 20:10:47 INFO - PROCESS | 2683 | Values: 355.0 361.6 361.7 362.0 363.5 13006.0 13347.8 15399.1 16182.8 17333.0 14895.6 14967.4 16025.8 16028.5 16064.8 5073.7 5389.7 5394.2 5394.3 5403.4 3952.6 4052.4 5318.4 5670.1 5894.8 5613.4 5786.1 5803.7 5854.8 5857.1 5690.4 5727.0 5747.2 5750.4 5752.9 4757.5 4953.6 4955.6 4959.2 5087.0 11695.8 11744.4 18808.3 18809.3 18968.3 2030.8 2155.0 2162.7 2340.0 2598.8 9224.8 9739.4 9956.4 10043.2 12232.1 1819.3 1830.3 1831.2 1867.7 1885.8 48350.8 49680.3 50196.2 50490.5 50499.0 9310.2 9629.5 9809.5 9904.5 9917.8 12734.5 12823.2 12876.7 12892.9 12927.4 6758.5 6959.2 7072.9 7082.1 7102.9 6821.5 6829.4 6833.3 6872.7 6876.8 3909.4 3992.6 4015.1 4039.5 4103.3 1651.7 1721.6 1832.4 1845.4 1857.6 780.2 793.9 821.9 855.2 906.6 10474.1 10541.9 10582.5 10806.3 14761.1 451.9 454.6 459.4 461.8 471.8 5525.4 5536.5 5709.9 5723.6 5888.6 382510.0 387062.0 389796.0 455477.0 485283.0 74099.0 74143.0 77013.6 77056.6 79076.0 447.7 457.2 459.4 459.6 461.4 8597.7 9543.7 10030.0 10157.2 10244.6 33470.8 33857.3 34046.8 34102.7 34468.8 39623.8 39686.0 39692.6 42899.8 42958.1 3043.6 7039.5 7042.6 7187.4 7317.3 10258.5 10497.2 10870.5 10981.6 10996.4 9425.4 9565.3 9702.2 9726.1 9730.6 9358.3 9400.0 9419.0 9771.3 9830.0 9692.1 9851.4 10065.1 10096.4 10188.6 7379.9 7420.1 7427.4 7429.1 7440.8 8128.9 9169.8 9906.9 10024.7 10088.0 20:10:47 INFO - PROCESS | 2683 | 20:10:47 INFO - PROCESS | 2683 | [#3] mootools.html Cycles:180 Average:5515.52 Median:6368.74 stddev:2863.56 (45.0%) stddev-sans-first:2854.11 20:10:47 INFO - PROCESS | 2683 | Values: 1305.9 1441.7 1459.9 1586.7 1759.4 6617.5 6759.1 7616.5 7732.2 7743.5 7346.7 7349.0 7371.3 7416.9 7417.7 2001.8 2045.5 2306.7 2334.1 2335.1 2310.5 2355.2 2358.2 2359.1 2359.2 2282.4 2301.5 2336.1 2338.7 2339.6 2298.1 2314.7 2318.1 2345.7 2345.8 2321.6 2321.7 2322.4 2330.5 2367.7 7695.5 7737.7 7738.3 7740.3 7741.5 4855.7 4972.8 5001.9 5004.1 5006.2 3033.9 3067.2 3085.7 3118.0 3122.7 891.6 912.1 926.2 926.4 946.4 10990.3 11042.4 11046.0 11051.0 11057.5 4397.1 4435.8 4500.5 4511.1 4530.3 9319.3 9339.3 9370.0 9379.9 9391.8 4879.8 4906.0 4906.3 4912.9 4915.2 4387.7 4426.0 4430.8 4431.5 4433.4 3470.1 3560.6 3668.5 3794.2 3811.8 1192.2 1233.0 1235.5 1237.1 1249.7 1216.7 1232.8 1243.9 1324.1 1324.6 6961.5 7043.5 7054.1 7061.3 7064.0 1091.5 1105.3 1107.1 1108.8 1114.5 5700.4 5756.8 5782.5 5793.2 5799.3 9474.4 9573.5 9821.9 9830.3 9837.9 9581.1 9596.6 9682.3 9713.0 9713.1 7291.2 7426.2 7481.3 7492.7 7510.9 7284.8 7296.7 7301.2 7334.1 7351.1 8389.7 8433.7 8622.1 8718.7 8724.1 8716.7 8992.7 9000.2 9008.0 9015.7 7126.3 7201.0 7201.7 7201.9 7202.2 6261.8 6345.8 7191.3 7491.2 7500.4 6908.1 6977.5 7095.1 7163.4 7200.2 7065.5 7137.1 7147.7 7152.7 7158.9 6647.6 7190.7 7232.2 7232.9 7247.6 6338.5 6358.6 6368.4 6369.1 6388.6 6364.6 6409.6 6411.8 6425.2 6432.7 20:10:47 INFO - PROCESS | 2683 | 20:10:47 INFO - PROCESS | 2683 | [#4] prototype.html Cycles:180 Average:5158.58 Median:5804.25 stddev:1549.00 (26.7%) stddev-sans-first:1510.43 20:10:47 INFO - PROCESS | 2683 | Values: 334.2 338.2 339.7 343.5 346.5 5639.2 5783.1 5790.6 5819.2 5865.3 5593.4 5737.6 5762.8 5777.3 5781.0 4491.3 4493.5 4495.9 4499.4 4501.5 4284.4 4332.1 4395.9 4416.2 4484.7 4142.9 4318.2 4356.2 4363.2 4392.8 4323.4 4383.8 4384.1 4384.4 4391.9 3902.8 3907.9 3944.4 3947.0 3949.8 5480.5 5531.7 5532.0 5532.2 5556.4 5085.2 5155.9 5176.7 5188.6 5189.3 6105.5 6112.9 6117.1 6126.4 6130.2 4316.0 4321.0 4321.4 4322.2 4349.6 6116.5 6265.6 6285.6 6408.0 6413.8 4413.2 4431.3 4435.8 4436.2 4439.0 4485.7 4489.3 4491.5 4491.5 4494.1 5042.0 5082.9 5101.6 5139.4 5141.1 6141.4 6157.3 6163.7 6174.8 6176.3 1579.2 1600.5 1603.3 1604.0 1604.3 1063.2 1076.3 1077.8 1100.6 1101.5 5784.9 5790.5 5798.9 5821.8 5823.5 6302.3 6342.2 6344.3 6346.1 6353.1 5809.7 5810.2 5814.9 5815.5 5819.7 3300.8 3426.2 3427.9 3432.9 3434.0 6610.0 6619.5 6622.4 6623.7 6624.4 6464.9 6473.8 6475.3 6480.2 6492.9 6396.4 6568.2 6616.8 6642.5 6675.3 6352.2 6388.2 6389.5 6399.3 6406.6 6064.9 6323.7 6325.1 6332.6 6337.4 6499.7 6529.8 6613.2 6680.5 6683.0 4314.8 4349.6 4354.2 4357.4 4364.8 6316.5 6359.2 6367.1 6379.3 6379.4 6086.9 6256.5 6259.8 6267.2 6277.1 6236.0 6238.6 6242.5 6247.2 6267.2 6035.1 6135.1 6142.4 6144.2 6146.5 6226.2 6267.8 6268.9 6280.4 6287.0 6141.3 6198.2 6202.5 6207.6 6209.2 20:10:47 INFO - PROCESS | 2683 | 20:10:47 INFO - PROCESS | 2683 | [#5] yui.html Cycles:180 Average:13273.50 Median:23527.99 stddev:14769.94 (62.8%) stddev-sans-first:14781.55 20:10:47 INFO - PROCESS | 2683 | Values: 774.2 814.3 842.1 847.3 865.4 13473.6 13513.9 13598.9 13624.6 13627.8 12557.8 12600.3 12616.8 12620.4 12632.2 643.0 652.8 794.2 795.1 812.1 804.4 812.2 812.3 814.1 814.3 837.3 837.8 842.5 845.0 846.1 680.1 691.5 828.6 842.2 842.3 623.5 625.0 625.6 626.6 626.7 12169.8 12208.9 12280.5 12306.6 12369.6 12013.5 12542.3 12583.6 12656.6 13049.5 10631.4 10671.6 10741.7 10781.6 10802.2 3584.6 3655.4 3719.3 3724.3 3759.6 45923.3 47407.3 47727.5 47762.8 47852.5 10198.2 10332.5 10419.4 10517.2 10517.5 18076.4 18256.1 18289.6 18300.3 18303.4 7376.9 7385.2 7530.7 7674.6 7674.6 4083.7 4197.8 4228.2 4273.6 4345.1 3102.4 3115.6 3127.8 3131.4 3132.4 531.4 544.0 545.5 548.2 561.5 496.5 523.9 551.0 590.0 592.6 8199.8 8365.4 8501.8 8506.1 8615.7 586.5 591.5 600.3 620.3 621.5 3837.8 3979.7 3980.2 4526.9 4579.8 52050.2 52199.0 52291.2 54671.0 56089.0 44959.0 45468.3 45485.8 45812.3 45895.8 42353.0 42649.6 42782.4 42949.6 43374.3 8988.8 9008.3 9138.1 9160.4 9279.7 32141.0 32372.2 33077.7 33189.5 33378.0 38781.0 40530.2 42293.4 42635.4 42958.0 11041.4 11112.6 11230.7 11427.4 11741.9 11104.6 11129.0 11588.4 12497.0 12538.2 10774.2 10947.9 10999.5 11508.1 11675.0 11702.9 11993.8 12018.8 12123.3 12396.0 11596.2 11888.3 11976.8 12048.1 12351.7 9109.5 9156.0 9255.8 9302.1 9433.6 9303.5 9352.5 10017.3 10363.7 10463.1 20:10:47 INFO - PROCESS | 2683 | -------- Summary: end -------- 20:10:47 INFO - PROCESS | 2683 | 20:10:48 INFO - TEST-INFO | 2683: exit 0 20:10:48 INFO - TEST-OK | dromaeo_css | took 1113597ms 20:10:48 INFO - TEST-START | kraken 20:10:48 INFO - operating with platform_type : linux_ 20:10:48 INFO - Initialising browser for kraken test... 20:10:48 INFO - TEST-INFO | started process 2975 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy5gXpr/profile http://localhost:43109/getInfo.html) 20:10:53 INFO - PROCESS | 2975 | __metrics Screen width/height:1600/1200 20:10:53 INFO - PROCESS | 2975 | colorDepth:24 20:10:53 INFO - PROCESS | 2975 | Browser inner width/height: 1024/697 20:10:53 INFO - PROCESS | 2975 | __metrics 20:10:53 INFO - PROCESS | 2975 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:10:53 INFO - PROCESS | 2975 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:10:54 INFO - TEST-INFO | 2975: exit 0 20:10:54 INFO - Browser initialized. 20:10:54 INFO - Running cycle 1/1 for kraken test... 20:10:54 INFO - TEST-INFO | started process 3059 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy5gXpr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:11:05 INFO - PROCESS | 3059 | RSS: Main: 148058112 20:11:05 INFO - PROCESS | 3059 | 20:11:08 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43109/tests/kraken/driver.html?testName=audio-beat-detection) 20:11:09 INFO - PROCESS | 3059 | RSS: Main: 188604416 20:11:09 INFO - PROCESS | 3059 | 20:11:11 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43109/tests/kraken/driver.html?testName=audio-dft) 20:11:12 INFO - PROCESS | 3059 | RSS: Main: 178552832 20:11:12 INFO - PROCESS | 3059 | 20:11:15 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43109/tests/kraken/driver.html?testName=audio-fft) 20:11:15 INFO - PROCESS | 3059 | RSS: Main: 164859904 20:11:15 INFO - PROCESS | 3059 | 20:11:17 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43109/tests/kraken/driver.html?testName=audio-oscillator) 20:11:18 INFO - PROCESS | 3059 | RSS: Main: 168288256 20:11:18 INFO - PROCESS | 3059 | 20:11:20 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43109/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:11:21 INFO - PROCESS | 3059 | RSS: Main: 167157760 20:11:21 INFO - PROCESS | 3059 | 20:11:24 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43109/tests/kraken/driver.html?testName=imaging-darkroom) 20:11:24 INFO - PROCESS | 3059 | RSS: Main: 167915520 20:11:24 INFO - PROCESS | 3059 | 20:11:28 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43109/tests/kraken/driver.html?testName=imaging-desaturate) 20:11:28 INFO - PROCESS | 3059 | RSS: Main: 168914944 20:11:28 INFO - PROCESS | 3059 | 20:11:31 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43109/tests/kraken/driver.html?testName=json-parse-financial) 20:11:31 INFO - PROCESS | 3059 | RSS: Main: 169033728 20:11:31 INFO - PROCESS | 3059 | 20:11:33 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43109/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:11:34 INFO - PROCESS | 3059 | RSS: Main: 181026816 20:11:34 INFO - PROCESS | 3059 | 20:11:35 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43109/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:11:36 INFO - PROCESS | 3059 | RSS: Main: 179453952 20:11:36 INFO - PROCESS | 3059 | 20:11:38 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43109/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:11:39 INFO - PROCESS | 3059 | RSS: Main: 187871232 20:11:39 INFO - PROCESS | 3059 | 20:11:41 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:11:42 INFO - PROCESS | 3059 | RSS: Main: 195321856 20:11:42 INFO - PROCESS | 3059 | 20:11:44 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:11:45 INFO - PROCESS | 3059 | RSS: Main: 196075520 20:11:45 INFO - PROCESS | 3059 | 20:11:46 INFO - PROCESS | 3059 | Cycle 1(1): loaded http://localhost:43109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43109/tests/kraken/driver.html?testName=ai-astar) 20:11:47 INFO - PROCESS | 3059 | RSS: Main: 256208896 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | __start_tp_report 20:11:47 INFO - PROCESS | 3059 | _x_x_mozilla_page_load 20:11:47 INFO - PROCESS | 3059 | _x_x_mozilla_page_load_details 20:11:47 INFO - PROCESS | 3059 | |i|pagename|runs| 20:11:47 INFO - PROCESS | 3059 | |0;ai-astar;111;110;107;110;110;110;112;111;104;111 20:11:47 INFO - PROCESS | 3059 | |1;audio-beat-detection;155;124;153;168;124;155;158;127;168;130 20:11:47 INFO - PROCESS | 3059 | |2;audio-dft;161;161;162;160;162;162;161;161;161;163 20:11:47 INFO - PROCESS | 3059 | |3;audio-fft;73;73;72;156;77;74;74;73;148;74 20:11:47 INFO - PROCESS | 3059 | |4;audio-oscillator;98;96;140;96;96;96;138;97;96;138 20:11:47 INFO - PROCESS | 3059 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;110;109;110 20:11:47 INFO - PROCESS | 3059 | |6;imaging-darkroom;146;145;146;146;145;145;146;146;146;145 20:11:47 INFO - PROCESS | 3059 | |7;imaging-desaturate;96;95;96;96;96;96;96;96;95;96 20:11:47 INFO - PROCESS | 3059 | |8;json-parse-financial;56;56;58;56;55;56;57;56;55;53 20:11:47 INFO - PROCESS | 3059 | |9;json-stringify-tinderbox;68;68;68;69;69;68;69;68;69;68 20:11:47 INFO - PROCESS | 3059 | |10;stanford-crypto-aes;83;81;84;84;83;83;83;83;85;82 20:11:47 INFO - PROCESS | 3059 | |11;stanford-crypto-ccm;130;117;123;111;121;117;121;114;115;121 20:11:47 INFO - PROCESS | 3059 | |12;stanford-crypto-pbkdf2;141;132;147;141;142;130;144;142;141;141 20:11:47 INFO - PROCESS | 3059 | |13;stanford-crypto-sha256-iterative;66;69;69;67;66;66;67;67;68;67 20:11:47 INFO - PROCESS | 3059 | __end_tp_report 20:11:47 INFO - PROCESS | 3059 | __start_cc_report 20:11:47 INFO - PROCESS | 3059 | _x_x_mozilla_cycle_collect,949 20:11:47 INFO - PROCESS | 3059 | __end_cc_report 20:11:47 INFO - PROCESS | 3059 | __startTimestamp1453522307188__endTimestamp 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | ------- Summary: start ------- 20:11:47 INFO - PROCESS | 3059 | Number of tests: 14 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.37 (2.1%) stddev-sans-first:2.46 20:11:47 INFO - PROCESS | 3059 | Values: 111.0 110.0 107.0 110.0 110.0 110.0 112.0 111.0 104.0 111.0 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:155.00 stddev:17.97 (11.6%) stddev-sans-first:18.78 20:11:47 INFO - PROCESS | 3059 | Values: 155.0 124.0 153.0 168.0 124.0 155.0 158.0 127.0 168.0 130.0 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 20:11:47 INFO - PROCESS | 3059 | Values: 161.0 161.0 162.0 160.0 162.0 162.0 161.0 161.0 161.0 163.0 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#3] audio-fft Cycles:10 Average:89.40 Median:73.50 stddev:33.07 (45.0%) stddev-sans-first:34.54 20:11:47 INFO - PROCESS | 3059 | Values: 73.0 73.0 72.0 156.0 77.0 74.0 74.0 73.0 148.0 74.0 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:96.00 stddev:20.42 (21.3%) stddev-sans-first:21.26 20:11:47 INFO - PROCESS | 3059 | Values: 98.0 96.0 140.0 96.0 96.0 96.0 138.0 97.0 96.0 138.0 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:11:47 INFO - PROCESS | 3059 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:11:47 INFO - PROCESS | 3059 | Values: 146.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 145.0 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:11:47 INFO - PROCESS | 3059 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:1.32 (2.4%) stddev-sans-first:1.39 20:11:47 INFO - PROCESS | 3059 | Values: 56.0 56.0 58.0 56.0 55.0 56.0 57.0 56.0 55.0 53.0 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 20:11:47 INFO - PROCESS | 3059 | Values: 68.0 68.0 68.0 69.0 69.0 68.0 69.0 68.0 69.0 68.0 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:1.10 (1.3%) stddev-sans-first:1.17 20:11:47 INFO - PROCESS | 3059 | Values: 83.0 81.0 84.0 84.0 83.0 83.0 83.0 83.0 85.0 82.0 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:121.00 stddev:5.40 (4.5%) stddev-sans-first:3.99 20:11:47 INFO - PROCESS | 3059 | Values: 130.0 117.0 123.0 111.0 121.0 117.0 121.0 114.0 115.0 121.0 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.10 Median:141.50 stddev:5.17 (3.7%) stddev-sans-first:5.48 20:11:47 INFO - PROCESS | 3059 | Values: 141.0 132.0 147.0 141.0 142.0 130.0 144.0 142.0 141.0 141.0 20:11:47 INFO - PROCESS | 3059 | 20:11:47 INFO - PROCESS | 3059 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.12 20:11:47 INFO - PROCESS | 3059 | Values: 66.0 69.0 69.0 67.0 66.0 66.0 67.0 67.0 68.0 67.0 20:11:47 INFO - PROCESS | 3059 | -------- Summary: end -------- 20:11:47 INFO - PROCESS | 3059 | 20:11:48 INFO - TEST-INFO | 3059: exit 0 20:11:48 INFO - TEST-OK | kraken | took 60319ms 20:11:48 INFO - TEST-START | v8_7 20:11:48 INFO - operating with platform_type : linux_ 20:11:48 INFO - Initialising browser for v8_7 test... 20:11:48 INFO - TEST-INFO | started process 3306 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOKRfAZ/profile http://localhost:43109/getInfo.html) 20:11:52 INFO - PROCESS | 3306 | __metrics Screen width/height:1600/1200 20:11:52 INFO - PROCESS | 3306 | colorDepth:24 20:11:52 INFO - PROCESS | 3306 | Browser inner width/height: 1024/697 20:11:52 INFO - PROCESS | 3306 | __metrics 20:11:53 INFO - PROCESS | 3306 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:11:53 INFO - PROCESS | 3306 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:11:54 INFO - TEST-INFO | 3306: exit 0 20:11:54 INFO - Browser initialized. 20:11:54 INFO - Running cycle 1/1 for v8_7 test... 20:11:54 INFO - TEST-INFO | started process 3389 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOKRfAZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:12:06 INFO - PROCESS | 3389 | RSS: Main: 148156416 20:12:06 INFO - PROCESS | 3389 | 20:12:28 INFO - PROCESS | 3389 | Cycle 1(1): loaded http://localhost:43109/tests/v8_7/run.html (next: http://localhost:43109/tests/v8_7/run.html) 20:12:28 INFO - PROCESS | 3389 | RSS: Main: 597917696 20:12:28 INFO - PROCESS | 3389 | 20:12:28 INFO - PROCESS | 3389 | __start_tp_report 20:12:28 INFO - PROCESS | 3389 | _x_x_mozilla_page_load 20:12:28 INFO - PROCESS | 3389 | _x_x_mozilla_page_load_details 20:12:28 INFO - PROCESS | 3389 | |i|pagename|runs| 20:12:28 INFO - PROCESS | 3389 | |0;Richards;167.42005692281936 20:12:28 INFO - PROCESS | 3389 | |1;DeltaBlue;190.4036557501904 20:12:28 INFO - PROCESS | 3389 | |2;Encrypt;280.19052956010086 20:12:28 INFO - PROCESS | 3389 | |3;Decrypt;5181.347150259067 20:12:28 INFO - PROCESS | 3389 | |4;RayTrace;1129.9435028248588 20:12:28 INFO - PROCESS | 3389 | |5;Earley;773.3952049497293 20:12:28 INFO - PROCESS | 3389 | |6;Boyer;12395.061728395061 20:12:28 INFO - PROCESS | 3389 | |7;RegExp;42791.666666666664 20:12:28 INFO - PROCESS | 3389 | |8;Splay;645.9948320413437 20:12:28 INFO - PROCESS | 3389 | |9;NavierStokes;4840.579710144928 20:12:28 INFO - PROCESS | 3389 | __end_tp_report 20:12:28 INFO - PROCESS | 3389 | __startTimestamp1453522348939__endTimestamp 20:12:28 INFO - PROCESS | 3389 | 20:12:28 INFO - PROCESS | 3389 | ------- Summary: start ------- 20:12:28 INFO - PROCESS | 3389 | Number of tests: 10 20:12:28 INFO - PROCESS | 3389 | 20:12:28 INFO - PROCESS | 3389 | [#0] Richards Cycles:1 Average:167.42 Median:167.42 stddev:0.00 (0.0%) 20:12:28 INFO - PROCESS | 3389 | Values: 167.4 20:12:28 INFO - PROCESS | 3389 | 20:12:28 INFO - PROCESS | 3389 | [#1] DeltaBlue Cycles:1 Average:190.40 Median:190.40 stddev:0.00 (0.0%) 20:12:28 INFO - PROCESS | 3389 | Values: 190.4 20:12:28 INFO - PROCESS | 3389 | 20:12:28 INFO - PROCESS | 3389 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 20:12:28 INFO - PROCESS | 3389 | Values: 280.2 20:12:28 INFO - PROCESS | 3389 | 20:12:28 INFO - PROCESS | 3389 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 20:12:28 INFO - PROCESS | 3389 | Values: 5181.3 20:12:28 INFO - PROCESS | 3389 | 20:12:28 INFO - PROCESS | 3389 | [#4] RayTrace Cycles:1 Average:1129.94 Median:1129.94 stddev:0.00 (0.0%) 20:12:28 INFO - PROCESS | 3389 | Values: 1129.9 20:12:28 INFO - PROCESS | 3389 | 20:12:28 INFO - PROCESS | 3389 | [#5] Earley Cycles:1 Average:773.40 Median:773.40 stddev:0.00 (0.0%) 20:12:28 INFO - PROCESS | 3389 | Values: 773.4 20:12:28 INFO - PROCESS | 3389 | 20:12:28 INFO - PROCESS | 3389 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 20:12:28 INFO - PROCESS | 3389 | Values: 12395.1 20:12:28 INFO - PROCESS | 3389 | 20:12:28 INFO - PROCESS | 3389 | [#7] RegExp Cycles:1 Average:42791.67 Median:42791.67 stddev:0.00 (0.0%) 20:12:28 INFO - PROCESS | 3389 | Values: 42791.7 20:12:28 INFO - PROCESS | 3389 | 20:12:28 INFO - PROCESS | 3389 | [#8] Splay Cycles:1 Average:645.99 Median:645.99 stddev:0.00 (0.0%) 20:12:28 INFO - PROCESS | 3389 | Values: 646.0 20:12:28 INFO - PROCESS | 3389 | 20:12:28 INFO - PROCESS | 3389 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:12:28 INFO - PROCESS | 3389 | Values: 4840.6 20:12:28 INFO - PROCESS | 3389 | -------- Summary: end -------- 20:12:28 INFO - PROCESS | 3389 | 20:12:29 INFO - TEST-INFO | 3389: exit 0 20:12:29 INFO - TEST-OK | v8_7 | took 41544ms 20:12:29 INFO - SUITE-END | took 1215s 20:12:30 INFO - Completed test suite (00:20:15) 20:12:30 INFO - Working with test: dromaeo_css 20:12:30 INFO - Generating results file: dromaeo_css 20:12:30 INFO - Working with test: kraken 20:12:30 INFO - Generating results file: kraken 20:12:30 INFO - javascript benchmark 20:12:30 INFO - Working with test: v8_7 20:12:30 INFO - Generating results file: v8_7 20:12:30 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:12:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:12:30 INFO - process_Request line: dromaeo_css 6627.71 graph.html#tests=[[72,64,35]] 20:12:30 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:12:30 INFO - process_Request line: kraken 1499.90 graph.html#tests=[[232,64,35]] 20:12:30 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:12:30 INFO - process_Request line: v8_7 19838.00 graph.html#tests=[[230,64,35]] 20:12:30 INFO - RETURN: dromaeo_css: 6627.71 20:12:30 INFO - RETURN: kraken: 1499.90 20:12:30 INFO - RETURN: v8_7: 19838.00 20:12:30 INFO - javascript benchmark 20:12:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3100.2094465911196, 3137.309791845796, 3174.0, 3182.936341273176, 3199.040287913626, 4982.750862456872, 5028.723420211887, 5068.569171620407, 5070.163423035199, 5080.949190508094, 5096.38843338799, 5162.586993040557, 5191.610629202806, 5209.817656382027, 5211.921821172686, 4634.212183928724, 4641.976790116045, 4675.976620116895, 4726.0547890421885, 4745.193317136095, 4762.285657151438, 4763.642726795487, 4775.092732380836, 4800.255960326138, 4823.951760482403, 4524.773761311922, 4583.679142460029, 4593.081383723252, 4596.816127354902, 4706.3411122442885, 4599.31010348447, 4607.285870690015, 4615.076984603059, 4625.606823420013, 4664.720116793003, 4583.977080114578, 4590.265557510782, 4600.723956562583, 4622.168009758242, 4631.0506346198945, 4855.32025516428, 4924.433690125646, 4928.359313289249, 4997.900041999176, 5003.249512573107, 5517.972410137963, 5520.503154716095, 5520.613557051008, 5532.695701736403, 5533.861653458655, 5425.26758887553, 5600.859978500529, 5601.943980560183, 5605.103183490663, 5606.495415412592, 5090.694558326512, 5212.6611770235195, 5264.894702105975, 5270.92093618596, 5292.126799078109, 5651.180578816131, 5659.434056594308, 5669.34802497718, 5673.290838645169, 5717.313922329347, 5443.891122177534, 5467.507924286833, 5475.753591088411, 5483.75323110461, 5486.231927530149, 5397.3523177218985, 5469.480399362054, 5481.0, 5515.889682206333, 5557.916631250535, 5477.178423236546, 5477.233187353773, 5480.972595136999, 5483.369412517532, 5483.396826349099, 5359.383670877821, 5502.119660854244, 5507.807226747124, 5511.972440137773, 5522.641028333145, 4293.506246781598, 4295.3771703102875, 4310.051788606502, 4378.934315985262, 4405.867823965222, 3870.2259548090497, 3871.9612803872164, 3874.2251549690177, 3912.941305880414, 3921.1569512554365, 4972.129877271463, 5104.3619547556555, 5119.411267704188, 5139.794408223704, 5187.377514698261, 5424.593155513352, 5451.100568406168, 5494.890102197934, 5564.582656300794, 5567.526760225345, 5110.718910459886, 5112.079825631422, 5125.487451254845, 5126.564242039394, 5130.127878260705, 4738.47876733559, 4744.312074749211, 4752.1921273383605, 4776.95223047772, 4811.687240329367, 5613.410591887793, 5682.374938756733, 5695.088785794253, 5740.368559458456, 5849.8245052647635, 5531.391546929754, 5539.362973258127, 5540.058190107611, 5547.306586676666, 5559.58303127259, 5717.37108918027, 5766.365699773106, 5774.105013722879, 5781.248437703071, 5785.305763308262, 5307.336582927134, 5379.946200537945, 5380.219868119023, 5436.891262174813, 5496.340439147328, 5460.645058071372, 5487.341519017744, 5513.558915286848, 5514.0, 5535.114381698909, 5295.4969277918535, 5387.892242155213, 5398.028354896156, 5411.6211865170635, 5443.156310771837, 5357.919631205457, 5370.865728356823, 5386.919196211981, 5413.945860541344, 5450.427705091067, 5295.602829787705, 5330.147176451749, 5342.973285133549, 5363.678179309254, 5394.32570928634, 5273.973630131824, 5307.203919412119, 5421.403645598902, 5424.674519528841, 5441.156620723794, 5126.666766660155, 5128.615353848401, 5149.48505149482, 5167.58659307262, 5170.508801663836], "unit": "score", "name": "dojo.html", "value": 5081.492411893972}, {"lowerIsBetter": false, "replicates": [525.1125597739822, 528.0, 538.4991957479544, 558.4164548047291, 560.8485708858611, 28572.0, 29123.126306210823, 29162.854185729095, 35115.64884351156, 35957.280854382894, 39295.0, 39976.600233997655, 39989.80005099978, 40021.799891000504, 40022.59977400225, 8291.58542072897, 8378.622961966727, 8435.536045517494, 8438.57807109642, 8451.070382257978, 8176.1415051419635, 8314.376421768362, 8366.83266334673, 8368.623411946477, 8371.0, 8560.14398560142, 8633.09352517983, 8658.61036253367, 8659.95670021649, 8659.956700216522, 8519.616617252208, 8579.699710510165, 8594.441361311494, 8597.05432402432, 8603.182697643713, 8453.535055571941, 8624.482531048157, 8625.26685231756, 8626.698065567738, 8629.741107766777, 39619.8019009906, 40074.198516029806, 40090.398644020366, 40169.59830401688, 40216.79891600523, 2981.567672687448, 3071.0, 3075.2773098321877, 3291.555639988595, 3743.831527581265, 29429.41141177186, 29495.726922884573, 29962.400751985057, 30345.69654303473, 31026.0, 3389.3729660012978, 3406.4379377402697, 3507.0881570791776, 3582.731295152848, 3727.925441491182, 270317.0, 270780.0, 271619.0, 271730.999999998, 272853.0, 50833.23750143751, 51385.48614513882, 57029.42970570324, 57332.0, 57481.71259143677, 51841.2223816643, 52122.436326910254, 52197.47802522002, 52240.0, 52248.47751522436, 13578.25319607431, 13793.379297931617, 13940.37268322928, 13954.58136255914, 13958.441662333393, 10115.0, 10167.593296268215, 10167.898321016695, 10694.465276736288, 10839.83740243897, 18136.45590632283, 18256.178471968793, 18308.084595770426, 18334.81665183331, 18358.44924652236, 7197.568145911157, 7408.296211859864, 7417.184109747924, 7427.18300986891, 7557.2820582044615, 898.8022635020285, 992.846108853129, 1004.7538353103537, 1032.4476405123223, 1033.834586466162, 27800.58299125515, 28127.859360703067, 28193.71806281911, 28410.0, 28489.0, 1056.3503445381036, 1067.770429357692, 1073.525523667953, 1114.3258328711174, 1170.4089434835353, 14669.413223471154, 14749.336279867432, 14822.258887055605, 14945.850541494447, 15004.099754014795, 317161.0, 320466.0, 321442.0, 321893.0, 322491.0, 50809.0, 51426.74286628543, 51525.48474515282, 51548.0, 51613.22580161301, 1285.5500574798932, 1292.069709808936, 1301.6225294664441, 1304.928228947398, 1308.8809068246703, 26901.327466812705, 28265.15204543867, 28307.858460708387, 28461.573076403456, 29248.0, 42103.36844947267, 42306.15387692291, 42428.787856060524, 42436.575634244495, 42564.36153457639, 242956.0, 246964.0, 247887.0, 248791.0, 248944.0, 28145.859270703517, 33514.99455016354, 34233.657663423044, 34492.82753586216, 34532.65467345395, 39419.40870886882, 40239.597604024755, 40290.59709402986, 40587.0, 40603.79698101491, 33762.831185844894, 34906.30187396187, 35292.47061294031, 35891.46162807508, 36053.27893442064, 27338.316542086606, 30306.393872122873, 31766.205844854063, 34274.48588271228, 34880.30239395147, 31064.844675776476, 31345.686543134278, 31537.52693709642, 31540.0, 31985.68014319827, 24285.271441856774, 25255.36861578475, 25607.743922560538, 25616.743832561435, 26193.607095893956, 24275.393115171555, 24406.755932440446, 24846.78830292427, 26534.867325663246, 26718.0], "unit": "score", "name": "ext.html", "value": 17486.273851309925}, {"lowerIsBetter": false, "replicates": [354.97160227181826, 361.56250936366996, 361.7070173159739, 361.97647152935076, 363.492927366324, 13006.0, 13347.799783003238, 15399.076055436668, 16182.838171618281, 17333.046682432476, 14895.553133405989, 14967.401303947829, 16025.759613605805, 16028.519144425656, 16064.83935160648, 5073.670211436254, 5389.703566303851, 5394.1908713693065, 5394.298741163643, 5403.378611459673, 3952.584978577251, 4052.412400201969, 5318.388385335678, 5670.06443936752, 5894.793682221123, 5613.354464236604, 5786.074228123501, 5803.709814509279, 5854.824355269348, 5857.121431785224, 5690.430956904318, 5727.0, 5747.195392644991, 5750.3962083981205, 5752.942470575304, 4757.452892917289, 4953.554180123806, 4955.554000140005, 4959.231319145538, 5086.974565127188, 11695.766084678258, 11744.378273945871, 18808.34170804029, 18809.341673041377, 18968.336108236144, 2030.7969203079574, 2154.9784502154935, 2162.7188465499385, 2339.9704130182663, 2598.7661110500144, 9224.769380765467, 9739.366941148874, 9956.402615843, 10043.246756493292, 12232.143749937508, 1819.2813838533705, 1830.3044842959723, 1831.1851226204344, 1867.6544839204792, 1885.7737071551364, 48350.7582462089, 49680.25479617809, 50196.24705629418, 50490.495095049315, 50499.0, 9310.162085412345, 9629.470379129076, 9809.460479673686, 9904.504774761233, 9917.801643967225, 12734.490620375267, 12823.230606163661, 12876.742465150832, 12892.872676008541, 12927.353632318347, 6758.493113016543, 6959.1996920353795, 7072.8939065914055, 7082.114735658043, 7102.934559816069, 6821.488388370793, 6829.351211634887, 6833.282505336868, 6872.656367181621, 6876.828079298058, 3909.354956432157, 3992.5608183099835, 4015.0966032642423, 4039.4748682671066, 4103.343465045578, 1651.7274649682909, 1721.5782133377152, 1832.39799484732, 1845.391020963079, 1857.5634725839418, 780.1535334162497, 793.920607939213, 821.8972628421448, 855.2089317381522, 906.6146887572755, 10474.109700675375, 10541.947290263499, 10582.523786429629, 10806.297590656583, 14761.114333140045, 451.884769383805, 454.5704309427625, 459.3867187304985, 461.8245066874566, 471.8298619423848, 5525.419830917776, 5536.52939500147, 5709.914351284734, 5723.59934804568, 5888.558358123158, 382510.0, 387062.0, 389796.0, 455477.0, 485283.0, 74099.0, 74143.0, 77013.61493192498, 77056.61471692605, 79076.0, 447.74702293204234, 457.1930542592327, 459.4211293769874, 459.648368997717, 461.3702296365437, 8597.742067737978, 9543.665971690958, 10030.0, 10157.238207134347, 10244.64143754965, 33470.75919897515, 33857.3228535423, 34046.82976585101, 34102.658973410944, 34468.82765586156, 39623.80188099041, 39686.0, 39692.603073968894, 42899.78550107229, 42958.14083718371, 3043.589115469383, 7039.54242974205, 7042.647867606497, 7187.353138217585, 7317.317017085994, 10258.487075646337, 10497.212709047004, 10870.510827012646, 10981.560737570728, 10996.395198264172, 9425.38734982224, 9565.33042687033, 9702.223822094356, 9726.076022777825, 9730.610775569181, 9358.29812764059, 9399.953000234955, 9418.952905235705, 9771.267154963549, 9829.950850245703, 9692.079252471003, 9851.408915464808, 10065.144462720458, 10096.444695541815, 10188.643397481053, 7379.889301660587, 7420.109586849612, 7427.368673662583, 7429.108506979197, 7440.776776696708, 8128.87806682912, 9169.816603667756, 9906.910239873752, 10024.749381265527, 10088.0], "unit": "score", "name": "jquery.html", "value": 7293.305328839075}, {"lowerIsBetter": false, "replicates": [1305.9085863989512, 1441.7404867123917, 1459.9416023359065, 1586.6985272798167, 1759.4281858396016, 6617.536772425932, 6759.12131422915, 7616.543007419552, 7732.226777322265, 7743.535387876731, 7346.706131754737, 7349.0, 7371.336579707825, 7416.925830741691, 7417.740379086733, 2001.8198362147405, 2045.4988527810633, 2306.665533497646, 2334.101370972171, 2335.1243283768504, 2310.5378924215142, 2355.222776483756, 2358.151065616377, 2359.09174967637, 2359.1860808021206, 2282.3609389370918, 2301.470661747799, 2336.1122773346106, 2338.707661542307, 2339.6490526421003, 2298.0922535598347, 2314.7338056123594, 2318.0727708916484, 2345.7067866516686, 2345.824063195267, 2321.6401457774073, 2321.6633588129794, 2322.3613506285737, 2330.487292795582, 2367.6922000140044, 7695.538267703956, 7737.651805668702, 7738.264864837832, 7740.26467485588, 7741.458097933147, 4855.708657480563, 4972.776225069844, 5001.874953126165, 5004.149294619923, 5006.199008158677, 3033.8786448542032, 3067.1871953932227, 3085.676004019568, 3117.9688203117908, 3122.656507784142, 891.5809569502323, 912.0651332384293, 926.2404828041009, 926.402470406584, 946.4415994563171, 10990.340579565252, 11042.447877606088, 11046.005859472605, 11051.0, 11057.50241239146, 4397.1205758848355, 4435.778211089432, 4500.549945005473, 4511.142882852248, 4530.275155975094, 9319.254459643213, 9339.299552533586, 9369.953150234205, 9379.859302110473, 9391.765205869771, 4879.756012199376, 4906.043321552334, 4906.288588154769, 4912.8771780705765, 4915.16442204826, 4387.670924680598, 4426.026274219731, 4430.778461076933, 4431.512533621299, 4433.423654924839, 3470.0630829675847, 3560.608333083359, 3668.5230919980763, 3794.165283637595, 3811.8094095295123, 1192.2429257421427, 1232.9568465103678, 1235.5428491458217, 1237.103100252328, 1249.6688377579949, 1216.7323188898606, 1232.778099942019, 1243.875612438749, 1324.0731487958276, 1324.602619214232, 6961.547499412522, 7043.542169758949, 7054.118235220598, 7061.329173728487, 7064.046353742179, 1091.5360971587045, 1105.3202280597536, 1107.141964977133, 1108.8004159251411, 1114.5318966034285, 5700.4299570043495, 5756.769729210869, 5782.479576838105, 5793.159991801165, 5799.2750906136735, 9474.38416502925, 9573.473458959685, 9821.901780982242, 9830.262730295113, 9837.852432213522, 9581.089796469325, 9596.568154433067, 9682.273829462818, 9712.951435242778, 9713.125818676353, 7291.197968223491, 7426.220246874109, 7481.3266805988815, 7492.700291988368, 7510.887336689954, 7284.781456556312, 7296.7446139384865, 7301.233370496234, 7334.083239595051, 7351.081114860643, 8389.748307550783, 8433.704820331504, 8622.051574326944, 8718.694845680371, 8724.127587241224, 8716.651333946571, 8992.68525601627, 9000.234980026771, 9007.954960225157, 9015.729528114167, 7126.2873712628325, 7200.963995179991, 7201.675924583302, 7201.891971620325, 7202.171750248579, 6261.843453913506, 6345.777897773556, 7191.280871912767, 7491.175970643116, 7500.36246919018, 6908.1364829396325, 6977.546459480118, 7095.148582170173, 7163.4269258460245, 7200.243974382614, 7065.540739851893, 7137.072180616487, 7147.678354474165, 7152.713891444284, 7158.928410716035, 6647.567908086153, 7190.7483238086415, 7232.168300645493, 7232.927670723226, 7247.601381924045, 6338.524610654312, 6358.554901156875, 6368.363163683594, 6369.108324834619, 6388.616682999035, 6364.586301890362, 6409.647469389229, 6411.8397040072505, 6425.1968503937005, 6432.710528026344], "unit": "score", "name": "mootools.html", "value": 4532.781635599816}, {"lowerIsBetter": false, "replicates": [334.1645885286783, 338.2389623347468, 339.71463970265006, 343.47791357137146, 346.50449856704904, 5639.238702775124, 5783.074708046708, 5790.5946583739105, 5819.214406055181, 5865.266841644794, 5593.440655934404, 5737.627054241471, 5762.798302059428, 5777.335606405265, 5780.971095144519, 4491.348754430597, 4493.46078470584, 4495.9325610115875, 4499.437570303712, 4501.504834468205, 4284.378765079062, 4332.090261045184, 4395.890102747425, 4416.160929423415, 4484.686071974963, 4142.937855932163, 4318.179545886272, 4356.150550642626, 4363.192809330269, 4392.824287028515, 4323.373110898933, 4383.802728877208, 4384.057427653054, 4384.386185933972, 4391.934120988188, 3902.7853468059247, 3907.8632247871474, 3944.447777311179, 3947.013246688328, 3949.822257998368, 5480.451954804527, 5531.668099914018, 5532.0, 5532.225488431623, 5556.361018482886, 5085.23721441783, 5155.896882062375, 5176.715280659562, 5188.610854185951, 5189.273501709764, 6105.45050945417, 6112.938870611281, 6117.143599896018, 6126.448619624255, 6130.233720784902, 4316.007318316773, 4320.978395108035, 4321.416608757809, 4322.222000039991, 4349.565043495625, 6116.541259405562, 6265.624062556216, 6285.560010799246, 6408.0, 6413.7755178569, 4413.22768515515, 4431.33529970507, 4435.844745433958, 4436.245838207513, 4439.023414848728, 4485.663575231871, 4489.349044388546, 4491.46102467706, 4491.528389519119, 4494.12364588902, 5042.0, 5082.923756143661, 5101.617378696613, 5139.381094955077, 5141.074606570854, 6141.416565426277, 6157.291911430153, 6163.722632481549, 6174.8147555573405, 6176.320604733476, 1579.202502736111, 1600.4958438091965, 1603.3346161343145, 1603.9814717654374, 1604.3422196899214, 1063.186662203415, 1076.262760009396, 1077.7844431113808, 1100.6312885183554, 1101.4878081692052, 5784.855378615568, 5790.536757059509, 5798.8550286242335, 5821.825345239565, 5823.5341172706085, 6302.306746257908, 6342.238931328178, 6344.333844946306, 6346.079818426302, 6353.078803573456, 5809.651420914759, 5810.157527158538, 5814.941850581525, 5815.505682017076, 5819.709014549256, 3300.8019518828946, 3426.2119712466274, 3427.862885484553, 3432.9141771455916, 3434.0213039283685, 6609.966950165219, 6619.470442364599, 6622.437092847162, 6623.668816559153, 6624.403803657598, 6464.903026454607, 6473.805785826433, 6475.287718350977, 6480.157579514633, 6492.870142597121, 6396.42432181106, 6568.1789776277965, 6616.801495955129, 6642.535022548472, 6675.265720770614, 6352.174217351715, 6388.233411990591, 6389.456896163692, 6399.296077431386, 6406.583572067801, 6064.908316503072, 6323.747050118128, 6325.082862984934, 6332.588381755171, 6337.429631333202, 6499.675016249074, 6529.771457998947, 6613.173353330833, 6680.532362734756, 6683.0, 4314.805833737552, 4349.608535231844, 4354.194474022316, 4357.433533640607, 4364.803583838671, 6316.494680425463, 6359.17330747, 6367.108604795239, 6379.298277189599, 6379.362063793584, 6086.878262434815, 6256.499480041677, 6259.78090766821, 6267.1539342188225, 6277.089821975696, 6235.96882015587, 6238.594491358047, 6242.500599952084, 6247.156633854554, 6267.2479302484, 6035.081408651935, 6135.079738039151, 6142.447179753844, 6144.2319710036245, 6146.508279337731, 6226.221722284715, 6267.843303917256, 6268.874622507616, 6280.403361680633, 6286.968565157145, 6141.293751218488, 6198.194234749454, 6202.503799695924, 6207.6275423474735, 6209.161763162096], "unit": "score", "name": "prototype.html", "value": 4663.245931342533}, {"lowerIsBetter": false, "replicates": [774.2373761844584, 814.3485211830535, 842.1031601344571, 847.3052097280229, 865.3553102938308, 13473.595792126227, 13513.864861351383, 13598.864011359883, 13624.591262262124, 13627.795583066238, 12557.811632825493, 12600.306983115925, 12616.810747838766, 12620.432080556375, 12632.242065476077, 643.0450780590819, 652.849844535757, 794.2335646101511, 795.0896223823732, 812.10262659761, 804.4248362420868, 812.2405550809982, 812.2567850416862, 814.1370147643487, 814.3281792521194, 837.3385025829588, 837.7821766340764, 842.5408152556871, 844.9788755281137, 846.0693237438829, 680.1022650101868, 691.5021184746975, 828.5691440450962, 842.2293601354753, 842.3135144856922, 623.479394705417, 625.0124802811547, 625.5527297981964, 626.564537646336, 626.6741294526867, 12169.817452738216, 12208.938955305255, 12280.508779648804, 12306.569270075594, 12369.62891113259, 12013.459394327188, 12542.310172940484, 12583.559575414816, 12656.55702050433, 13049.478020879153, 10631.415272160028, 10671.573137074507, 10741.731456713645, 10781.5687372505, 10802.243842930999, 3584.551931008624, 3655.3603119453987, 3719.3119272934323, 3724.3296206682785, 3759.642833930772, 45923.31115033244, 47407.28889066667, 47727.52272477266, 47762.76118619419, 47852.52147478516, 10198.18414526836, 10332.483375831178, 10419.426931518688, 10517.211209159344, 10517.52671129801, 18076.367327143485, 18256.087195640164, 18289.63420731578, 18300.26798928028, 18303.35938242155, 7376.889346659805, 7385.22455142213, 7530.698772049166, 7674.577898215652, 7674.577898215652, 4083.71414001023, 4197.769122698281, 4228.175505776344, 4273.615374616299, 4345.065810850619, 3102.37952409519, 3115.610548681415, 3127.827969461656, 3131.373725254958, 3132.3578666373337, 531.3889027618193, 543.982752253281, 545.5390195284978, 548.2434240747742, 561.4806304168709, 496.4910966259613, 523.9318888544541, 550.9724513774376, 590.0, 592.5703864698146, 8199.754007379788, 8365.372597055246, 8501.787455313543, 8506.106858779864, 8615.741527754177, 586.519054375408, 591.4617697894895, 600.3126420248877, 620.2742790934617, 621.4531212532942, 3837.76973381598, 3979.6816254699556, 3980.2238563479846, 4526.88682782933, 4579.839705610288, 52050.21924671133, 52199.0, 52291.21563176555, 54671.0, 56089.0, 44959.0, 45468.3179752304, 45485.7725711376, 45812.3128153078, 45895.770521147184, 42353.0, 42649.57350426456, 42782.358264626055, 42949.57050429518, 43374.349384759254, 8988.775280617776, 9008.324375671982, 9138.13187747163, 9160.358774885693, 9279.68819134079, 32141.0, 32372.190695232806, 33077.66922330746, 33189.50215746718, 33377.99866004024, 38781.03047423837, 40530.1893962125, 42293.36559951665, 42635.3604695936, 42958.0, 11041.447927603427, 11112.611058612909, 11230.66308010761, 11427.428628568372, 11741.941290293495, 11104.5558177672, 11129.0, 11588.420578970849, 12497.0, 12538.185017973803, 10774.24580279373, 10947.945260273647, 10999.505022273857, 11508.13688973347, 11675.0, 11702.88297117018, 11993.760124797629, 12018.75962480763, 12123.333216672814, 12396.0, 11596.188266821242, 11888.28670279786, 11976.76046479083, 12048.096392770753, 12351.69120771988, 9109.544522773702, 9155.954220228856, 9255.76860578491, 9302.069793020644, 9433.575489103145, 9303.534823258675, 9352.53237338144, 10017.348872323275, 10363.740906477398, 10463.11063559606], "unit": "score", "name": "yui.html", "value": 6187.008220678342}], "name": "dromaeo_css", "value": 6627.7140549717205}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 107.0, 110.0, 110.0, 110.0, 112.0, 111.0, 104.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 153.0, 168.0, 124.0, 155.0, 158.0, 127.0, 168.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 160.0, 162.0, 162.0, 161.0, 161.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 156.0, 77.0, 74.0, 74.0, 73.0, 148.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.4}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 140.0, 96.0, 96.0, 96.0, 138.0, 97.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 58.0, 56.0, 55.0, 56.0, 57.0, 56.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 84.0, 84.0, 83.0, 83.0, 83.0, 83.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [130.0, 117.0, 123.0, 111.0, 121.0, 117.0, 121.0, 114.0, 115.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [141.0, 132.0, 147.0, 141.0, 142.0, 130.0, 144.0, 142.0, 141.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.1}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 69.0, 67.0, 66.0, 66.0, 67.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1499.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.42005692281936], "unit": "score", "name": "Richards", "value": 210.8588460000001}, {"lowerIsBetter": false, "replicates": [190.4036557501904], "unit": "score", "name": "DeltaBlue", "value": 347.251736}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1129.9435028248588], "unit": "score", "name": "RayTrace", "value": 654.890265}, {"lowerIsBetter": false, "replicates": [773.3952049497293], "unit": "score", "name": "Earley", "value": 861.7366589999996}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [42791.666666666664], "unit": "score", "name": "RegExp", "value": 21.288841285296993}, {"lowerIsBetter": false, "replicates": [645.9948320413437], "unit": "score", "name": "Splay", "value": 126.148068}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19837.996259771335}]} 20:12:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19838.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1499.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6627.71"}}} 20:12:30 INFO - Return code: 0 20:12:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:12:30 INFO - # TBPL SUCCESS # 20:12:30 INFO - Running post-action listener: _resource_record_post_action 20:12:30 INFO - Running post-run listener: _resource_record_post_run 20:12:31 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547282944; Read time: 12; Write time: 623116 20:12:31 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236433408; Read time: 0; Write time: 311272 20:12:31 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310849536; Read time: 12; Write time: 311844 20:12:31 INFO - Running post-run listener: _upload_blobber_files 20:12:31 INFO - Blob upload gear active. 20:12:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:12:31 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 20:12:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:12:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:12:32 INFO - (blobuploader) - INFO - Open directory for files ... 20:12:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:12:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:12:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:33 INFO - (blobuploader) - INFO - Done attempting. 20:12:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:12:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:12:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:33 INFO - (blobuploader) - INFO - Done attempting. 20:12:33 INFO - (blobuploader) - INFO - Iteration through files over. 20:12:33 INFO - Return code: 0 20:12:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:12:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:12:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa623072467286a0856e8345cd7f6c3d56f412a2d58b55f547ed7fbfde319c1782faff3dc87c7a8735236b3ddf92d920927bf73610788298112a46554e371906", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ab67b4cda86aaf94711ab9342242cbd63c0a0f776db452c1b5ac123f6c57ca74feb6b364506ce184f26d40ef881ee4d270431ad8d75dd8a1fdfc51911ce541a"} 20:12:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:12:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:12:33 INFO - Contents: 20:12:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa623072467286a0856e8345cd7f6c3d56f412a2d58b55f547ed7fbfde319c1782faff3dc87c7a8735236b3ddf92d920927bf73610788298112a46554e371906", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ab67b4cda86aaf94711ab9342242cbd63c0a0f776db452c1b5ac123f6c57ca74feb6b364506ce184f26d40ef881ee4d270431ad8d75dd8a1fdfc51911ce541a"} 20:12:33 INFO - Running post-run listener: copy_logs_to_upload_dir 20:12:33 INFO - Copying logs to upload dir... 20:12:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:12:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.802922 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-22 20:12:33.749451) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 20:12:33.752687) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa623072467286a0856e8345cd7f6c3d56f412a2d58b55f547ed7fbfde319c1782faff3dc87c7a8735236b3ddf92d920927bf73610788298112a46554e371906", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ab67b4cda86aaf94711ab9342242cbd63c0a0f776db452c1b5ac123f6c57ca74feb6b364506ce184f26d40ef881ee4d270431ad8d75dd8a1fdfc51911ce541a"} build_url:https://queue.taskcluster.net/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/BVk2SVg5SYCbmJ_2fDl4yg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa623072467286a0856e8345cd7f6c3d56f412a2d58b55f547ed7fbfde319c1782faff3dc87c7a8735236b3ddf92d920927bf73610788298112a46554e371906", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ab67b4cda86aaf94711ab9342242cbd63c0a0f776db452c1b5ac123f6c57ca74feb6b364506ce184f26d40ef881ee4d270431ad8d75dd8a1fdfc51911ce541a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 20:12:33.779920) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 20:12:33.780680) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453517305.428878-692967322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 20:12:33.865727) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 20:12:33.866351) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 20:12:33.866938) ========= ========= Total master_lag: 0.30 =========