builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1453316172.5 results: success (0) buildid: 20160120083056 builduid: 82065a8a69a845b0954d48c40c1a455a revision: 92016fe68730f7f2257fb9a12b242fb85c541fa7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.502244) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.502712) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.503028) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006394 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.527272) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.527575) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.542003) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.542384) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.591370) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.591661) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.592059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.592324) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 10:56:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2016-01-20 10:56:13 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165502 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.770613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.770929) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020605 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.820538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:12.820881) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 92016fe68730f7f2257fb9a12b242fb85c541fa7 --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 92016fe68730f7f2257fb9a12b242fb85c541fa7 --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=fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 10:56:13,337 truncating revision to first 12 chars 2016-01-20 10:56:13,337 Setting DEBUG logging. 2016-01-20 10:56:13,337 attempt 1/10 2016-01-20 10:56:13,337 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/92016fe68730?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 10:56:13,572 unpacking tar archive at: fx-team-92016fe68730/testing/mozharness/ program finished with exit code 0 elapsedTime=0.518208 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:13.358441) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:13.358761) ========= echo 92016fe68730f7f2257fb9a12b242fb85c541fa7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'92016fe68730f7f2257fb9a12b242fb85c541fa7'] 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=fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 92016fe68730f7f2257fb9a12b242fb85c541fa7 program finished with exit code 0 elapsedTime=0.004638 script_repo_revision: '92016fe68730f7f2257fb9a12b242fb85c541fa7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:13.409285) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:13.409578) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:13.419215) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:13.419463) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/92016fe68730f7f2257fb9a12b242fb85c541fa7 ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 10:56:13.419818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-20 10:56:13.420104) ========= /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=fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:56:14 INFO - MultiFileLogger online at 20160120 10:56:14 in /builds/slave/test-pgo 10:56:14 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 10:56:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:56:14 INFO - {'append_to_log': False, 10:56:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:56:14 INFO - 'blob_upload_branch': 'Fx-Team', 10:56:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:56:14 INFO - 'branch': 'Fx-Team', 10:56:14 INFO - 'buildbot_json_path': 'buildprops.json', 10:56:14 INFO - 'config_files': ('talos/linux_config.py',), 10:56:14 INFO - 'default_actions': ('clobber', 10:56:14 INFO - 'read-buildbot-config', 10:56:14 INFO - 'download-and-extract', 10:56:14 INFO - 'populate-webroot', 10:56:14 INFO - 'create-virtualenv', 10:56:14 INFO - 'install', 10:56:14 INFO - 'run-tests'), 10:56:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:56:14 INFO - 'download_minidump_stackwalk': True, 10:56:14 INFO - 'download_symbols': 'ondemand', 10:56:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:56:14 INFO - 'tooltool.py': '/tools/tooltool.py', 10:56:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:56:14 INFO - '/tools/misc-python/virtualenv.py')}, 10:56:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:56:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:56:14 INFO - 'installer_path': 'installer.exe', 10:56:14 INFO - 'log_level': 'info', 10:56:14 INFO - 'log_name': 'talos', 10:56:14 INFO - 'log_to_console': True, 10:56:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:56:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:56:14 INFO - 'opt_config_files': (), 10:56:14 INFO - 'pip_index': False, 10:56:14 INFO - 'sps_profile': False, 10:56:14 INFO - 'sps_profile_interval': 0, 10:56:14 INFO - 'suite': 'dromaeojs', 10:56:14 INFO - 'system_bits': '32', 10:56:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:56:14 INFO - 'title': 'talos-linux64-ix-014', 10:56:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:56:14 INFO - 'use_talos_json': True, 10:56:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:56:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:56:14 INFO - 'work_dir': 'build'} 10:56:14 INFO - ##### 10:56:14 INFO - ##### Running clobber step. 10:56:14 INFO - ##### 10:56:14 INFO - Running pre-action listener: _resource_record_pre_action 10:56:14 INFO - Running main action method: clobber 10:56:14 INFO - rmtree: /builds/slave/test-pgo/build 10:56:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:56:14 INFO - Running post-action listener: _resource_record_post_action 10:56:14 INFO - ##### 10:56:14 INFO - ##### Running read-buildbot-config step. 10:56:14 INFO - ##### 10:56:14 INFO - Running pre-action listener: _resource_record_pre_action 10:56:14 INFO - Running main action method: read_buildbot_config 10:56:14 INFO - Using buildbot properties: 10:56:14 INFO - { 10:56:14 INFO - "project": "", 10:56:14 INFO - "product": "firefox", 10:56:14 INFO - "script_repo_revision": "production", 10:56:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:56:14 INFO - "repository": "", 10:56:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:56:14 INFO - "buildid": "20160120083056", 10:56:14 INFO - "pgo_build": "True", 10:56:14 INFO - "basedir": "/builds/slave/test-pgo", 10:56:14 INFO - "buildnumber": 435, 10:56:14 INFO - "slavename": "talos-linux64-ix-014", 10:56:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:56:14 INFO - "platform": "ubuntu64_hw", 10:56:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:56:14 INFO - "branch": "fx-team", 10:56:14 INFO - "repo_path": "integration/fx-team", 10:56:14 INFO - "revision": "92016fe68730f7f2257fb9a12b242fb85c541fa7", 10:56:14 INFO - "stage_platform": "linux64-pgo", 10:56:14 INFO - "builduid": "82065a8a69a845b0954d48c40c1a455a", 10:56:14 INFO - "slavebuilddir": "test" 10:56:14 INFO - } 10:56:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:56:14 INFO - Running post-action listener: _resource_record_post_action 10:56:14 INFO - ##### 10:56:14 INFO - ##### Running download-and-extract step. 10:56:14 INFO - ##### 10:56:14 INFO - Running pre-action listener: _resource_record_pre_action 10:56:14 INFO - Running main action method: download_and_extract 10:56:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:14 INFO - https://queue.taskcluster.net/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:56:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/test_packages.json 10:56:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/test_packages.json 10:56:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:56:23 INFO - Downloaded 1448 bytes. 10:56:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:56:23 INFO - Using the following test package requirements: 10:56:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:56:23 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:56:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:23 INFO - u'jsshell-linux-x86_64.zip'], 10:56:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:56:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:56:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:56:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:56:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:56:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:56: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')]} 10:56:23 INFO - https://queue.taskcluster.net/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:56:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/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 10:56:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/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 10:56:26 INFO - Downloaded 22485658 bytes. 10:56:26 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'] 10:56:26 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 10:56:28 INFO - Return code: 0 10:56:28 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 10:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:28 INFO - https://queue.taskcluster.net/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:56:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/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 10:56:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/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 10:56:37 INFO - Downloaded 22485658 bytes. 10:56:37 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'] 10:56:37 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 10:56:39 INFO - Return code: 0 10:56:39 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')]} 10:56:39 INFO - https://queue.taskcluster.net/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:56:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/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 10:56:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/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 10:56:40 INFO - Downloaded 11132144 bytes. 10:56:40 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'] 10:56:40 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 10:56:40 INFO - Return code: 0 10:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:40 INFO - https://queue.taskcluster.net/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/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 10:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d4YZG-78SpetzoG37iZu8g/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 10:56:42 INFO - Downloaded 55953796 bytes. 10:56:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:42 INFO - mkdir: /builds/slave/test-pgo/properties 10:56:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:56:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:56:42 INFO - Contents: 10:56:42 INFO - build_url:https://queue.taskcluster.net/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:42 INFO - Running post-action listener: _resource_record_post_action 10:56:42 INFO - Running post-action listener: set_extra_try_arguments 10:56:42 INFO - ##### 10:56:42 INFO - ##### Running populate-webroot step. 10:56:42 INFO - ##### 10:56:42 INFO - Running pre-action listener: _resource_record_pre_action 10:56:42 INFO - Running main action method: populate_webroot 10:56:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:56:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:56:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:56:42 INFO - '--tppagecycles', 10:56:42 INFO - '7'], 10:56:42 INFO - 'tests': ['tsvgm']}}, 10:56:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:56:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:56:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:56:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:56:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:56:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:56:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:42 INFO - 'talos_options': ['--e10s'], 10:56:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:42 INFO - 'tests': ['damp', 'tps']}, 10:56:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:42 INFO - 'talos_options': ['--e10s'], 10:56:42 INFO - 'tests': ['damp', 'tps']}, 10:56:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:56:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:56:42 INFO - 'other': {'tests': ['a11yr', 10:56:42 INFO - 'ts_paint', 10:56:42 INFO - 'tpaint', 10:56:42 INFO - 'sessionrestore', 10:56:42 INFO - 'sessionrestore_no_auto_restore']}, 10:56:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:56:42 INFO - 'tests': ['a11yr', 10:56:42 INFO - 'ts_paint', 10:56:42 INFO - 'tpaint', 10:56:42 INFO - 'sessionrestore', 10:56:42 INFO - 'sessionrestore_no_auto_restore']}, 10:56:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:56:42 INFO - 'tests': ['a11yr', 10:56:42 INFO - 'ts_paint', 10:56:42 INFO - 'tpaint', 10:56:42 INFO - 'sessionrestore', 10:56:42 INFO - 'sessionrestore_no_auto_restore']}, 10:56:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:56:42 INFO - 'tests': ['a11yr', 10:56:42 INFO - 'ts_paint', 10:56:42 INFO - 'tpaint', 10:56:42 INFO - 'sessionrestore', 10:56:42 INFO - 'sessionrestore_no_auto_restore']}, 10:56:42 INFO - 'other_l64': {'tests': ['a11yr', 10:56:42 INFO - 'ts_paint', 10:56:42 INFO - 'tpaint', 10:56:42 INFO - 'sessionrestore', 10:56:42 INFO - 'sessionrestore_no_auto_restore']}, 10:56:42 INFO - 'other_nol64': {'tests': ['a11yr', 10:56:42 INFO - 'ts_paint', 10:56:42 INFO - 'tpaint', 10:56:42 INFO - 'sessionrestore', 10:56:42 INFO - 'sessionrestore_no_auto_restore']}, 10:56:42 INFO - 'svgr': {'tests': ['tsvgx', 10:56:42 INFO - 'tsvgr_opacity', 10:56:42 INFO - 'tart', 10:56:42 INFO - 'tscrollx', 10:56:42 INFO - 'cart']}, 10:56:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:56:42 INFO - 'tests': ['tsvgx', 10:56:42 INFO - 'tsvgr_opacity', 10:56:42 INFO - 'tart', 10:56:42 INFO - 'tscrollx', 10:56:42 INFO - 'cart']}, 10:56:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:42 INFO - 'tests': ['tp5o']}, 10:56:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:42 INFO - 'talos_options': ['--e10s'], 10:56:42 INFO - 'tests': ['tp5o']}, 10:56:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:42 INFO - 'talos_options': ['--xperf_path', 10:56:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:42 INFO - 'tests': ['tp5n']}, 10:56:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:42 INFO - 'talos_options': ['--e10s', 10:56:42 INFO - '--xperf_path', 10:56:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:42 INFO - 'tests': ['tp5n']}}, 10:56:42 INFO - 'talos.zip': {'path': '', 10:56:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:56:42 INFO - Running post-action listener: _resource_record_post_action 10:56:42 INFO - ##### 10:56:42 INFO - ##### Running create-virtualenv step. 10:56:42 INFO - ##### 10:56:42 INFO - Running pre-action listener: _resource_record_pre_action 10:56:42 INFO - Running main action method: create_virtualenv 10:56:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:56:42 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 10:56:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:56:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:56:42 INFO - Using real prefix '/usr' 10:56:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:56:42 INFO - Installing distribute.............................................................................................................................................................................................done. 10:56:44 INFO - Installing pip.................done. 10:56:44 INFO - Return code: 0 10:56:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:56: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')]} 10:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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')]} 10:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9374122f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2623630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4840>, '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 0x26216b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2621b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', '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 10:56:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:56:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:56:44 INFO - Using env: {'DISPLAY': ':0', 10:56:44 INFO - 'HOME': '/home/cltbld', 10:56:44 INFO - 'LANG': 'en_US.UTF-8', 10:56:44 INFO - 'LANGUAGE': 'en_US:en', 10:56:44 INFO - 'LOGNAME': 'cltbld', 10:56:44 INFO - 'MAIL': '/var/mail/cltbld', 10:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:44 INFO - 'MOZ_NO_REMOTE': '1', 10:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:44 INFO - 'NO_EM_RESTART': '1', 10:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:44 INFO - 'SHELL': '/bin/bash', 10:56:44 INFO - 'SHLVL': '1', 10:56:44 INFO - 'TERM': 'linux', 10:56:44 INFO - 'TMOUT': '86400', 10:56:44 INFO - 'USER': 'cltbld', 10:56:44 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', 10:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:44 INFO - '_': '/tools/buildbot/bin/python'} 10:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:44 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 10:56:44 INFO - Cleaning up... 10:56:44 INFO - Return code: 0 10:56:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:56: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')]} 10:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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')]} 10:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9374122f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2623630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4840>, '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 0x26216b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2621b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', '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 10:56:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:56:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:56:44 INFO - Using env: {'DISPLAY': ':0', 10:56:44 INFO - 'HOME': '/home/cltbld', 10:56:44 INFO - 'LANG': 'en_US.UTF-8', 10:56:44 INFO - 'LANGUAGE': 'en_US:en', 10:56:44 INFO - 'LOGNAME': 'cltbld', 10:56:44 INFO - 'MAIL': '/var/mail/cltbld', 10:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:44 INFO - 'MOZ_NO_REMOTE': '1', 10:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:44 INFO - 'NO_EM_RESTART': '1', 10:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:44 INFO - 'SHELL': '/bin/bash', 10:56:44 INFO - 'SHLVL': '1', 10:56:44 INFO - 'TERM': 'linux', 10:56:44 INFO - 'TMOUT': '86400', 10:56:44 INFO - 'USER': 'cltbld', 10:56:44 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', 10:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:44 INFO - '_': '/tools/buildbot/bin/python'} 10:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:45 INFO - Downloading/unpacking psutil>=0.7.1 10:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:56:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:47 INFO - Installing collected packages: psutil 10:56:47 INFO - Running setup.py install for psutil 10:56:47 INFO - building 'psutil._psutil_linux' extension 10:56:47 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 10:56:47 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 10:56:47 INFO - building 'psutil._psutil_posix' extension 10:56:47 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 10:56:47 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 10:56:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:47 INFO - Successfully installed psutil 10:56:47 INFO - Cleaning up... 10:56:47 INFO - Return code: 0 10:56:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:56: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')]} 10:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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')]} 10:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9374122f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2623630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4840>, '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 0x26216b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2621b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', '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 10:56:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:56:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:56:47 INFO - Using env: {'DISPLAY': ':0', 10:56:47 INFO - 'HOME': '/home/cltbld', 10:56:47 INFO - 'LANG': 'en_US.UTF-8', 10:56:47 INFO - 'LANGUAGE': 'en_US:en', 10:56:47 INFO - 'LOGNAME': 'cltbld', 10:56:47 INFO - 'MAIL': '/var/mail/cltbld', 10:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:47 INFO - 'MOZ_NO_REMOTE': '1', 10:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:47 INFO - 'NO_EM_RESTART': '1', 10:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:47 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:47 INFO - 'SHELL': '/bin/bash', 10:56:47 INFO - 'SHLVL': '1', 10:56:47 INFO - 'TERM': 'linux', 10:56:47 INFO - 'TMOUT': '86400', 10:56:47 INFO - 'USER': 'cltbld', 10:56:47 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', 10:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:47 INFO - '_': '/tools/buildbot/bin/python'} 10:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:56:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:56:49 INFO - Installing collected packages: mozsystemmonitor 10:56:49 INFO - Running setup.py install for mozsystemmonitor 10:56:49 INFO - Successfully installed mozsystemmonitor 10:56:49 INFO - Cleaning up... 10:56:49 INFO - Return code: 0 10:56:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:49 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 0x7f9374122f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2623630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4840>, '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 0x26216b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2621b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', '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 10:56:49 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 10:56:49 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 10:56:49 INFO - Using env: {'DISPLAY': ':0', 10:56:49 INFO - 'HOME': '/home/cltbld', 10:56:49 INFO - 'LANG': 'en_US.UTF-8', 10:56:49 INFO - 'LANGUAGE': 'en_US:en', 10:56:49 INFO - 'LOGNAME': 'cltbld', 10:56:49 INFO - 'MAIL': '/var/mail/cltbld', 10:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:49 INFO - 'MOZ_NO_REMOTE': '1', 10:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:49 INFO - 'NO_EM_RESTART': '1', 10:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:49 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:49 INFO - 'SHELL': '/bin/bash', 10:56:49 INFO - 'SHLVL': '1', 10:56:49 INFO - 'TERM': 'linux', 10:56:49 INFO - 'TMOUT': '86400', 10:56:49 INFO - 'USER': 'cltbld', 10:56:49 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', 10:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:49 INFO - '_': '/tools/buildbot/bin/python'} 10:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:56:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:56:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:56: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 10:56: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 10:56: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 10:56: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 10:56: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 10:56: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 10:56:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:56:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:56:52 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 10:56:52 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 10:56:52 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 10:56:52 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 10:56:52 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 10:56:52 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 10:56:52 INFO - Downloading docopt-0.6.1.tar.gz 10:56:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:56:52 INFO - Installing collected packages: blobuploader, requests, docopt 10:56:52 INFO - Running setup.py install for blobuploader 10:56:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:56:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:56:52 INFO - Running setup.py install for requests 10:56:53 INFO - Running setup.py install for docopt 10:56:53 INFO - Successfully installed blobuploader requests docopt 10:56:53 INFO - Cleaning up... 10:56:53 INFO - Return code: 0 10:56:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:56: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')]} 10:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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')]} 10:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:53 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 0x7f9374122f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2623630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4840>, '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 0x26216b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2621b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', '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 10:56:53 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 10:56:53 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 10:56:53 INFO - Using env: {'DISPLAY': ':0', 10:56:53 INFO - 'HOME': '/home/cltbld', 10:56:53 INFO - 'LANG': 'en_US.UTF-8', 10:56:53 INFO - 'LANGUAGE': 'en_US:en', 10:56:53 INFO - 'LOGNAME': 'cltbld', 10:56:53 INFO - 'MAIL': '/var/mail/cltbld', 10:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:53 INFO - 'MOZ_NO_REMOTE': '1', 10:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:53 INFO - 'NO_EM_RESTART': '1', 10:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:53 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:53 INFO - 'SHELL': '/bin/bash', 10:56:53 INFO - 'SHLVL': '1', 10:56:53 INFO - 'TERM': 'linux', 10:56:53 INFO - 'TMOUT': '86400', 10:56:53 INFO - 'USER': 'cltbld', 10:56:53 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', 10:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:53 INFO - '_': '/tools/buildbot/bin/python'} 10:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:56:53 INFO - Running setup.py (path:/tmp/pip-CBANGI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:56:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:56:53 INFO - Running setup.py (path:/tmp/pip-5pIbxh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:56:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:56:53 INFO - Running setup.py (path:/tmp/pip-68qNmk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:56:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:56:53 INFO - Running setup.py (path:/tmp/pip-qD7ncp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:56:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:56:53 INFO - Running setup.py (path:/tmp/pip-Oodwqu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:56:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:56:53 INFO - Running setup.py (path:/tmp/pip-RFiKcY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:56:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:56:53 INFO - Running setup.py (path:/tmp/pip-AHJYdB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:56:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:56:53 INFO - Running setup.py (path:/tmp/pip-J7LmPD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:56:54 INFO - Running setup.py (path:/tmp/pip-GdDgWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:56:54 INFO - Running setup.py (path:/tmp/pip-oau6iW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:56:54 INFO - Running setup.py (path:/tmp/pip-_YeBJN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:56:54 INFO - Running setup.py (path:/tmp/pip-f3g3s4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:56:54 INFO - Running setup.py (path:/tmp/pip-pePpeM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:56:54 INFO - Running setup.py (path:/tmp/pip-K8_1bR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:56:54 INFO - Running setup.py (path:/tmp/pip-RdLDqk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:56:54 INFO - Running setup.py (path:/tmp/pip-ztSIJK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:56:54 INFO - Running setup.py (path:/tmp/pip-n1_9fj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:56:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:56:54 INFO - Running setup.py install for manifestparser 10:56:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:56:54 INFO - Running setup.py install for mozcrash 10:56:54 INFO - Running setup.py install for mozdebug 10:56:54 INFO - Running setup.py install for mozdevice 10:56:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:56:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:56:55 INFO - Running setup.py install for mozfile 10:56:55 INFO - Running setup.py install for mozhttpd 10:56:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:56:55 INFO - Running setup.py install for mozinfo 10:56:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:56:55 INFO - Running setup.py install for mozInstall 10:56:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:56:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:56:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:56:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:56:55 INFO - Running setup.py install for mozleak 10:56:55 INFO - Running setup.py install for mozlog 10:56:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:56:55 INFO - Running setup.py install for moznetwork 10:56:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:56:55 INFO - Running setup.py install for mozprocess 10:56:55 INFO - Running setup.py install for mozprofile 10:56:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:56:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:56:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:56:55 INFO - Running setup.py install for mozrunner 10:56:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:56:56 INFO - Running setup.py install for mozscreenshot 10:56:56 INFO - Running setup.py install for moztest 10:56:56 INFO - Running setup.py install for mozversion 10:56:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:56:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:56:56 INFO - Cleaning up... 10:56:56 INFO - Return code: 0 10:56:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:56 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 0x7f9374122f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2623630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4840>, '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 0x26216b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2621b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', '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 10:56:56 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 10:56:56 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 10:56:56 INFO - Using env: {'DISPLAY': ':0', 10:56:56 INFO - 'HOME': '/home/cltbld', 10:56:56 INFO - 'LANG': 'en_US.UTF-8', 10:56:56 INFO - 'LANGUAGE': 'en_US:en', 10:56:56 INFO - 'LOGNAME': 'cltbld', 10:56:56 INFO - 'MAIL': '/var/mail/cltbld', 10:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:56 INFO - 'MOZ_NO_REMOTE': '1', 10:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:56 INFO - 'NO_EM_RESTART': '1', 10:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:56 INFO - 'SHELL': '/bin/bash', 10:56:56 INFO - 'SHLVL': '1', 10:56:56 INFO - 'TERM': 'linux', 10:56:56 INFO - 'TMOUT': '86400', 10:56:56 INFO - 'USER': 'cltbld', 10:56:56 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', 10:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:56 INFO - '_': '/tools/buildbot/bin/python'} 10:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:56:56 INFO - Running setup.py (path:/tmp/pip-B7W1KY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:56:56 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)) 10:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:56:56 INFO - Running setup.py (path:/tmp/pip-Kls_Hm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:56:56 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)) 10:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:56:56 INFO - Running setup.py (path:/tmp/pip-sA5GUK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:56:56 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)) 10:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:56:56 INFO - Running setup.py (path:/tmp/pip-AGke_k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:56:56 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)) 10:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:56:56 INFO - Running setup.py (path:/tmp/pip-GdyJZ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:56:57 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)) 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:56:57 INFO - Running setup.py (path:/tmp/pip-u8wv7Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:56:57 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)) 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:56:57 INFO - Running setup.py (path:/tmp/pip-B_k7y0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:56:57 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)) 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:56:57 INFO - Running setup.py (path:/tmp/pip-MqVK8t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:56:57 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)) 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:56:57 INFO - Running setup.py (path:/tmp/pip-kUZlsA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:56:57 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)) 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:56:57 INFO - Running setup.py (path:/tmp/pip-lxLEiB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:56:57 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)) 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:56:57 INFO - Running setup.py (path:/tmp/pip-wVLk34-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:56:57 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)) 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:56:57 INFO - Running setup.py (path:/tmp/pip-PTHfmN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:56:57 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)) 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:56:57 INFO - Running setup.py (path:/tmp/pip-R3ly7m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:56:57 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)) 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:56:57 INFO - Running setup.py (path:/tmp/pip-qyJQje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:56:57 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)) 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:56:57 INFO - Running setup.py (path:/tmp/pip-3UI5Fm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:56:57 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)) 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:56:57 INFO - Running setup.py (path:/tmp/pip-rr_BR0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:56:57 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)) 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:56:57 INFO - Running setup.py (path:/tmp/pip-xsl_RM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:56:57 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)) 10:56:57 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)) 10:56:57 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)) 10:56:57 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)) 10:56:57 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)) 10:56:57 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)) 10:56:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:59 INFO - Downloading blessings-1.6.tar.gz 10:56:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:56:59 INFO - Installing collected packages: blessings 10:56:59 INFO - Running setup.py install for blessings 10:56:59 INFO - Successfully installed blessings 10:56:59 INFO - Cleaning up... 10:57:00 INFO - Return code: 0 10:57:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:57:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:57:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:57:00 INFO - Reading from file tmpfile_stdout 10:57:00 INFO - Current package versions: 10:57:00 INFO - argparse == 1.2.1 10:57:00 INFO - blessings == 1.6 10:57:00 INFO - blobuploader == 1.2.4 10:57:00 INFO - docopt == 0.6.1 10:57:00 INFO - manifestparser == 1.1 10:57:00 INFO - mozInstall == 1.12 10:57:00 INFO - mozcrash == 0.16 10:57:00 INFO - mozdebug == 0.1 10:57:00 INFO - mozdevice == 0.48 10:57:00 INFO - mozfile == 1.2 10:57:00 INFO - mozhttpd == 0.7 10:57:00 INFO - mozinfo == 0.9 10:57:00 INFO - mozleak == 0.1 10:57:00 INFO - mozlog == 3.1 10:57:00 INFO - moznetwork == 0.27 10:57:00 INFO - mozprocess == 0.22 10:57:00 INFO - mozprofile == 0.28 10:57:00 INFO - mozrunner == 6.11 10:57:00 INFO - mozscreenshot == 0.1 10:57:00 INFO - mozsystemmonitor == 0.0 10:57:00 INFO - moztest == 0.7 10:57:00 INFO - mozversion == 1.4 10:57:00 INFO - psutil == 3.1.1 10:57:00 INFO - requests == 1.2.3 10:57:00 INFO - wsgiref == 0.1.2 10:57:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:57:00 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')]} 10:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:00 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')]} 10:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:00 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 0x7f9374122f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2623630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4840>, '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 0x26216b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2621b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', '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 10:57:00 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 10:57:00 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 10:57:00 INFO - Using env: {'DISPLAY': ':0', 10:57:00 INFO - 'HOME': '/home/cltbld', 10:57:00 INFO - 'LANG': 'en_US.UTF-8', 10:57:00 INFO - 'LANGUAGE': 'en_US:en', 10:57:00 INFO - 'LOGNAME': 'cltbld', 10:57:00 INFO - 'MAIL': '/var/mail/cltbld', 10:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:00 INFO - 'MOZ_NO_REMOTE': '1', 10:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:00 INFO - 'NO_EM_RESTART': '1', 10:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:00 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:00 INFO - 'SHELL': '/bin/bash', 10:57:00 INFO - 'SHLVL': '1', 10:57:00 INFO - 'TERM': 'linux', 10:57:00 INFO - 'TMOUT': '86400', 10:57:00 INFO - 'USER': 'cltbld', 10:57:00 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', 10:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:00 INFO - '_': '/tools/buildbot/bin/python'} 10:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:00 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)) 10:57:00 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)) 10:57:00 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)) 10:57:00 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)) 10:57:00 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)) 10:57:00 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)) 10:57:00 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)) 10:57:00 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)) 10:57:00 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)) 10:57:00 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)) 10:57:00 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)) 10:57:00 INFO - Cleaning up... 10:57:00 INFO - Return code: 0 10:57:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:57:00 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')]} 10:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:00 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')]} 10:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:00 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 0x7f9374122f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2623630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4840>, '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 0x26216b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2621b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', '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 10:57:00 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 10:57:00 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 10:57:00 INFO - Using env: {'DISPLAY': ':0', 10:57:00 INFO - 'HOME': '/home/cltbld', 10:57:00 INFO - 'LANG': 'en_US.UTF-8', 10:57:00 INFO - 'LANGUAGE': 'en_US:en', 10:57:00 INFO - 'LOGNAME': 'cltbld', 10:57:00 INFO - 'MAIL': '/var/mail/cltbld', 10:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:00 INFO - 'MOZ_NO_REMOTE': '1', 10:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:00 INFO - 'NO_EM_RESTART': '1', 10:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:00 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:00 INFO - 'SHELL': '/bin/bash', 10:57:00 INFO - 'SHLVL': '1', 10:57:00 INFO - 'TERM': 'linux', 10:57:00 INFO - 'TMOUT': '86400', 10:57:00 INFO - 'USER': 'cltbld', 10:57:00 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', 10:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:00 INFO - '_': '/tools/buildbot/bin/python'} 10:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:00 INFO - Downloading/unpacking jsonschema 10:57:00 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 10:57:00 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 10:57:00 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 10:57:00 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 10:57:00 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 10:57:00 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 10:57:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:57:02 INFO - Downloading/unpacking functools32 (from jsonschema) 10:57:02 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 10:57:02 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 10:57:02 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 10:57:02 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 10:57:02 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 10:57:02 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 10:57:02 INFO - Downloading functools32-3.2.3-2.tar.gz 10:57:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:57:02 INFO - warning: no files found matching '*.txt' 10:57:02 INFO - no previously-included directories found matching 'build' 10:57:02 INFO - no previously-included directories found matching 'dist' 10:57:02 INFO - no previously-included directories found matching '.git*' 10:57:02 INFO - Installing collected packages: jsonschema, functools32 10:57:02 INFO - Running setup.py install for functools32 10:57:02 INFO - warning: no files found matching '*.txt' 10:57:02 INFO - no previously-included directories found matching 'build' 10:57:02 INFO - no previously-included directories found matching 'dist' 10:57:02 INFO - no previously-included directories found matching '.git*' 10:57:02 INFO - Successfully installed jsonschema functools32 10:57:02 INFO - Cleaning up... 10:57:02 INFO - Return code: 0 10:57:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:57:02 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')]} 10:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:02 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')]} 10:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:02 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 0x7f9374122f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2623630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4840>, '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 0x26216b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2621b60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', '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 10:57:02 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 10:57:02 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 10:57:02 INFO - Using env: {'DISPLAY': ':0', 10:57:02 INFO - 'HOME': '/home/cltbld', 10:57:02 INFO - 'LANG': 'en_US.UTF-8', 10:57:02 INFO - 'LANGUAGE': 'en_US:en', 10:57:02 INFO - 'LOGNAME': 'cltbld', 10:57:02 INFO - 'MAIL': '/var/mail/cltbld', 10:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:02 INFO - 'MOZ_NO_REMOTE': '1', 10:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:02 INFO - 'NO_EM_RESTART': '1', 10:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:02 INFO - 'SHELL': '/bin/bash', 10:57:02 INFO - 'SHLVL': '1', 10:57:02 INFO - 'TERM': 'linux', 10:57:02 INFO - 'TMOUT': '86400', 10:57:02 INFO - 'USER': 'cltbld', 10:57:02 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', 10:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:02 INFO - '_': '/tools/buildbot/bin/python'} 10:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:03 INFO - Downloading/unpacking flake8 10:57:03 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 10:57:03 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 10:57:03 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 10:57:03 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 10:57:03 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 10:57:03 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 10:57:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:57:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:57:04 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 10:57:04 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 10:57:04 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 10:57:04 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 10:57:04 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 10:57:04 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 10:57:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:57:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:57:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:05 INFO - no previously-included directories found matching 'docs/_build' 10:57:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:57:05 INFO - Running setup.py install for pep8 10:57:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:05 INFO - no previously-included directories found matching 'docs/_build' 10:57:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:57:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:57:05 INFO - Cleaning up... 10:57:05 INFO - Return code: 0 10:57:05 INFO - Running post-action listener: _resource_record_post_action 10:57:05 INFO - Running post-action listener: _start_resource_monitoring 10:57:05 INFO - Starting resource monitoring. 10:57:05 INFO - ##### 10:57:05 INFO - ##### Running install step. 10:57:05 INFO - ##### 10:57:05 INFO - Running pre-action listener: _resource_record_pre_action 10:57:05 INFO - Running main action method: install 10:57:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:57:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:57:06 INFO - Reading from file tmpfile_stdout 10:57:06 INFO - Detecting whether we're running mozinstall >=1.0... 10:57:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:57:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:57:06 INFO - Reading from file tmpfile_stdout 10:57:06 INFO - Output received: 10:57:06 INFO - Usage: mozinstall [options] installer 10:57:06 INFO - Options: 10:57:06 INFO - -h, --help show this help message and exit 10:57:06 INFO - -d DEST, --destination=DEST 10:57:06 INFO - Directory to install application into. [default: 10:57:06 INFO - "/builds/slave/test-pgo"] 10:57:06 INFO - --app=APP Application being installed. [default: firefox] 10:57:06 INFO - mkdir: /builds/slave/test-pgo/build/application 10:57:06 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'] 10:57:06 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 10:57:22 INFO - Reading from file tmpfile_stdout 10:57:22 INFO - Output received: 10:57:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:57:22 INFO - Running post-action listener: _resource_record_post_action 10:57:22 INFO - ##### 10:57:22 INFO - ##### Running run-tests step. 10:57:22 INFO - ##### 10:57:22 INFO - Running pre-action listener: _resource_record_pre_action 10:57:22 INFO - Running main action method: run_tests 10:57:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:57:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:57:22 INFO - Python 2.7.3 10:57:22 INFO - Return code: 0 10:57:22 INFO - grabbing minidump binary from tooltool 10:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:22 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 0x26b4840>, '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 0x26216b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2621b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:57:22 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 10:57:22 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 10:57:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:57:22 INFO - Return code: 0 10:57:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:57:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:57:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:57:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:57:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:57:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:57:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:57:23 INFO - Return code: 0 10:57:23 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/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 10:57:23 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/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 10:57:23 INFO - Using env: {'DISPLAY': ':0', 10:57:23 INFO - 'HOME': '/home/cltbld', 10:57:23 INFO - 'LANG': 'en_US.UTF-8', 10:57:23 INFO - 'LANGUAGE': 'en_US:en', 10:57:23 INFO - 'LOGNAME': 'cltbld', 10:57:23 INFO - 'MAIL': '/var/mail/cltbld', 10:57:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:57:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:23 INFO - 'MOZ_NO_REMOTE': '1', 10:57:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:57:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:23 INFO - 'NO_EM_RESTART': '1', 10:57:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:23 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:57:23 INFO - 'SHELL': '/bin/bash', 10:57:23 INFO - 'SHLVL': '1', 10:57:23 INFO - 'TERM': 'linux', 10:57:23 INFO - 'TMOUT': '86400', 10:57:23 INFO - 'USER': 'cltbld', 10:57:23 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231', 10:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:23 INFO - '_': '/tools/buildbot/bin/python'} 10:57:23 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/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 10:57:23 INFO - mozversion application_buildid: 20160120083056 10:57:23 INFO - mozversion application_changeset: 92016fe68730f7f2257fb9a12b242fb85c541fa7 10:57:23 INFO - mozversion application_display_name: Nightly 10:57:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:57:23 INFO - mozversion application_name: Firefox 10:57:23 INFO - mozversion application_remotingname: firefox 10:57:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:57:23 INFO - mozversion application_vendor: Mozilla 10:57:23 INFO - mozversion application_version: 46.0a1 10:57:23 INFO - mozversion platform_buildid: 20160120083056 10:57:23 INFO - mozversion platform_changeset: 92016fe68730f7f2257fb9a12b242fb85c541fa7 10:57:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:57:23 INFO - mozversion platform_version: 46.0a1 10:57:23 INFO - using testdate: 1453316243 10:57:23 INFO - actual date: 1453316243 10:57:23 INFO - starting webserver on 'localhost:48831' 10:57:23 INFO - SUITE-START | Running 3 tests 10:57:23 INFO - TEST-START | dromaeo_css 10:57:23 INFO - operating with platform_type : linux_ 10:57:23 INFO - Initialising browser for dromaeo_css test... 10:57:23 INFO - TEST-INFO | started process 1218 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGYer9H/profile http://localhost:48831/getInfo.html) 10:57:27 INFO - PROCESS | 1218 | __metrics Screen width/height:1600/1200 10:57:27 INFO - PROCESS | 1218 | colorDepth:24 10:57:27 INFO - PROCESS | 1218 | Browser inner width/height: 1024/697 10:57:27 INFO - PROCESS | 1218 | __metrics 10:57:27 INFO - PROCESS | 1218 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:57:27 INFO - PROCESS | 1218 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:57:28 INFO - TEST-INFO | 1218: exit 0 10:57:28 INFO - Browser initialized. 10:57:28 INFO - Running cycle 1/1 for dromaeo_css test... 10:57:28 INFO - TEST-INFO | started process 1330 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGYer9H/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:40 INFO - PROCESS | 1330 | RSS: Main: 149278720 10:57:40 INFO - PROCESS | 1330 | 10:58:31 INFO - PROCESS | 1330 | 1453316311302 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] 11:00:39 INFO - PROCESS | 1330 | Cycle 1(1): loaded http://localhost:48831/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48831/tests/dromaeo/cssquery-ext.html) 11:00:40 INFO - PROCESS | 1330 | RSS: Main: 263294976 11:00:40 INFO - PROCESS | 1330 | 11:03:43 INFO - PROCESS | 1330 | Cycle 1(1): loaded http://localhost:48831/tests/dromaeo/cssquery-ext.html (next: http://localhost:48831/tests/dromaeo/cssquery-jquery.html) 11:03:43 INFO - PROCESS | 1330 | RSS: Main: 227635200 11:03:43 INFO - PROCESS | 1330 | 11:06:45 INFO - PROCESS | 1330 | Cycle 1(1): loaded http://localhost:48831/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48831/tests/dromaeo/cssquery-mootools.html) 11:06:46 INFO - PROCESS | 1330 | RSS: Main: 218918912 11:06:46 INFO - PROCESS | 1330 | 11:09:48 INFO - PROCESS | 1330 | Cycle 1(1): loaded http://localhost:48831/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48831/tests/dromaeo/cssquery-prototype.html) 11:09:48 INFO - PROCESS | 1330 | RSS: Main: 207740928 11:09:48 INFO - PROCESS | 1330 | 11:12:51 INFO - PROCESS | 1330 | Cycle 1(1): loaded http://localhost:48831/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48831/tests/dromaeo/cssquery-yui.html) 11:12:52 INFO - PROCESS | 1330 | RSS: Main: 211578880 11:12:52 INFO - PROCESS | 1330 | 11:15:54 INFO - PROCESS | 1330 | Cycle 1(1): loaded http://localhost:48831/tests/dromaeo/cssquery-yui.html (next: http://localhost:48831/tests/dromaeo/cssquery-dojo.html) 11:15:54 INFO - PROCESS | 1330 | RSS: Main: 271142912 11:15:54 INFO - PROCESS | 1330 | 11:15:54 INFO - PROCESS | 1330 | __start_tp_report 11:15:54 INFO - PROCESS | 1330 | _x_x_mozilla_page_load 11:15:54 INFO - PROCESS | 1330 | _x_x_mozilla_page_load_details 11:15:54 INFO - PROCESS | 1330 | |i|pagename|runs| 11:15:54 INFO - PROCESS | 1330 | |0;dojo.html;3150.6691797361264;3154.82648454335;3193.4890417533184;3200.631927328358;3223.2586505103827;5163.483651634835;5172.094883395405;5173.637845350822;5214.504622060903;5289.841304760854;5171.922421163686;5255.316808814849;5266.394364648067;5290.470952904708;5293.391260005101;4801.687890287138;4804.951950480503;4839.225723884179;4853.8058477661025;4911.066897289522;349.94897982118204;4816.542428469307;4843.878903027417;4844.224924012159;4847.054824309261;4737.313089602006;4760.262159365304;4837.758112094381;4839.927401088987;4848.781804818792;4819.204831202847;4822.156122678517;4832.661713680044;4835.516448355172;4858.052679727454;4804.183288840871;4805.063012712522;4810.903781924377;4815.927761083586;4846.224604063368;5040.49595040493;5108.770105345268;5134.897302053975;5157.535821776059;5171.922421163686;5656.717164141776;5707.971460142714;5709.74306156224;5717.942820571824;5764.106563482625;5722.37053924068;5770.307563092414;5778.075507918755;5787.971060144714;5788.18965344852;5297.867553311159;5311.814086506954;5362.927414517073;5376.758045887945;5407.594430417735;5644.491995720405;5711.286089238845;5733.082706766897;5734.139879018181;5767.826965191051;5512.503874651301;5514.6139770216505;5519.613627046148;5526.811735476892;5550.750216240198;5555.944440555623;5586.86032849182;5609.214709940612;5612.887742245132;5685.800996965169;5694.715264236772;5706.400827913092;5709.0865461525955;5712.800051998243;5713.4000929902595;5632.943670563324;5654.575906807006;5658.094704847204;5658.660480371191;5658.773649054074;4365.497967733688;4443.666724995638;4446.555344465528;4450.621697155713;4459.598636122764;3955.5055618047745;4018.276710192135;4028.597140285948;4055;4056.229316429928;5131.897362052738;5251.396089449686;5262.342207224097;5300.867478313073;5310.840674779763;5571.470710282517;5571.693556854412;5574.749136288877;5581.441855814386;5582.888342233133;5134.820281290137;5135.794568217229;5136.126858434075;5141.871453213699;5189.40321862983;4751.358566593535;4845.345878306454;4878.804847806048;4887.462379138292;4936.333594964705;5661.518770904519;5712.742926568314;5714.742836572281;5718.542516598662;5721.22763426932;5515.862103447446;5523.28197334344;5525.530329922001;5538.556915446674;5574.052411090043;5769.567282453749;5773.942260577341;5865.560082993878;5901.852453688693;5945.078512830518;5509.559235261249;5511.5315198207;5512.200730894078;5515.558755299647;5524.8342549723575;5578.972105139448;5585.748641311069;5588.720563971867;5593.0491816390495;5617.8033768817895;5476.945230547643;5550.333959924674;5577.386487486455;5586.273784408001;5623.212750215055;5543.085390910454;5579.107342825128;5583.55331573465;5584.720763961867;5592.5525957922455;5418.268533748052;5466.671999680032;5492.80775172867;5495.148252020943;5545.445455454584;5350.197470379474;5421.83734487966;5422.810201642924;5434.212039254365;5484.780608775604;5391.487808658171;5392.622516423813;5415.675059496442;5422.295101636762;5425.159100339453 11:15:54 INFO - PROCESS | 1330 | |1;ext.html;527.9260903473514;535.4752342704147;537.9004884096441;571.9542436605072;594.2215697436358;27595.448091038168;28076.438471230587;35461.64538354619;35817.2836543269;35861;37830;38302.23395532088;38411.80794096032;38441.80779096101;38494;8304.294134998532;8492.278156356717;8492.575371231414;8497.61760720769;8501.277391421705;8357.540335281557;8498.915010849905;8516.701915432961;8519.787005324855;8522.659093636246;8492.15078492152;8560.828783424327;8727.825443491127;8793;8796.25231855293;8640.265577425926;8730.214280714767;8734.650613975466;8739.868901966476;8741.4755114693;8475.703350382708;8607.870881936777;8616.267617252479;8622;8623.655053797904;39146.412803807965;39619.60380396188;39751.20497590032;39837.80081099576;39864.2162940449;3282.261491164493;3306.801591904469;3345.080102971678;3668.284684486526;3878.2825177342283;29608.55587166194;29802.403951921056;29911.252218694706;31015.689843101507;31076.270847498447;3523.7533372663925;3579.49887015818;3626.12972886508;3691.261747650454;3805.46723458716;275153;276414;276550;277010.614946926;278066;50753;51383;55878.44121558814;56560.43439565552;57137.14294285589;56888.43111568914;57656;57897.710511448015;57901.71049144727;57961.710191449616;15064.322105505278;15071;15075;15240.923795380952;15260.771088433683;10900;11347.092232621371;11935.283882967049;12177.452014659362;12191.634250972485;18374.35689750852;18474.261029558667;18497.352592659194;19106.94288913767;19170.808291916903;7294.161171465349;7497.437692173109;7568.394528437711;7610.353119984753;7647.808804779814;928.8978212396631;963.4508330251689;1014.1633152649094;1043;1061.6549621373085;28284.90871643124;28446.404712590764;28616.85691571529;28679.283017924718;28711;1034.5137785240925;1054.0144964458257;1060.204846365226;1149.9540018399337;1171.5313874450117;14731.262758094024;14922.272547952467;14956.92521537407;14960.40158393652;14961;313834;317210;319415;319741;319979;51928.74035629873;52050.739746301784;52087.47912520902;52248.477515225124;52255.477445225064;1204.241327963395;1249.4439974211389;1251.8497780266425;1254.6737848159362;1300.635821969831;25476.49047019012;25670;26469.22720962542;27792.583111253753;28273.293167670974;38159.61840381672;39139;39220.60779392169;39414;39468.21063578655;213262;216676;289714;294616;402307;30975;31115.84442077775;31144;31461;31532.211694707818;39751.80124099361;40362;40525;40870;41179;34255.65744342525;34629.30741385208;34755.652443476254;34788.30423391467;35101.47347789734;31708.682913170574;32481.187970300933;32658;32737.672623274415;33032;34939.126521837155;35361.1159721009;35416;35849.64150358463;35906;28747.71252287534;29370.41259174762;31363.84318078395;31424.214394639403;31904.521432178073;24463;24489.51020979535;24501.38746531351;24516.87741561281;24978.37554061163 11:15:54 INFO - PROCESS | 1330 | |2;jquery.html;365.2475899646728;366.20898858465705;371.22969837587016;372.4692313453329;372.6273726273726;13440.52958146465;13442.596722098353;15871.365145394186;17106.65786684267;18037.819621803796;15577.143257120853;15810.762838557432;15813.209339533036;15839.366425343002;16697.66604667909;5230.633855630107;5422.240886275925;5432.538234250093;5442.863928401782;5443.020256353855;4014.8996275093064;4128.442660240859;4128.442660240874;5334.279872217259;5740.368559458456;5519.558435325164;5845.298564172305;5894.204282421882;5902.586818922677;5906;5375.247465354853;5676.971615141919;5687.0900655895275;5689.260396148516;5714.371419143891;5208.8958220835375;5209.479052094798;5212.1139406300645;5213.296205012351;5220.895582088337;11770.470328835137;13535.526256581072;18997.81002189988;19445.513862153417;19455.513612159666;2120.639491286485;2156.9029393677165;2189.562087582474;2206.7131272934575;2340.2862127051244;7345.522541034816;8815.471071735716;8856.025837157971;9165.404248723878;11497.252678575866;1844.7509586205958;1849.8427633651156;1863.1150203653292;1898.7057006164066;1932.9033548322668;55804;57200.14199787048;58515.70742146305;58769;59061.40938590645;9929.950350248202;10098.949505252574;10176.084152426318;10188.490575471196;10288.588456461657;13429.865701342862;13560.321983900765;13565.59303220905;13566.660833479242;13576.185428874101;7633.084029916446;7672.73145439907;7683.193264707125;7705.267999540035;7706.922930770733;7304.160021597478;7343.412526997828;7395.112586489548;7413.777586672409;7418.109826820816;4025.7383270087353;4057.498725471535;4251.256030194703;4370.2570563004365;4478.865634030984;1650.8596769274745;1740.6779745747078;1818.4814032564993;1823.489422961573;1834.8348648621688;407.9959200407958;840.8360369727967;916.5600511754262;930.5393830054031;992.6228033347281;8416;9490.193333566724;9979.650712225037;10030.498475076218;10053.74328208974;431.24747315933894;434.9043210493686;438.0319493918476;448.17983090943494;450.16045075933147;5409.188621706776;5638.323401191883;5713.600047996683;5733.684647344353;5809.448102430262;524758;527859;542329;543955.1649318571;574654;71447.64276178586;72477;72479;73261;75270;439.9230134726474;456.77161419290354;460.9585137337656;473.68973322473835;481.506455882716;9433.952830235805;9563.187129094105;9776.951115244377;9901.950490247502;9907.554160062671;30138.397232055675;30428.69571304347;31809;32164;33000.33999320048;36697;37936.430953535164;42323;42492;46474.76762616165;6909.343612356818;6909.723611055702;6971.477139214478;7078.610676412847;7246.166690830411;10729.409882456539;10793.67618971432;10835.187360947803;11420.94289528547;11767.76464470723;9016.549172541478;9478.194353479756;9514.571844266886;9617.51912404363;9812.705618831447;9105.77235569116;9314.394564353295;9759.87991510567;9867.65463208813;9885.308028438229;3122.31309111995;5029.270755740324;5767.423257674199;9612.279079068958;9621.759456013655;7109.1824440187975;7112.50212485121;7142.285851395523;7236.855262894607;7261.056062711814;8234.629441675019;9103.90896091057;9643.662471813454;10033.44816035125;10167.796644067224 11:15:54 INFO - PROCESS | 1330 | |3;mootools.html;1250.2685928731692;1438.151490620534;1447.413797412048;1588.1582761136594;1770.4777090758225;7123.394511466525;7673.386129109672;7860.764177074697;7869.92130078699;7872.5670088145125;7654.311111999933;7751.961240193791;7796.415268854845;7800.921990780091;7824.843503129934;2074.2325339624285;2118.470382404399;2119.8940052997286;2362.114207172306;2393.8803059847023;2341.0401735288533;2410.6745589345387;2410.855348679076;2411.722651895037;2413.9517209655796;2320.3503019154664;2344.3553022918663;2376.239603326936;2376.4652953085506;2376.7266764322153;2315.0392587076426;2328.906843726249;2332.3352844439337;2354.705661792276;2359.1624973134462;2325.6627788970504;2330.7203135623663;2353.5292941411617;2360.893759780814;2362.716474023111;7823.452358334919;7868.685252589947;7869;7870.449068565203;7873.763787086396;4762.214234651278;4878.195097808893;4881.926771098437;4884.658073934826;4885.706857588556;3076.9846150769326;3115.3146307812244;3136.764742644311;3151.921201969946;3220.130564747505;1001.9048190421898;1019.6584144311664;1035.777307878802;1050.8791488978788;1053.6628278950739;11152.944235278852;11179.888201118047;11187.608433704781;11190.44047797615;11231.60689375876;4310;4347.826086956549;4375.2780791169735;4424.292113261863;4440.600345968878;9481.194098501566;9483.14651681352;9539.47532885698;9542.90457095434;9550.235981121632;4916.704997700078;4918.827841025547;4939.135651261086;4939.3084968104495;4943.629227807929;4447.2439685253585;4471.150481408522;4478.2386994211065;4480.350349199348;4481.574250446202;3514.3498452786316;3581.5702115746276;3715.64701353371;3720.720945929012;3809.3333666608232;1216.2094638484878;1216.683662247822;1218.0620921890272;1221.8533775946767;1226.172333674766;968.8934217236099;989.1690979577189;990.3760630802692;1092.9289596176222;1345.663584103974;7286.162091359455;7294.161171465244;7296.233895441009;7307.926920730724;7324;1181.8522684664417;1197.6646538969103;1205.7889869272842;1226.405193481161;1233.531258121926;5690.971545142331;5738;5777.162311464814;5835.533157347402;5839.883202336015;9278.628854845865;9529.571169297398;9644.18024467928;9655.9034409655;9656.903430965742;9257.722268331961;9521.381110227812;9546.331756776959;9607.279454040974;9656.71029869105;7377.26227377258;7459.328660420588;7487.66305516253;7546;7558.2441755825075;7150.64246787669;7188.388986936169;7280.235575264521;7296.489245752747;7324.743633972998;8448.915510844812;8674.826503469769;8676.349273804617;8800.47197168172;8802.339824513316;8699.13008699125;8738.868916966123;8813.559322034002;8975.865362019706;9070.954645226995;6845.794626161223;6901.723931042903;6907.171139463297;6943.826404339932;6953.548019378724;6885.827854303682;7048.647567621701;7228.168760592389;7335.083114610674;7403.074615673041;6690.665466726547;6772.255051944184;6832.145981752281;6898.379145876695;6957.582545047313;6597.670116494252;6758;6829.965850170717;6963.234044255027;7146.3568278855155;7110;7148.070750802362;7149.0706208192605;7155.642217889189;7158.749443769443;6093.6039157454625;6217.906731399123;6226.657533835682;6228.283747369111;6318.241810982711;6386.297507274103;6415.743370265137;6437.871242575028;6438.90341644885;6448.32292609288 11:15:54 INFO - PROCESS | 1330 | |4;prototype.html;335.6274535265855;336.48685754224806;347.588108091911;347.79132520487724;352.2760726706617;5824.737886795094;5914.053751399777;5917.082852157917;5934.465898069173;5965.1946987156725;5678;5748.080307150857;5749.080147176443;5784.132380142981;5787.594868359217;4556.749378784166;4560.680752347337;4562.133194693014;4564.771761411933;4576.336431217472;4358.128374325148;4448.466184057901;4475.932861007088;4554.2713165893465;4568.497465278817;4519.819207231707;4521.276595744682;4531.388262584542;4536.841210557631;4544.341070544769;4527.750973696462;4533.909321813579;4535.546445355438;4537.909241815161;4543.704659197141;4012.9197416051807;4019.4774679291504;4020.2361551305453;4025.3961905714377;4026.174634199982;5509.917351239735;5644.717764111778;5656.575756818255;5677.318721753375;5778.075507918755;5232.555232805216;5253.238280449352;5253.4221235664045;5259.132243179909;5262.473752624745;5953.791617293374;6287.9056814147825;6299.338569450188;6300.27546832111;6300.495960323209;4232.534421213664;4279.058607106432;4374.6500279977845;4380.561943805626;4384.868453946387;6450.709718062699;6454.774082907123;6499.5775274607;6503.837404064936;6530.6734663267125;4433.29067349229;4434.17967675981;4436.401085853433;4437.556244375537;4445.066536027471;4415;4477.619402350771;4497.347884556721;4501.504834468205;4533.863984080483;5212.218167274939;5218.112920803473;5220.895582088337;5224.660397074178;5226.268322434862;6299.6850157491945;6305.558610897193;6308.053791931247;6314.810555683337;6318.526110541728;1555.5411153709683;1558.322129873486;1559.1346802524708;1560.5240401677597;1561.3910574875808;1047.9790404191874;1064.090202876545;1067.6636859389268;1069.2996087562658;1087.798757229915;5885.440883116097;5890.410958904075;5896.616719913192;5905.350411454737;5919.082542205965;6446.387593178641;6459.418652321219;6464.676766161673;6488.318726533646;6494.1232933553365;5917.852053698606;5923.703814809242;5928.140419639129;5931.169636250928;5931.940680593225;3402.608699999532;3485.686288234071;3491.860325586999;3492.0571445709516;3494.947575786365;6776.69504872282;6818.2159051708695;6837.589744615339;6842.4183944364295;6845.657717114124;6648.700808463631;6649.335066493409;6650.833729156713;6651.833704157338;6655.46756259498;6603.504737144734;6794.388505034571;6810.455163586901;6821.317868213238;6821.556598821061;6303.432691057827;6432.067350234283;6480.319566445455;6520.510961677988;6533.836654083686;6231.470325022243;6325.335839736761;6357.713902874474;6357.841053973688;6483.930151524945;6791.185057793096;6816.727330906907;6816.863662726817;6827.317268273332;6831.59010459374;4358.891027724332;4458.952146245694;4501.852027732907;4504.504504504567;4510.977445112753;6499.155109835691;6502.60984340941;6511.641859697762;6513.772017979348;6516.804495865132;6321.304656487875;6325.620462772248;6330.556861019684;6338.65137417428;6338.746450141943;6197.194364732556;6305.864944309885;6307.936920630918;6313.1477250572425;6324.778632747832;6201.875962480815;6207.534434917309;6207.751689932352;6211.65835879013;6219.0982307566055;6340.397662222082;6340.968295158679;6350.841228969312;6354.887894618516;6355.237371515448;6024.969875150597;6189;6246.875062498815;6269.4984401246875;6273.153124328157 11:15:54 INFO - PROCESS | 1330 | |5;yui.html;831.1895901496042;834.7078522517123;835.1982097186702;840.9411341206117;845.3575282785085;12821.55124570639;12907.225566466019;12931.094823362368;12934.5472908448;12947;12491.267706119279;12594;12800.551980680679;13501.797473037888;13512.121712088707;796.0685997383047;809.7935026568217;811.3265989228955;811.5942028985507;812.3866480807012;656.9934300657004;675.2707076357522;801.519088546873;820.6225136437246;826.2811354121923;846.2299307630058;852.0840096895862;853.8164294676643;853.8505761491746;855.7432770168956;690.5166383531498;701.5895701014913;850.26452118917;854.0434713121313;854.8760429737684;619.3249358199585;625.4964753373532;625.9280182778994;626.2422468812742;628.6353914729445;13623.455061797516;13624.795628065587;13652.453901843914;13655.38550765218;13749.931250343785;13042.347882605833;13357.413329475163;13749.518766843112;13812.240326782023;13870.930645346809;10805.621803236849;10816.51325690338;11031.558737650485;11037.163613834187;11058.834117488244;3586.8923932282073;3628.51015112959;3634.309481198564;3654.8172591370326;3751.662350388478;47652.761736191445;47746.7612661938;47792.5220747795;47850.28224576634;47874.76062619664;10339.741506462247;10524.31591946521;10633.202509811796;10688;11080.833787493195;18685.719714204297;18748.250069997048;18761.90619046896;18776.248950041845;18777.906110469634;7164.605946672983;7183.209846916835;7203.747868824566;7385.7045718170675;7502.662380192795;3987.561368249548;3991.381335892941;4069.1658210066867;4085.9591404085577;4221.514525829508;2989.8056626319653;2996.565498002821;3010.262485690976;3010.5935698680837;3013.8794448222266;532.2229544864464;547.7124509632475;547.8712502561895;558.2993343354065;562.0585519255231;533.6344603946309;601.5638661970037;666.4768156996735;675.6486626953956;683.5864302097259;8506.74479765608;8799.736007919773;8891.911080889238;8990.910090899008;9205.401648892801;560.6075746977132;573.3549756523911;600.7116584039599;651.7914267434376;692.8648913461826;3655.7258205634685;3946.9013274668364;3973.3443981743267;3974.82113304902;3991.4212439196735;54556.45443545514;59501;59589;59769.40230597725;59782;51947;52187;52850.207246891325;53080;53133.734331328094;45979.77010114928;47037.52962470332;47367.52632473631;47571.76214118907;49073.5092649069;7945.1510333863735;7981.680732770857;8020.278174964281;8112.75661730149;8214.753557393287;33173;33911.660883391836;34367.4844877322;34508.41186910941;34630.653693462744;42319.57680423156;42441.15117697567;43849.34225986549;46037.309440359095;46308;10823.350598963772;10930.453477325942;11016;11079.16906232052;11331.206815522833;10945.83581246298;10969.286996345212;12470.812937806122;12678;13383.732325353632;10129.363070363255;10170.593176272867;10265;10882;10907.236493445384;10329.638462654071;10477.266591338534;10845.078168355778;10854.728631784268;10936.726581835517;10316.17470602365;10372.377657340583;11020.559177633126;11032.44837758125;11034.393108379116;9329.207017403325;9388.812223755624;9543.9045609543;9651.9034809651;10119.190464762949;8753.518556479201;9242.214411775074;9665.420074795535;9741.9025809741;9796.706098816761 11:15:54 INFO - PROCESS | 1330 | __end_tp_report 11:15:54 INFO - PROCESS | 1330 | __start_cc_report 11:15:54 INFO - PROCESS | 1330 | _x_x_mozilla_cycle_collect,724 11:15:54 INFO - PROCESS | 1330 | __end_cc_report 11:15:54 INFO - PROCESS | 1330 | __startTimestamp1453317354926__endTimestamp 11:15:54 INFO - PROCESS | 1330 | 11:15:54 INFO - PROCESS | 1330 | ------- Summary: start ------- 11:15:54 INFO - PROCESS | 1330 | Number of tests: 6 11:15:54 INFO - PROCESS | 1330 | 11:15:54 INFO - PROCESS | 1330 | [#0] dojo.html Cycles:165 Average:5211.96 Median:5422.81 stddev:672.33 (12.4%) stddev-sans-first:654.65 11:15:54 INFO - PROCESS | 1330 | Values: 3150.7 3154.8 3193.5 3200.6 3223.3 5163.5 5172.1 5173.6 5214.5 5289.8 5171.9 5255.3 5266.4 5290.5 5293.4 4801.7 4805.0 4839.2 4853.8 4911.1 349.9 4816.5 4843.9 4844.2 4847.1 4737.3 4760.3 4837.8 4839.9 4848.8 4819.2 4822.2 4832.7 4835.5 4858.1 4804.2 4805.1 4810.9 4815.9 4846.2 5040.5 5108.8 5134.9 5157.5 5171.9 5656.7 5708.0 5709.7 5717.9 5764.1 5722.4 5770.3 5778.1 5788.0 5788.2 5297.9 5311.8 5362.9 5376.8 5407.6 5644.5 5711.3 5733.1 5734.1 5767.8 5512.5 5514.6 5519.6 5526.8 5550.8 5555.9 5586.9 5609.2 5612.9 5685.8 5694.7 5706.4 5709.1 5712.8 5713.4 5632.9 5654.6 5658.1 5658.7 5658.8 4365.5 4443.7 4446.6 4450.6 4459.6 3955.5 4018.3 4028.6 4055.0 4056.2 5131.9 5251.4 5262.3 5300.9 5310.8 5571.5 5571.7 5574.7 5581.4 5582.9 5134.8 5135.8 5136.1 5141.9 5189.4 4751.4 4845.3 4878.8 4887.5 4936.3 5661.5 5712.7 5714.7 5718.5 5721.2 5515.9 5523.3 5525.5 5538.6 5574.1 5769.6 5773.9 5865.6 5901.9 5945.1 5509.6 5511.5 5512.2 5515.6 5524.8 5579.0 5585.7 5588.7 5593.0 5617.8 5476.9 5550.3 5577.4 5586.3 5623.2 5543.1 5579.1 5583.6 5584.7 5592.6 5418.3 5466.7 5492.8 5495.1 5545.4 5350.2 5421.8 5422.8 5434.2 5484.8 5391.5 5392.6 5415.7 5422.3 5425.2 11:15:54 INFO - PROCESS | 1330 | 11:15:54 INFO - PROCESS | 1330 | [#1] ext.html Cycles:180 Average:45246.88 Median:34863.72 stddev:77522.86 (222.4%) stddev-sans-first:77667.62 11:15:54 INFO - PROCESS | 1330 | Values: 527.9 535.5 537.9 572.0 594.2 27595.4 28076.4 35461.6 35817.3 35861.0 37830.0 38302.2 38411.8 38441.8 38494.0 8304.3 8492.3 8492.6 8497.6 8501.3 8357.5 8498.9 8516.7 8519.8 8522.7 8492.2 8560.8 8727.8 8793.0 8796.3 8640.3 8730.2 8734.7 8739.9 8741.5 8475.7 8607.9 8616.3 8622.0 8623.7 39146.4 39619.6 39751.2 39837.8 39864.2 3282.3 3306.8 3345.1 3668.3 3878.3 29608.6 29802.4 29911.3 31015.7 31076.3 3523.8 3579.5 3626.1 3691.3 3805.5 275153.0 276414.0 276550.0 277010.6 278066.0 50753.0 51383.0 55878.4 56560.4 57137.1 56888.4 57656.0 57897.7 57901.7 57961.7 15064.3 15071.0 15075.0 15240.9 15260.8 10900.0 11347.1 11935.3 12177.5 12191.6 18374.4 18474.3 18497.4 19106.9 19170.8 7294.2 7497.4 7568.4 7610.4 7647.8 928.9 963.5 1014.2 1043.0 1061.7 28284.9 28446.4 28616.9 28679.3 28711.0 1034.5 1054.0 1060.2 1150.0 1171.5 14731.3 14922.3 14956.9 14960.4 14961.0 313834.0 317210.0 319415.0 319741.0 319979.0 51928.7 52050.7 52087.5 52248.5 52255.5 1204.2 1249.4 1251.8 1254.7 1300.6 25476.5 25670.0 26469.2 27792.6 28273.3 38159.6 39139.0 39220.6 39414.0 39468.2 213262.0 216676.0 289714.0 294616.0 402307.0 30975.0 31115.8 31144.0 31461.0 31532.2 39751.8 40362.0 40525.0 40870.0 41179.0 34255.7 34629.3 34755.7 34788.3 35101.5 31708.7 32481.2 32658.0 32737.7 33032.0 34939.1 35361.1 35416.0 35849.6 35906.0 28747.7 29370.4 31363.8 31424.2 31904.5 24463.0 24489.5 24501.4 24516.9 24978.4 11:15:54 INFO - PROCESS | 1330 | 11:15:54 INFO - PROCESS | 1330 | [#2] jquery.html Cycles:180 Average:26850.41 Median:264994.32 stddev:88830.02 (33.5%) stddev-sans-first:89056.95 11:15:54 INFO - PROCESS | 1330 | Values: 365.2 366.2 371.2 372.5 372.6 13440.5 13442.6 15871.4 17106.7 18037.8 15577.1 15810.8 15813.2 15839.4 16697.7 5230.6 5422.2 5432.5 5442.9 5443.0 4014.9 4128.4 4128.4 5334.3 5740.4 5519.6 5845.3 5894.2 5902.6 5906.0 5375.2 5677.0 5687.1 5689.3 5714.4 5208.9 5209.5 5212.1 5213.3 5220.9 11770.5 13535.5 18997.8 19445.5 19455.5 2120.6 2156.9 2189.6 2206.7 2340.3 7345.5 8815.5 8856.0 9165.4 11497.3 1844.8 1849.8 1863.1 1898.7 1932.9 55804.0 57200.1 58515.7 58769.0 59061.4 9930.0 10098.9 10176.1 10188.5 10288.6 13429.9 13560.3 13565.6 13566.7 13576.2 7633.1 7672.7 7683.2 7705.3 7706.9 7304.2 7343.4 7395.1 7413.8 7418.1 4025.7 4057.5 4251.3 4370.3 4478.9 1650.9 1740.7 1818.5 1823.5 1834.8 408.0 840.8 916.6 930.5 992.6 8416.0 9490.2 9979.7 10030.5 10053.7 431.2 434.9 438.0 448.2 450.2 5409.2 5638.3 5713.6 5733.7 5809.4 524758.0 527859.0 542329.0 543955.2 574654.0 71447.6 72477.0 72479.0 73261.0 75270.0 439.9 456.8 461.0 473.7 481.5 9434.0 9563.2 9777.0 9902.0 9907.6 30138.4 30428.7 31809.0 32164.0 33000.3 36697.0 37936.4 42323.0 42492.0 46474.8 6909.3 6909.7 6971.5 7078.6 7246.2 10729.4 10793.7 10835.2 11420.9 11767.8 9016.5 9478.2 9514.6 9617.5 9812.7 9105.8 9314.4 9759.9 9867.7 9885.3 3122.3 5029.3 5767.4 9612.3 9621.8 7109.2 7112.5 7142.3 7236.9 7261.1 8234.6 9103.9 9643.7 10033.4 10167.8 11:15:54 INFO - PROCESS | 1330 | 11:15:54 INFO - PROCESS | 1330 | [#3] mootools.html Cycles:180 Average:5531.85 Median:6273.26 stddev:2873.27 (45.8%) stddev-sans-first:2863.30 11:15:54 INFO - PROCESS | 1330 | Values: 1250.3 1438.2 1447.4 1588.2 1770.5 7123.4 7673.4 7860.8 7869.9 7872.6 7654.3 7752.0 7796.4 7800.9 7824.8 2074.2 2118.5 2119.9 2362.1 2393.9 2341.0 2410.7 2410.9 2411.7 2414.0 2320.4 2344.4 2376.2 2376.5 2376.7 2315.0 2328.9 2332.3 2354.7 2359.2 2325.7 2330.7 2353.5 2360.9 2362.7 7823.5 7868.7 7869.0 7870.4 7873.8 4762.2 4878.2 4881.9 4884.7 4885.7 3077.0 3115.3 3136.8 3151.9 3220.1 1001.9 1019.7 1035.8 1050.9 1053.7 11152.9 11179.9 11187.6 11190.4 11231.6 4310.0 4347.8 4375.3 4424.3 4440.6 9481.2 9483.1 9539.5 9542.9 9550.2 4916.7 4918.8 4939.1 4939.3 4943.6 4447.2 4471.2 4478.2 4480.4 4481.6 3514.3 3581.6 3715.6 3720.7 3809.3 1216.2 1216.7 1218.1 1221.9 1226.2 968.9 989.2 990.4 1092.9 1345.7 7286.2 7294.2 7296.2 7307.9 7324.0 1181.9 1197.7 1205.8 1226.4 1233.5 5691.0 5738.0 5777.2 5835.5 5839.9 9278.6 9529.6 9644.2 9655.9 9656.9 9257.7 9521.4 9546.3 9607.3 9656.7 7377.3 7459.3 7487.7 7546.0 7558.2 7150.6 7188.4 7280.2 7296.5 7324.7 8448.9 8674.8 8676.3 8800.5 8802.3 8699.1 8738.9 8813.6 8975.9 9071.0 6845.8 6901.7 6907.2 6943.8 6953.5 6885.8 7048.6 7228.2 7335.1 7403.1 6690.7 6772.3 6832.1 6898.4 6957.6 6597.7 6758.0 6830.0 6963.2 7146.4 7110.0 7148.1 7149.1 7155.6 7158.7 6093.6 6217.9 6226.7 6228.3 6318.2 6386.3 6415.7 6437.9 6438.9 6448.3 11:15:54 INFO - PROCESS | 1330 | 11:15:54 INFO - PROCESS | 1330 | [#4] prototype.html Cycles:180 Average:5254.46 Median:5915.57 stddev:1588.13 (26.8%) stddev-sans-first:1549.08 11:15:54 INFO - PROCESS | 1330 | Values: 335.6 336.5 347.6 347.8 352.3 5824.7 5914.1 5917.1 5934.5 5965.2 5678.0 5748.1 5749.1 5784.1 5787.6 4556.7 4560.7 4562.1 4564.8 4576.3 4358.1 4448.5 4475.9 4554.3 4568.5 4519.8 4521.3 4531.4 4536.8 4544.3 4527.8 4533.9 4535.5 4537.9 4543.7 4012.9 4019.5 4020.2 4025.4 4026.2 5509.9 5644.7 5656.6 5677.3 5778.1 5232.6 5253.2 5253.4 5259.1 5262.5 5953.8 6287.9 6299.3 6300.3 6300.5 4232.5 4279.1 4374.7 4380.6 4384.9 6450.7 6454.8 6499.6 6503.8 6530.7 4433.3 4434.2 4436.4 4437.6 4445.1 4415.0 4477.6 4497.3 4501.5 4533.9 5212.2 5218.1 5220.9 5224.7 5226.3 6299.7 6305.6 6308.1 6314.8 6318.5 1555.5 1558.3 1559.1 1560.5 1561.4 1048.0 1064.1 1067.7 1069.3 1087.8 5885.4 5890.4 5896.6 5905.4 5919.1 6446.4 6459.4 6464.7 6488.3 6494.1 5917.9 5923.7 5928.1 5931.2 5931.9 3402.6 3485.7 3491.9 3492.1 3494.9 6776.7 6818.2 6837.6 6842.4 6845.7 6648.7 6649.3 6650.8 6651.8 6655.5 6603.5 6794.4 6810.5 6821.3 6821.6 6303.4 6432.1 6480.3 6520.5 6533.8 6231.5 6325.3 6357.7 6357.8 6483.9 6791.2 6816.7 6816.9 6827.3 6831.6 4358.9 4459.0 4501.9 4504.5 4511.0 6499.2 6502.6 6511.6 6513.8 6516.8 6321.3 6325.6 6330.6 6338.7 6338.7 6197.2 6305.9 6307.9 6313.1 6324.8 6201.9 6207.5 6207.8 6211.7 6219.1 6340.4 6341.0 6350.8 6354.9 6355.2 6025.0 6189.0 6246.9 6269.5 6273.2 11:15:54 INFO - PROCESS | 1330 | 11:15:54 INFO - PROCESS | 1330 | [#5] yui.html Cycles:180 Average:13823.83 Median:46172.65 stddev:16137.96 (35.0%) stddev-sans-first:16153.73 11:15:54 INFO - PROCESS | 1330 | Values: 831.2 834.7 835.2 840.9 845.4 12821.6 12907.2 12931.1 12934.5 12947.0 12491.3 12594.0 12800.6 13501.8 13512.1 796.1 809.8 811.3 811.6 812.4 657.0 675.3 801.5 820.6 826.3 846.2 852.1 853.8 853.9 855.7 690.5 701.6 850.3 854.0 854.9 619.3 625.5 625.9 626.2 628.6 13623.5 13624.8 13652.5 13655.4 13749.9 13042.3 13357.4 13749.5 13812.2 13870.9 10805.6 10816.5 11031.6 11037.2 11058.8 3586.9 3628.5 3634.3 3654.8 3751.7 47652.8 47746.8 47792.5 47850.3 47874.8 10339.7 10524.3 10633.2 10688.0 11080.8 18685.7 18748.3 18761.9 18776.2 18777.9 7164.6 7183.2 7203.7 7385.7 7502.7 3987.6 3991.4 4069.2 4086.0 4221.5 2989.8 2996.6 3010.3 3010.6 3013.9 532.2 547.7 547.9 558.3 562.1 533.6 601.6 666.5 675.6 683.6 8506.7 8799.7 8891.9 8990.9 9205.4 560.6 573.4 600.7 651.8 692.9 3655.7 3946.9 3973.3 3974.8 3991.4 54556.5 59501.0 59589.0 59769.4 59782.0 51947.0 52187.0 52850.2 53080.0 53133.7 45979.8 47037.5 47367.5 47571.8 49073.5 7945.2 7981.7 8020.3 8112.8 8214.8 33173.0 33911.7 34367.5 34508.4 34630.7 42319.6 42441.2 43849.3 46037.3 46308.0 10823.4 10930.5 11016.0 11079.2 11331.2 10945.8 10969.3 12470.8 12678.0 13383.7 10129.4 10170.6 10265.0 10882.0 10907.2 10329.6 10477.3 10845.1 10854.7 10936.7 10316.2 10372.4 11020.6 11032.4 11034.4 9329.2 9388.8 9543.9 9651.9 10119.2 8753.5 9242.2 9665.4 9741.9 9796.7 11:15:54 INFO - PROCESS | 1330 | -------- Summary: end -------- 11:15:54 INFO - PROCESS | 1330 | 11:15:55 INFO - TEST-INFO | 1330: exit 0 11:15:55 INFO - TEST-OK | dromaeo_css | took 1112260ms 11:15:55 INFO - TEST-START | kraken 11:15:55 INFO - operating with platform_type : linux_ 11:15:55 INFO - Initialising browser for kraken test... 11:15:55 INFO - TEST-INFO | started process 1533 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaKKrnv/profile http://localhost:48831/getInfo.html) 11:15:59 INFO - PROCESS | 1533 | __metrics Screen width/height:1600/1200 11:15:59 INFO - PROCESS | 1533 | colorDepth:24 11:15:59 INFO - PROCESS | 1533 | Browser inner width/height: 1024/697 11:15:59 INFO - PROCESS | 1533 | __metrics 11:15:59 INFO - PROCESS | 1533 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:15:59 INFO - PROCESS | 1533 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:16:01 INFO - TEST-INFO | 1533: exit 0 11:16:01 INFO - Browser initialized. 11:16:01 INFO - Running cycle 1/1 for kraken test... 11:16:01 INFO - TEST-INFO | started process 1613 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaKKrnv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:12 INFO - PROCESS | 1613 | RSS: Main: 148893696 11:16:12 INFO - PROCESS | 1613 | 11:16:15 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48831/tests/kraken/driver.html?testName=audio-beat-detection) 11:16:15 INFO - PROCESS | 1613 | RSS: Main: 185729024 11:16:15 INFO - PROCESS | 1613 | 11:16:18 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48831/tests/kraken/driver.html?testName=audio-dft) 11:16:19 INFO - PROCESS | 1613 | RSS: Main: 174489600 11:16:19 INFO - PROCESS | 1613 | 11:16:22 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48831/tests/kraken/driver.html?testName=audio-fft) 11:16:22 INFO - PROCESS | 1613 | RSS: Main: 161775616 11:16:22 INFO - PROCESS | 1613 | 11:16:24 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48831/tests/kraken/driver.html?testName=audio-oscillator) 11:16:25 INFO - PROCESS | 1613 | RSS: Main: 164347904 11:16:25 INFO - PROCESS | 1613 | 11:16:27 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48831/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:16:28 INFO - PROCESS | 1613 | RSS: Main: 165724160 11:16:28 INFO - PROCESS | 1613 | 11:16:30 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48831/tests/kraken/driver.html?testName=imaging-darkroom) 11:16:31 INFO - PROCESS | 1613 | RSS: Main: 166375424 11:16:31 INFO - PROCESS | 1613 | 11:16:34 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48831/tests/kraken/driver.html?testName=imaging-desaturate) 11:16:35 INFO - PROCESS | 1613 | RSS: Main: 166150144 11:16:35 INFO - PROCESS | 1613 | 11:16:38 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48831/tests/kraken/driver.html?testName=json-parse-financial) 11:16:38 INFO - PROCESS | 1613 | RSS: Main: 166531072 11:16:38 INFO - PROCESS | 1613 | 11:16:40 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48831/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:16:40 INFO - PROCESS | 1613 | RSS: Main: 178991104 11:16:40 INFO - PROCESS | 1613 | 11:16:42 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48831/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:16:43 INFO - PROCESS | 1613 | RSS: Main: 177455104 11:16:43 INFO - PROCESS | 1613 | 11:16:45 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48831/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:16:45 INFO - PROCESS | 1613 | RSS: Main: 184537088 11:16:45 INFO - PROCESS | 1613 | 11:16:48 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:16:48 INFO - PROCESS | 1613 | RSS: Main: 192331776 11:16:48 INFO - PROCESS | 1613 | 11:16:51 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:16:51 INFO - PROCESS | 1613 | RSS: Main: 190894080 11:16:52 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | Cycle 1(1): loaded http://localhost:48831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48831/tests/kraken/driver.html?testName=ai-astar) 11:16:53 INFO - PROCESS | 1613 | RSS: Main: 249430016 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | __start_tp_report 11:16:53 INFO - PROCESS | 1613 | _x_x_mozilla_page_load 11:16:53 INFO - PROCESS | 1613 | _x_x_mozilla_page_load_details 11:16:53 INFO - PROCESS | 1613 | |i|pagename|runs| 11:16:53 INFO - PROCESS | 1613 | |0;ai-astar;112;111;105;111;109;110;109;111;105;109 11:16:53 INFO - PROCESS | 1613 | |1;audio-beat-detection;157;127;150;160;129;157;163;143;172;132 11:16:53 INFO - PROCESS | 1613 | |2;audio-dft;161;162;162;161;161;162;160;162;162;162 11:16:53 INFO - PROCESS | 1613 | |3;audio-fft;76;73;94;100;72;73;72;109;94;74 11:16:53 INFO - PROCESS | 1613 | |4;audio-oscillator;104;96;147;96;96;95;143;96;97;135 11:16:53 INFO - PROCESS | 1613 | |5;imaging-gaussian-blur;109;109;110;109;109;109;109;109;109;110 11:16:53 INFO - PROCESS | 1613 | |6;imaging-darkroom;145;146;146;147;146;146;145;147;146;146 11:16:53 INFO - PROCESS | 1613 | |7;imaging-desaturate;96;97;96;96;96;96;96;96;95;95 11:16:53 INFO - PROCESS | 1613 | |8;json-parse-financial;57;56;57;56;56;58;57;56;56;55 11:16:53 INFO - PROCESS | 1613 | |9;json-stringify-tinderbox;68;68;69;69;69;69;69;68;68;68 11:16:53 INFO - PROCESS | 1613 | |10;stanford-crypto-aes;88;81;82;82;82;83;81;82;85;83 11:16:53 INFO - PROCESS | 1613 | |11;stanford-crypto-ccm;113;116;117;118;126;114;118;121;118;117 11:16:53 INFO - PROCESS | 1613 | |12;stanford-crypto-pbkdf2;143;132;142;139;142;132;143;143;140;141 11:16:53 INFO - PROCESS | 1613 | |13;stanford-crypto-sha256-iterative;67;67;68;67;68;66;65;67;66;67 11:16:53 INFO - PROCESS | 1613 | __end_tp_report 11:16:53 INFO - PROCESS | 1613 | __start_cc_report 11:16:53 INFO - PROCESS | 1613 | _x_x_mozilla_cycle_collect,964 11:16:53 INFO - PROCESS | 1613 | __end_cc_report 11:16:53 INFO - PROCESS | 1613 | __startTimestamp1453317413918__endTimestamp 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | ------- Summary: start ------- 11:16:53 INFO - PROCESS | 1613 | Number of tests: 14 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:2.44 (2.2%) stddev-sans-first:2.37 11:16:53 INFO - PROCESS | 1613 | Values: 112.0 111.0 105.0 111.0 109.0 110.0 109.0 111.0 105.0 109.0 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:157.00 stddev:15.58 (9.9%) stddev-sans-first:16.25 11:16:53 INFO - PROCESS | 1613 | Values: 157.0 127.0 150.0 160.0 129.0 157.0 163.0 143.0 172.0 132.0 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 11:16:53 INFO - PROCESS | 1613 | Values: 161.0 162.0 162.0 161.0 161.0 162.0 160.0 162.0 162.0 162.0 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#3] audio-fft Cycles:10 Average:83.70 Median:73.50 stddev:14.04 (19.1%) stddev-sans-first:14.61 11:16:53 INFO - PROCESS | 1613 | Values: 76.0 73.0 94.0 100.0 72.0 73.0 72.0 109.0 94.0 74.0 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:96.00 stddev:21.84 (22.8%) stddev-sans-first:23.04 11:16:53 INFO - PROCESS | 1613 | Values: 104.0 96.0 147.0 96.0 96.0 95.0 143.0 96.0 97.0 135.0 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:16:53 INFO - PROCESS | 1613 | Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 11:16:53 INFO - PROCESS | 1613 | Values: 145.0 146.0 146.0 147.0 146.0 146.0 145.0 147.0 146.0 146.0 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 11:16:53 INFO - PROCESS | 1613 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:0.84 (1.5%) stddev-sans-first:0.87 11:16:53 INFO - PROCESS | 1613 | Values: 57.0 56.0 57.0 56.0 56.0 58.0 57.0 56.0 56.0 55.0 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 11:16:53 INFO - PROCESS | 1613 | Values: 68.0 68.0 69.0 69.0 69.0 69.0 69.0 68.0 68.0 68.0 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.50 stddev:2.13 (2.6%) stddev-sans-first:1.22 11:16:53 INFO - PROCESS | 1613 | Values: 88.0 81.0 82.0 82.0 82.0 83.0 81.0 82.0 85.0 83.0 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:118.00 stddev:3.65 (3.1%) stddev-sans-first:3.43 11:16:53 INFO - PROCESS | 1613 | Values: 113.0 116.0 117.0 118.0 126.0 114.0 118.0 121.0 118.0 117.0 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.70 Median:142.00 stddev:4.27 (3.0%) stddev-sans-first:4.36 11:16:53 INFO - PROCESS | 1613 | Values: 143.0 132.0 142.0 139.0 142.0 132.0 143.0 143.0 140.0 141.0 11:16:53 INFO - PROCESS | 1613 | 11:16:53 INFO - PROCESS | 1613 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 11:16:53 INFO - PROCESS | 1613 | Values: 67.0 67.0 68.0 67.0 68.0 66.0 65.0 67.0 66.0 67.0 11:16:53 INFO - PROCESS | 1613 | -------- Summary: end -------- 11:16:53 INFO - PROCESS | 1613 | 11:16:54 INFO - TEST-INFO | 1613: exit 0 11:16:54 INFO - TEST-OK | kraken | took 59216ms 11:16:54 INFO - TEST-START | v8_7 11:16:54 INFO - operating with platform_type : linux_ 11:16:54 INFO - Initialising browser for v8_7 test... 11:16:54 INFO - TEST-INFO | started process 1859 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5ok1sI/profile http://localhost:48831/getInfo.html) 11:16:58 INFO - PROCESS | 1859 | __metrics Screen width/height:1600/1200 11:16:58 INFO - PROCESS | 1859 | colorDepth:24 11:16:58 INFO - PROCESS | 1859 | Browser inner width/height: 1024/697 11:16:58 INFO - PROCESS | 1859 | __metrics 11:16:59 INFO - PROCESS | 1859 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:16:59 INFO - PROCESS | 1859 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:17:00 INFO - TEST-INFO | 1859: exit 0 11:17:00 INFO - Browser initialized. 11:17:00 INFO - Running cycle 1/1 for v8_7 test... 11:17:00 INFO - TEST-INFO | started process 1942 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5ok1sI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:12 INFO - PROCESS | 1942 | RSS: Main: 149413888 11:17:12 INFO - PROCESS | 1942 | 11:17:34 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:48831/tests/v8_7/run.html (next: http://localhost:48831/tests/v8_7/run.html) 11:17:34 INFO - PROCESS | 1942 | RSS: Main: 544923648 11:17:34 INFO - PROCESS | 1942 | 11:17:34 INFO - PROCESS | 1942 | __start_tp_report 11:17:34 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 11:17:34 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 11:17:34 INFO - PROCESS | 1942 | |i|pagename|runs| 11:17:34 INFO - PROCESS | 1942 | |0;Richards;168.01075268817203 11:17:34 INFO - PROCESS | 1942 | |1;DeltaBlue;187.75816748028538 11:17:34 INFO - PROCESS | 1942 | |2;Encrypt;282.326369282891 11:17:34 INFO - PROCESS | 1942 | |3;Decrypt;5240.837696335078 11:17:34 INFO - PROCESS | 1942 | |4;RayTrace;2089.7703549060543 11:17:34 INFO - PROCESS | 1942 | |5;Earley;772.2007722007722 11:17:34 INFO - PROCESS | 1942 | |6;Boyer;12512.5 11:17:34 INFO - PROCESS | 1942 | |7;RegExp;42187.5 11:17:34 INFO - PROCESS | 1942 | |8;Splay;562.429696287964 11:17:34 INFO - PROCESS | 1942 | |9;NavierStokes;4830.917874396136 11:17:34 INFO - PROCESS | 1942 | __end_tp_report 11:17:34 INFO - PROCESS | 1942 | __startTimestamp1453317454929__endTimestamp 11:17:34 INFO - PROCESS | 1942 | 11:17:34 INFO - PROCESS | 1942 | ------- Summary: start ------- 11:17:34 INFO - PROCESS | 1942 | Number of tests: 10 11:17:34 INFO - PROCESS | 1942 | 11:17:34 INFO - PROCESS | 1942 | [#0] Richards Cycles:1 Average:168.01 Median:168.01 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 1942 | Values: 168.0 11:17:34 INFO - PROCESS | 1942 | 11:17:34 INFO - PROCESS | 1942 | [#1] DeltaBlue Cycles:1 Average:187.76 Median:187.76 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 1942 | Values: 187.8 11:17:34 INFO - PROCESS | 1942 | 11:17:34 INFO - PROCESS | 1942 | [#2] Encrypt Cycles:1 Average:282.33 Median:282.33 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 1942 | Values: 282.3 11:17:34 INFO - PROCESS | 1942 | 11:17:34 INFO - PROCESS | 1942 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 1942 | Values: 5240.8 11:17:34 INFO - PROCESS | 1942 | 11:17:34 INFO - PROCESS | 1942 | [#4] RayTrace Cycles:1 Average:2089.77 Median:2089.77 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 1942 | Values: 2089.8 11:17:34 INFO - PROCESS | 1942 | 11:17:34 INFO - PROCESS | 1942 | [#5] Earley Cycles:1 Average:772.20 Median:772.20 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 1942 | Values: 772.2 11:17:34 INFO - PROCESS | 1942 | 11:17:34 INFO - PROCESS | 1942 | [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 1942 | Values: 12512.5 11:17:34 INFO - PROCESS | 1942 | 11:17:34 INFO - PROCESS | 1942 | [#7] RegExp Cycles:1 Average:42187.50 Median:42187.50 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 1942 | Values: 42187.5 11:17:34 INFO - PROCESS | 1942 | 11:17:34 INFO - PROCESS | 1942 | [#8] Splay Cycles:1 Average:562.43 Median:562.43 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 1942 | Values: 562.4 11:17:34 INFO - PROCESS | 1942 | 11:17:34 INFO - PROCESS | 1942 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 1942 | Values: 4830.9 11:17:34 INFO - PROCESS | 1942 | -------- Summary: end -------- 11:17:34 INFO - PROCESS | 1942 | 11:17:35 INFO - TEST-INFO | 1942: exit 0 11:17:35 INFO - TEST-OK | v8_7 | took 41005ms 11:17:35 INFO - SUITE-END | took 1212s 11:17:36 INFO - Completed test suite (00:20:12) 11:17:36 INFO - Working with test: dromaeo_css 11:17:36 INFO - Generating results file: dromaeo_css 11:17:36 INFO - Working with test: kraken 11:17:36 INFO - Generating results file: kraken 11:17:36 INFO - javascript benchmark 11:17:36 INFO - Working with test: v8_7 11:17:36 INFO - Generating results file: v8_7 11:17:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:17:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:17:36 INFO - process_Request line: dromaeo_css 6705.62 graph.html#tests=[[72,64,35]] 11:17:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:17:36 INFO - process_Request line: kraken 1497.10 graph.html#tests=[[232,64,35]] 11:17:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:17:36 INFO - process_Request line: v8_7 18910.12 graph.html#tests=[[230,64,35]] 11:17:36 INFO - RETURN: dromaeo_css: 6705.62 11:17:36 INFO - RETURN: kraken: 1497.10 11:17:36 INFO - RETURN: v8_7: 18910.12 11:17:36 INFO - javascript benchmark 11:17:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3150.6691797361264, 3154.82648454335, 3193.4890417533184, 3200.631927328358, 3223.2586505103827, 5163.483651634835, 5172.094883395405, 5173.637845350822, 5214.504622060903, 5289.841304760854, 5171.922421163686, 5255.316808814849, 5266.394364648067, 5290.470952904708, 5293.391260005101, 4801.687890287138, 4804.951950480503, 4839.225723884179, 4853.8058477661025, 4911.066897289522, 349.94897982118204, 4816.542428469307, 4843.878903027417, 4844.224924012159, 4847.054824309261, 4737.313089602006, 4760.262159365304, 4837.758112094381, 4839.927401088987, 4848.781804818792, 4819.204831202847, 4822.156122678517, 4832.661713680044, 4835.516448355172, 4858.052679727454, 4804.183288840871, 4805.063012712522, 4810.903781924377, 4815.927761083586, 4846.224604063368, 5040.49595040493, 5108.770105345268, 5134.897302053975, 5157.535821776059, 5171.922421163686, 5656.717164141776, 5707.971460142714, 5709.74306156224, 5717.942820571824, 5764.106563482625, 5722.37053924068, 5770.307563092414, 5778.075507918755, 5787.971060144714, 5788.18965344852, 5297.867553311159, 5311.814086506954, 5362.927414517073, 5376.758045887945, 5407.594430417735, 5644.491995720405, 5711.286089238845, 5733.082706766897, 5734.139879018181, 5767.826965191051, 5512.503874651301, 5514.6139770216505, 5519.613627046148, 5526.811735476892, 5550.750216240198, 5555.944440555623, 5586.86032849182, 5609.214709940612, 5612.887742245132, 5685.800996965169, 5694.715264236772, 5706.400827913092, 5709.0865461525955, 5712.800051998243, 5713.4000929902595, 5632.943670563324, 5654.575906807006, 5658.094704847204, 5658.660480371191, 5658.773649054074, 4365.497967733688, 4443.666724995638, 4446.555344465528, 4450.621697155713, 4459.598636122764, 3955.5055618047745, 4018.276710192135, 4028.597140285948, 4055.0, 4056.229316429928, 5131.897362052738, 5251.396089449686, 5262.342207224097, 5300.867478313073, 5310.840674779763, 5571.470710282517, 5571.693556854412, 5574.749136288877, 5581.441855814386, 5582.888342233133, 5134.820281290137, 5135.794568217229, 5136.126858434075, 5141.871453213699, 5189.40321862983, 4751.358566593535, 4845.345878306454, 4878.804847806048, 4887.462379138292, 4936.333594964705, 5661.518770904519, 5712.742926568314, 5714.742836572281, 5718.542516598662, 5721.22763426932, 5515.862103447446, 5523.28197334344, 5525.530329922001, 5538.556915446674, 5574.052411090043, 5769.567282453749, 5773.942260577341, 5865.560082993878, 5901.852453688693, 5945.078512830518, 5509.559235261249, 5511.5315198207, 5512.200730894078, 5515.558755299647, 5524.8342549723575, 5578.972105139448, 5585.748641311069, 5588.720563971867, 5593.0491816390495, 5617.8033768817895, 5476.945230547643, 5550.333959924674, 5577.386487486455, 5586.273784408001, 5623.212750215055, 5543.085390910454, 5579.107342825128, 5583.55331573465, 5584.720763961867, 5592.5525957922455, 5418.268533748052, 5466.671999680032, 5492.80775172867, 5495.148252020943, 5545.445455454584, 5350.197470379474, 5421.83734487966, 5422.810201642924, 5434.212039254365, 5484.780608775604, 5391.487808658171, 5392.622516423813, 5415.675059496442, 5422.295101636762, 5425.159100339453], "unit": "score", "name": "dojo.html", "value": 5172.567964334203}, {"lowerIsBetter": false, "replicates": [527.9260903473514, 535.4752342704147, 537.9004884096441, 571.9542436605072, 594.2215697436358, 27595.448091038168, 28076.438471230587, 35461.64538354619, 35817.2836543269, 35861.0, 37830.0, 38302.23395532088, 38411.80794096032, 38441.80779096101, 38494.0, 8304.294134998532, 8492.278156356717, 8492.575371231414, 8497.61760720769, 8501.277391421705, 8357.540335281557, 8498.915010849905, 8516.701915432961, 8519.787005324855, 8522.659093636246, 8492.15078492152, 8560.828783424327, 8727.825443491127, 8793.0, 8796.25231855293, 8640.265577425926, 8730.214280714767, 8734.650613975466, 8739.868901966476, 8741.4755114693, 8475.703350382708, 8607.870881936777, 8616.267617252479, 8622.0, 8623.655053797904, 39146.412803807965, 39619.60380396188, 39751.20497590032, 39837.80081099576, 39864.2162940449, 3282.261491164493, 3306.801591904469, 3345.080102971678, 3668.284684486526, 3878.2825177342283, 29608.55587166194, 29802.403951921056, 29911.252218694706, 31015.689843101507, 31076.270847498447, 3523.7533372663925, 3579.49887015818, 3626.12972886508, 3691.261747650454, 3805.46723458716, 275153.0, 276414.0, 276550.0, 277010.614946926, 278066.0, 50753.0, 51383.0, 55878.44121558814, 56560.43439565552, 57137.14294285589, 56888.43111568914, 57656.0, 57897.710511448015, 57901.71049144727, 57961.710191449616, 15064.322105505278, 15071.0, 15075.0, 15240.923795380952, 15260.771088433683, 10900.0, 11347.092232621371, 11935.283882967049, 12177.452014659362, 12191.634250972485, 18374.35689750852, 18474.261029558667, 18497.352592659194, 19106.94288913767, 19170.808291916903, 7294.161171465349, 7497.437692173109, 7568.394528437711, 7610.353119984753, 7647.808804779814, 928.8978212396631, 963.4508330251689, 1014.1633152649094, 1043.0, 1061.6549621373085, 28284.90871643124, 28446.404712590764, 28616.85691571529, 28679.283017924718, 28711.0, 1034.5137785240925, 1054.0144964458257, 1060.204846365226, 1149.9540018399337, 1171.5313874450117, 14731.262758094024, 14922.272547952467, 14956.92521537407, 14960.40158393652, 14961.0, 313834.0, 317210.0, 319415.0, 319741.0, 319979.0, 51928.74035629873, 52050.739746301784, 52087.47912520902, 52248.477515225124, 52255.477445225064, 1204.241327963395, 1249.4439974211389, 1251.8497780266425, 1254.6737848159362, 1300.635821969831, 25476.49047019012, 25670.0, 26469.22720962542, 27792.583111253753, 28273.293167670974, 38159.61840381672, 39139.0, 39220.60779392169, 39414.0, 39468.21063578655, 213262.0, 216676.0, 289714.0, 294616.0, 402307.0, 30975.0, 31115.84442077775, 31144.0, 31461.0, 31532.211694707818, 39751.80124099361, 40362.0, 40525.0, 40870.0, 41179.0, 34255.65744342525, 34629.30741385208, 34755.652443476254, 34788.30423391467, 35101.47347789734, 31708.682913170574, 32481.187970300933, 32658.0, 32737.672623274415, 33032.0, 34939.126521837155, 35361.1159721009, 35416.0, 35849.64150358463, 35906.0, 28747.71252287534, 29370.41259174762, 31363.84318078395, 31424.214394639403, 31904.521432178073, 24463.0, 24489.51020979535, 24501.38746531351, 24516.87741561281, 24978.37554061163], "unit": "score", "name": "ext.html", "value": 17860.595127073466}, {"lowerIsBetter": false, "replicates": [365.2475899646728, 366.20898858465705, 371.22969837587016, 372.4692313453329, 372.6273726273726, 13440.52958146465, 13442.596722098353, 15871.365145394186, 17106.65786684267, 18037.819621803796, 15577.143257120853, 15810.762838557432, 15813.209339533036, 15839.366425343002, 16697.66604667909, 5230.633855630107, 5422.240886275925, 5432.538234250093, 5442.863928401782, 5443.020256353855, 4014.8996275093064, 4128.442660240859, 4128.442660240874, 5334.279872217259, 5740.368559458456, 5519.558435325164, 5845.298564172305, 5894.204282421882, 5902.586818922677, 5906.0, 5375.247465354853, 5676.971615141919, 5687.0900655895275, 5689.260396148516, 5714.371419143891, 5208.8958220835375, 5209.479052094798, 5212.1139406300645, 5213.296205012351, 5220.895582088337, 11770.470328835137, 13535.526256581072, 18997.81002189988, 19445.513862153417, 19455.513612159666, 2120.639491286485, 2156.9029393677165, 2189.562087582474, 2206.7131272934575, 2340.2862127051244, 7345.522541034816, 8815.471071735716, 8856.025837157971, 9165.404248723878, 11497.252678575866, 1844.7509586205958, 1849.8427633651156, 1863.1150203653292, 1898.7057006164066, 1932.9033548322668, 55804.0, 57200.14199787048, 58515.70742146305, 58769.0, 59061.40938590645, 9929.950350248202, 10098.949505252574, 10176.084152426318, 10188.490575471196, 10288.588456461657, 13429.865701342862, 13560.321983900765, 13565.59303220905, 13566.660833479242, 13576.185428874101, 7633.084029916446, 7672.73145439907, 7683.193264707125, 7705.267999540035, 7706.922930770733, 7304.160021597478, 7343.412526997828, 7395.112586489548, 7413.777586672409, 7418.109826820816, 4025.7383270087353, 4057.498725471535, 4251.256030194703, 4370.2570563004365, 4478.865634030984, 1650.8596769274745, 1740.6779745747078, 1818.4814032564993, 1823.489422961573, 1834.8348648621688, 407.9959200407958, 840.8360369727967, 916.5600511754262, 930.5393830054031, 992.6228033347281, 8416.0, 9490.193333566724, 9979.650712225037, 10030.498475076218, 10053.74328208974, 431.24747315933894, 434.9043210493686, 438.0319493918476, 448.17983090943494, 450.16045075933147, 5409.188621706776, 5638.323401191883, 5713.600047996683, 5733.684647344353, 5809.448102430262, 524758.0, 527859.0, 542329.0, 543955.1649318571, 574654.0, 71447.64276178586, 72477.0, 72479.0, 73261.0, 75270.0, 439.9230134726474, 456.77161419290354, 460.9585137337656, 473.68973322473835, 481.506455882716, 9433.952830235805, 9563.187129094105, 9776.951115244377, 9901.950490247502, 9907.554160062671, 30138.397232055675, 30428.69571304347, 31809.0, 32164.0, 33000.33999320048, 36697.0, 37936.430953535164, 42323.0, 42492.0, 46474.76762616165, 6909.343612356818, 6909.723611055702, 6971.477139214478, 7078.610676412847, 7246.166690830411, 10729.409882456539, 10793.67618971432, 10835.187360947803, 11420.94289528547, 11767.76464470723, 9016.549172541478, 9478.194353479756, 9514.571844266886, 9617.51912404363, 9812.705618831447, 9105.77235569116, 9314.394564353295, 9759.87991510567, 9867.65463208813, 9885.308028438229, 3122.31309111995, 5029.270755740324, 5767.423257674199, 9612.279079068958, 9621.759456013655, 7109.1824440187975, 7112.50212485121, 7142.285851395523, 7236.855262894607, 7261.056062711814, 8234.629441675019, 9103.90896091057, 9643.662471813454, 10033.44816035125, 10167.796644067224], "unit": "score", "name": "jquery.html", "value": 7302.673499222396}, {"lowerIsBetter": false, "replicates": [1250.2685928731692, 1438.151490620534, 1447.413797412048, 1588.1582761136594, 1770.4777090758225, 7123.394511466525, 7673.386129109672, 7860.764177074697, 7869.92130078699, 7872.5670088145125, 7654.311111999933, 7751.961240193791, 7796.415268854845, 7800.921990780091, 7824.843503129934, 2074.2325339624285, 2118.470382404399, 2119.8940052997286, 2362.114207172306, 2393.8803059847023, 2341.0401735288533, 2410.6745589345387, 2410.855348679076, 2411.722651895037, 2413.9517209655796, 2320.3503019154664, 2344.3553022918663, 2376.239603326936, 2376.4652953085506, 2376.7266764322153, 2315.0392587076426, 2328.906843726249, 2332.3352844439337, 2354.705661792276, 2359.1624973134462, 2325.6627788970504, 2330.7203135623663, 2353.5292941411617, 2360.893759780814, 2362.716474023111, 7823.452358334919, 7868.685252589947, 7869.0, 7870.449068565203, 7873.763787086396, 4762.214234651278, 4878.195097808893, 4881.926771098437, 4884.658073934826, 4885.706857588556, 3076.9846150769326, 3115.3146307812244, 3136.764742644311, 3151.921201969946, 3220.130564747505, 1001.9048190421898, 1019.6584144311664, 1035.777307878802, 1050.8791488978788, 1053.6628278950739, 11152.944235278852, 11179.888201118047, 11187.608433704781, 11190.44047797615, 11231.60689375876, 4310.0, 4347.826086956549, 4375.2780791169735, 4424.292113261863, 4440.600345968878, 9481.194098501566, 9483.14651681352, 9539.47532885698, 9542.90457095434, 9550.235981121632, 4916.704997700078, 4918.827841025547, 4939.135651261086, 4939.3084968104495, 4943.629227807929, 4447.2439685253585, 4471.150481408522, 4478.2386994211065, 4480.350349199348, 4481.574250446202, 3514.3498452786316, 3581.5702115746276, 3715.64701353371, 3720.720945929012, 3809.3333666608232, 1216.2094638484878, 1216.683662247822, 1218.0620921890272, 1221.8533775946767, 1226.172333674766, 968.8934217236099, 989.1690979577189, 990.3760630802692, 1092.9289596176222, 1345.663584103974, 7286.162091359455, 7294.161171465244, 7296.233895441009, 7307.926920730724, 7324.0, 1181.8522684664417, 1197.6646538969103, 1205.7889869272842, 1226.405193481161, 1233.531258121926, 5690.971545142331, 5738.0, 5777.162311464814, 5835.533157347402, 5839.883202336015, 9278.628854845865, 9529.571169297398, 9644.18024467928, 9655.9034409655, 9656.903430965742, 9257.722268331961, 9521.381110227812, 9546.331756776959, 9607.279454040974, 9656.71029869105, 7377.26227377258, 7459.328660420588, 7487.66305516253, 7546.0, 7558.2441755825075, 7150.64246787669, 7188.388986936169, 7280.235575264521, 7296.489245752747, 7324.743633972998, 8448.915510844812, 8674.826503469769, 8676.349273804617, 8800.47197168172, 8802.339824513316, 8699.13008699125, 8738.868916966123, 8813.559322034002, 8975.865362019706, 9070.954645226995, 6845.794626161223, 6901.723931042903, 6907.171139463297, 6943.826404339932, 6953.548019378724, 6885.827854303682, 7048.647567621701, 7228.168760592389, 7335.083114610674, 7403.074615673041, 6690.665466726547, 6772.255051944184, 6832.145981752281, 6898.379145876695, 6957.582545047313, 6597.670116494252, 6758.0, 6829.965850170717, 6963.234044255027, 7146.3568278855155, 7110.0, 7148.070750802362, 7149.0706208192605, 7155.642217889189, 7158.749443769443, 6093.6039157454625, 6217.906731399123, 6226.657533835682, 6228.283747369111, 6318.241810982711, 6386.297507274103, 6415.743370265137, 6437.871242575028, 6438.90341644885, 6448.32292609288], "unit": "score", "name": "mootools.html", "value": 4549.272565192606}, {"lowerIsBetter": false, "replicates": [335.6274535265855, 336.48685754224806, 347.588108091911, 347.79132520487724, 352.2760726706617, 5824.737886795094, 5914.053751399777, 5917.082852157917, 5934.465898069173, 5965.1946987156725, 5678.0, 5748.080307150857, 5749.080147176443, 5784.132380142981, 5787.594868359217, 4556.749378784166, 4560.680752347337, 4562.133194693014, 4564.771761411933, 4576.336431217472, 4358.128374325148, 4448.466184057901, 4475.932861007088, 4554.2713165893465, 4568.497465278817, 4519.819207231707, 4521.276595744682, 4531.388262584542, 4536.841210557631, 4544.341070544769, 4527.750973696462, 4533.909321813579, 4535.546445355438, 4537.909241815161, 4543.704659197141, 4012.9197416051807, 4019.4774679291504, 4020.2361551305453, 4025.3961905714377, 4026.174634199982, 5509.917351239735, 5644.717764111778, 5656.575756818255, 5677.318721753375, 5778.075507918755, 5232.555232805216, 5253.238280449352, 5253.4221235664045, 5259.132243179909, 5262.473752624745, 5953.791617293374, 6287.9056814147825, 6299.338569450188, 6300.27546832111, 6300.495960323209, 4232.534421213664, 4279.058607106432, 4374.6500279977845, 4380.561943805626, 4384.868453946387, 6450.709718062699, 6454.774082907123, 6499.5775274607, 6503.837404064936, 6530.6734663267125, 4433.29067349229, 4434.17967675981, 4436.401085853433, 4437.556244375537, 4445.066536027471, 4415.0, 4477.619402350771, 4497.347884556721, 4501.504834468205, 4533.863984080483, 5212.218167274939, 5218.112920803473, 5220.895582088337, 5224.660397074178, 5226.268322434862, 6299.6850157491945, 6305.558610897193, 6308.053791931247, 6314.810555683337, 6318.526110541728, 1555.5411153709683, 1558.322129873486, 1559.1346802524708, 1560.5240401677597, 1561.3910574875808, 1047.9790404191874, 1064.090202876545, 1067.6636859389268, 1069.2996087562658, 1087.798757229915, 5885.440883116097, 5890.410958904075, 5896.616719913192, 5905.350411454737, 5919.082542205965, 6446.387593178641, 6459.418652321219, 6464.676766161673, 6488.318726533646, 6494.1232933553365, 5917.852053698606, 5923.703814809242, 5928.140419639129, 5931.169636250928, 5931.940680593225, 3402.608699999532, 3485.686288234071, 3491.860325586999, 3492.0571445709516, 3494.947575786365, 6776.69504872282, 6818.2159051708695, 6837.589744615339, 6842.4183944364295, 6845.657717114124, 6648.700808463631, 6649.335066493409, 6650.833729156713, 6651.833704157338, 6655.46756259498, 6603.504737144734, 6794.388505034571, 6810.455163586901, 6821.317868213238, 6821.556598821061, 6303.432691057827, 6432.067350234283, 6480.319566445455, 6520.510961677988, 6533.836654083686, 6231.470325022243, 6325.335839736761, 6357.713902874474, 6357.841053973688, 6483.930151524945, 6791.185057793096, 6816.727330906907, 6816.863662726817, 6827.317268273332, 6831.59010459374, 4358.891027724332, 4458.952146245694, 4501.852027732907, 4504.504504504567, 4510.977445112753, 6499.155109835691, 6502.60984340941, 6511.641859697762, 6513.772017979348, 6516.804495865132, 6321.304656487875, 6325.620462772248, 6330.556861019684, 6338.65137417428, 6338.746450141943, 6197.194364732556, 6305.864944309885, 6307.936920630918, 6313.1477250572425, 6324.778632747832, 6201.875962480815, 6207.534434917309, 6207.751689932352, 6211.65835879013, 6219.0982307566055, 6340.397662222082, 6340.968295158679, 6350.841228969312, 6354.887894618516, 6355.237371515448, 6024.969875150597, 6189.0, 6246.875062498815, 6269.4984401246875, 6273.153124328157], "unit": "score", "name": "prototype.html", "value": 4740.977213251935}, {"lowerIsBetter": false, "replicates": [831.1895901496042, 834.7078522517123, 835.1982097186702, 840.9411341206117, 845.3575282785085, 12821.55124570639, 12907.225566466019, 12931.094823362368, 12934.5472908448, 12947.0, 12491.267706119279, 12594.0, 12800.551980680679, 13501.797473037888, 13512.121712088707, 796.0685997383047, 809.7935026568217, 811.3265989228955, 811.5942028985507, 812.3866480807012, 656.9934300657004, 675.2707076357522, 801.519088546873, 820.6225136437246, 826.2811354121923, 846.2299307630058, 852.0840096895862, 853.8164294676643, 853.8505761491746, 855.7432770168956, 690.5166383531498, 701.5895701014913, 850.26452118917, 854.0434713121313, 854.8760429737684, 619.3249358199585, 625.4964753373532, 625.9280182778994, 626.2422468812742, 628.6353914729445, 13623.455061797516, 13624.795628065587, 13652.453901843914, 13655.38550765218, 13749.931250343785, 13042.347882605833, 13357.413329475163, 13749.518766843112, 13812.240326782023, 13870.930645346809, 10805.621803236849, 10816.51325690338, 11031.558737650485, 11037.163613834187, 11058.834117488244, 3586.8923932282073, 3628.51015112959, 3634.309481198564, 3654.8172591370326, 3751.662350388478, 47652.761736191445, 47746.7612661938, 47792.5220747795, 47850.28224576634, 47874.76062619664, 10339.741506462247, 10524.31591946521, 10633.202509811796, 10688.0, 11080.833787493195, 18685.719714204297, 18748.250069997048, 18761.90619046896, 18776.248950041845, 18777.906110469634, 7164.605946672983, 7183.209846916835, 7203.747868824566, 7385.7045718170675, 7502.662380192795, 3987.561368249548, 3991.381335892941, 4069.1658210066867, 4085.9591404085577, 4221.514525829508, 2989.8056626319653, 2996.565498002821, 3010.262485690976, 3010.5935698680837, 3013.8794448222266, 532.2229544864464, 547.7124509632475, 547.8712502561895, 558.2993343354065, 562.0585519255231, 533.6344603946309, 601.5638661970037, 666.4768156996735, 675.6486626953956, 683.5864302097259, 8506.74479765608, 8799.736007919773, 8891.911080889238, 8990.910090899008, 9205.401648892801, 560.6075746977132, 573.3549756523911, 600.7116584039599, 651.7914267434376, 692.8648913461826, 3655.7258205634685, 3946.9013274668364, 3973.3443981743267, 3974.82113304902, 3991.4212439196735, 54556.45443545514, 59501.0, 59589.0, 59769.40230597725, 59782.0, 51947.0, 52187.0, 52850.207246891325, 53080.0, 53133.734331328094, 45979.77010114928, 47037.52962470332, 47367.52632473631, 47571.76214118907, 49073.5092649069, 7945.1510333863735, 7981.680732770857, 8020.278174964281, 8112.75661730149, 8214.753557393287, 33173.0, 33911.660883391836, 34367.4844877322, 34508.41186910941, 34630.653693462744, 42319.57680423156, 42441.15117697567, 43849.34225986549, 46037.309440359095, 46308.0, 10823.350598963772, 10930.453477325942, 11016.0, 11079.16906232052, 11331.206815522833, 10945.83581246298, 10969.286996345212, 12470.812937806122, 12678.0, 13383.732325353632, 10129.363070363255, 10170.593176272867, 10265.0, 10882.0, 10907.236493445384, 10329.638462654071, 10477.266591338534, 10845.078168355778, 10854.728631784268, 10936.726581835517, 10316.17470602365, 10372.377657340583, 11020.559177633126, 11032.44837758125, 11034.393108379116, 9329.207017403325, 9388.812223755624, 9543.9045609543, 9651.9034809651, 10119.190464762949, 8753.518556479201, 9242.214411775074, 9665.420074795535, 9741.9025809741, 9796.706098816761], "unit": "score", "name": "yui.html", "value": 6247.442111462226}], "name": "dromaeo_css", "value": 6705.61530832186}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 105.0, 111.0, 109.0, 110.0, 109.0, 111.0, 105.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [157.0, 127.0, 150.0, 160.0, 129.0, 157.0, 163.0, 143.0, 172.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 161.0, 161.0, 162.0, 160.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 94.0, 100.0, 72.0, 73.0, 72.0, 109.0, 94.0, 74.0], "unit": "score", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [104.0, 96.0, 147.0, 96.0, 96.0, 95.0, 143.0, 96.0, 97.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 56.0, 56.0, 58.0, 57.0, 56.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [88.0, 81.0, 82.0, 82.0, 82.0, 83.0, 81.0, 82.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [113.0, 116.0, 117.0, 118.0, 126.0, 114.0, 118.0, 121.0, 118.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [143.0, 132.0, 142.0, 139.0, 142.0, 132.0, 143.0, 143.0, 140.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 68.0, 66.0, 65.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1497.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.01075268817203], "unit": "score", "name": "Richards", "value": 210.11750400000008}, {"lowerIsBetter": false, "replicates": [187.75816748028538], "unit": "score", "name": "DeltaBlue", "value": 352.14446799999996}, {"lowerIsBetter": false, "replicates": [282.326369282891], "unit": "score", "name": "Encrypt", "value": 942.813102}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [2089.7703549060543], "unit": "score", "name": "RayTrace", "value": 354.1006303696304}, {"lowerIsBetter": false, "replicates": [772.2007722007722], "unit": "score", "name": "Earley", "value": 863.0695849999998}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [42187.5], "unit": "score", "name": "RegExp", "value": 21.593718518518536}, {"lowerIsBetter": false, "replicates": [562.429696287964], "unit": "score", "name": "Splay", "value": 144.89099799999994}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 18910.12110892433}]} 11:17:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18910.12"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1497.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6705.62"}}} 11:17:36 INFO - Return code: 0 11:17:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:17:36 INFO - # TBPL SUCCESS # 11:17:36 INFO - Running post-action listener: _resource_record_post_action 11:17:36 INFO - Running post-run listener: _resource_record_post_run 11:17:37 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 553619456; Read time: 0; Write time: 462600 11:17:37 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237387776; Read time: 0; Write time: 296816 11:17:37 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 316231680; Read time: 0; Write time: 165784 11:17:37 INFO - Running post-run listener: _upload_blobber_files 11:17:37 INFO - Blob upload gear active. 11:17:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:17:37 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 11:17:37 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'] 11:17:37 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 11:17:38 INFO - (blobuploader) - INFO - Open directory for files ... 11:17:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:17:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:17:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:39 INFO - (blobuploader) - INFO - Done attempting. 11:17:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:17:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:17:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:40 INFO - (blobuploader) - INFO - Done attempting. 11:17:40 INFO - (blobuploader) - INFO - Iteration through files over. 11:17:40 INFO - Return code: 0 11:17:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:17:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:17:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1858be440c80c7c849dda4476e4df725493509cda8a31b4b36a4b440e00a0fb13d920434194ae252033d693b4fa2229a7f1cb7848baf8e756128900b34a9da8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0afa3b6f92455f4d386087a7a60cf2e1caad95379663638621fb2bfe51f910f6876f427cf5925b070383a5bc85a39a45a824574b4f37a02e9bd1ac5209671626"} 11:17:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:17:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:17:40 INFO - Contents: 11:17:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1858be440c80c7c849dda4476e4df725493509cda8a31b4b36a4b440e00a0fb13d920434194ae252033d693b4fa2229a7f1cb7848baf8e756128900b34a9da8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0afa3b6f92455f4d386087a7a60cf2e1caad95379663638621fb2bfe51f910f6876f427cf5925b070383a5bc85a39a45a824574b4f37a02e9bd1ac5209671626"} 11:17:40 INFO - Running post-run listener: copy_logs_to_upload_dir 11:17:40 INFO - Copying logs to upload dir... 11:17:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:17:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.664183 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-20 11:17:40.098762) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 11:17:40.102344) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231 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/f1858be440c80c7c849dda4476e4df725493509cda8a31b4b36a4b440e00a0fb13d920434194ae252033d693b4fa2229a7f1cb7848baf8e756128900b34a9da8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0afa3b6f92455f4d386087a7a60cf2e1caad95379663638621fb2bfe51f910f6876f427cf5925b070383a5bc85a39a45a824574b4f37a02e9bd1ac5209671626"} build_url:https://queue.taskcluster.net/v1/task/d4YZG-78SpetzoG37iZu8g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010106 build_url: 'https://queue.taskcluster.net/v1/task/d4YZG-78SpetzoG37iZu8g/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/f1858be440c80c7c849dda4476e4df725493509cda8a31b4b36a4b440e00a0fb13d920434194ae252033d693b4fa2229a7f1cb7848baf8e756128900b34a9da8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0afa3b6f92455f4d386087a7a60cf2e1caad95379663638621fb2bfe51f910f6876f427cf5925b070383a5bc85a39a45a824574b4f37a02e9bd1ac5209671626"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 11:17:40.127009) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 11:17:40.127336) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453315497.555678-1778897231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 11:17:40.212879) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 11:17:40.213213) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 11:17:40.213513) ========= ========= Total master_lag: 0.28 =========