builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1455842321.36 results: success (0) buildid: 20160218141425 builduid: 7c140e22d05a4eecbd4b0090952d146e revision: 811cb8884a03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:41.360592) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:41.361027) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:41.361330) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006355 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.40 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:41.770990) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:41.774348) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:41.789886) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:41.790273) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:41.838964) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:41.842290) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:41.842652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:41.842928) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-18 16:38:42-- 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% 42.9M=0s 2016-02-18 16:38:42 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118950 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:41.974595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:41.974907) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022203 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:42.025402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:42.025790) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 811cb8884a03 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 811cb8884a03 --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=78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-18 16:38:42,504 Setting DEBUG logging. 2016-02-18 16:38:42,505 attempt 1/10 2016-02-18 16:38:42,505 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/811cb8884a03?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 16:38:42,762 unpacking tar archive at: mozilla-beta-811cb8884a03/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567665 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:42.608189) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:42.608645) ========= echo 811cb8884a03 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'811cb8884a03'] 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=78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 811cb8884a03 program finished with exit code 0 elapsedTime=0.004611 script_repo_revision: '811cb8884a03' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:42.664254) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:42.664552) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 16:38:42.674870) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-18 16:38:42.675142) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:38:43 INFO - MultiFileLogger online at 20160218 16:38:43 in /builds/slave/test-pgo 16:38:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:38:43 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:38:43 INFO - {'append_to_log': False, 16:38:43 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:38:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:38:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:38:43 INFO - 'branch': 'Mozilla-Beta', 16:38:43 INFO - 'buildbot_json_path': 'buildprops.json', 16:38:43 INFO - 'config_files': ('talos/linux_config.py',), 16:38:43 INFO - 'default_actions': ('clobber', 16:38:43 INFO - 'read-buildbot-config', 16:38:43 INFO - 'download-and-extract', 16:38:43 INFO - 'populate-webroot', 16:38:43 INFO - 'create-virtualenv', 16:38:43 INFO - 'install', 16:38:43 INFO - 'run-tests'), 16:38:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:38:43 INFO - 'download_minidump_stackwalk': True, 16:38:43 INFO - 'download_symbols': 'ondemand', 16:38:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:38:43 INFO - 'tooltool.py': '/tools/tooltool.py', 16:38:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:38:43 INFO - '/tools/misc-python/virtualenv.py')}, 16:38:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:38:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:38:43 INFO - 'installer_path': 'installer.exe', 16:38:43 INFO - 'log_level': 'info', 16:38:43 INFO - 'log_name': 'talos', 16:38:43 INFO - 'log_to_console': True, 16:38:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:38:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:38:43 INFO - 'opt_config_files': (), 16:38:43 INFO - 'pip_index': False, 16:38:43 INFO - 'sps_profile': False, 16:38:43 INFO - 'sps_profile_interval': 0, 16:38:43 INFO - 'suite': 'dromaeojs', 16:38:43 INFO - 'system_bits': '32', 16:38:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:38:43 INFO - 'title': 'talos-linux64-ix-019', 16:38:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:38:43 INFO - 'use_talos_json': True, 16:38:43 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:38:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:38:43 INFO - 'work_dir': 'build'} 16:38:43 INFO - ##### 16:38:43 INFO - ##### Running clobber step. 16:38:43 INFO - ##### 16:38:43 INFO - Running pre-action listener: _resource_record_pre_action 16:38:43 INFO - Running main action method: clobber 16:38:43 INFO - rmtree: /builds/slave/test-pgo/build 16:38:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:38:43 INFO - Running post-action listener: _resource_record_post_action 16:38:43 INFO - ##### 16:38:43 INFO - ##### Running read-buildbot-config step. 16:38:43 INFO - ##### 16:38:43 INFO - Running pre-action listener: _resource_record_pre_action 16:38:43 INFO - Running main action method: read_buildbot_config 16:38:43 INFO - Using buildbot properties: 16:38:43 INFO - { 16:38:43 INFO - "properties": { 16:38:43 INFO - "buildnumber": 89, 16:38:43 INFO - "product": "firefox", 16:38:43 INFO - "script_repo_revision": "production", 16:38:43 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 16:38:43 INFO - "repository": "", 16:38:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 16:38:43 INFO - "buildid": "20160218141425", 16:38:43 INFO - "slavename": "talos-linux64-ix-019", 16:38:43 INFO - "pgo_build": "True", 16:38:43 INFO - "basedir": "/builds/slave/test-pgo", 16:38:43 INFO - "project": "", 16:38:43 INFO - "platform": "ubuntu64_hw", 16:38:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:38:43 INFO - "slavebuilddir": "test", 16:38:43 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:38:43 INFO - "branch": "mozilla-beta", 16:38:43 INFO - "repo_path": "releases/mozilla-beta", 16:38:43 INFO - "stage_platform": "linux64-pgo", 16:38:43 INFO - "builduid": "7c140e22d05a4eecbd4b0090952d146e", 16:38:43 INFO - "revision": "811cb8884a03" 16:38:43 INFO - }, 16:38:43 INFO - "sourcestamp": { 16:38:43 INFO - "repository": "", 16:38:43 INFO - "hasPatch": false, 16:38:43 INFO - "project": "", 16:38:43 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 16:38:43 INFO - "changes": [ 16:38:43 INFO - { 16:38:43 INFO - "category": null, 16:38:43 INFO - "files": [ 16:38:43 INFO - { 16:38:43 INFO - "url": null, 16:38:43 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455829105/firefox-45.0.en-US.linux-x86_64.tar.bz2" 16:38:43 INFO - } 16:38:43 INFO - ], 16:38:43 INFO - "repository": "", 16:38:43 INFO - "rev": "7619a19b83cb", 16:38:43 INFO - "who": "sendchange", 16:38:43 INFO - "when": 1455842240, 16:38:43 INFO - "number": 7624782, 16:38:43 INFO - "comments": "Bug 1163082 - Part 2: Extract Android distribution from packaged assets rather than APK root. r=rnewman a=sylvestre", 16:38:43 INFO - "project": "", 16:38:43 INFO - "at": "Thu 18 Feb 2016 16:37:20", 16:38:43 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 16:38:43 INFO - "revlink": "", 16:38:43 INFO - "properties": [ 16:38:43 INFO - [ 16:38:43 INFO - "buildid", 16:38:43 INFO - "20160218125825", 16:38:43 INFO - "Change" 16:38:43 INFO - ], 16:38:43 INFO - [ 16:38:43 INFO - "builduid", 16:38:43 INFO - "9f45e47762e0417da8a7d90fe46ceda8", 16:38:43 INFO - "Change" 16:38:43 INFO - ], 16:38:43 INFO - [ 16:38:43 INFO - "pgo_build", 16:38:43 INFO - "True", 16:38:43 INFO - "Change" 16:38:43 INFO - ] 16:38:43 INFO - ], 16:38:43 INFO - "revision": "7619a19b83cb" 16:38:43 INFO - }, 16:38:43 INFO - { 16:38:43 INFO - "category": null, 16:38:43 INFO - "files": [ 16:38:43 INFO - { 16:38:43 INFO - "url": null, 16:38:43 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.tar.bz2" 16:38:43 INFO - } 16:38:43 INFO - ], 16:38:43 INFO - "repository": "", 16:38:43 INFO - "rev": "811cb8884a03", 16:38:43 INFO - "who": "sendchange", 16:38:43 INFO - "when": 1455842194, 16:38:43 INFO - "number": 7624779, 16:38:43 INFO - "comments": "Bug 1201885,1247752,1247753 - Re-mark passing/failing tests. - a=test-only", 16:38:43 INFO - "project": "", 16:38:43 INFO - "at": "Thu 18 Feb 2016 16:36:34", 16:38:43 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 16:38:43 INFO - "revlink": "", 16:38:43 INFO - "properties": [ 16:38:43 INFO - [ 16:38:43 INFO - "buildid", 16:38:43 INFO - "20160218141425", 16:38:43 INFO - "Change" 16:38:43 INFO - ], 16:38:43 INFO - [ 16:38:43 INFO - "builduid", 16:38:43 INFO - "7c140e22d05a4eecbd4b0090952d146e", 16:38:43 INFO - "Change" 16:38:43 INFO - ], 16:38:43 INFO - [ 16:38:43 INFO - "pgo_build", 16:38:43 INFO - "True", 16:38:43 INFO - "Change" 16:38:43 INFO - ] 16:38:43 INFO - ], 16:38:43 INFO - "revision": "811cb8884a03" 16:38:43 INFO - } 16:38:43 INFO - ], 16:38:43 INFO - "revision": "811cb8884a03" 16:38:43 INFO - } 16:38:43 INFO - } 16:38:43 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.tar.bz2. 16:38:43 INFO - Running post-action listener: _resource_record_post_action 16:38:43 INFO - ##### 16:38:43 INFO - ##### Running download-and-extract step. 16:38:43 INFO - ##### 16:38:43 INFO - Running pre-action listener: _resource_record_pre_action 16:38:43 INFO - Running main action method: download_and_extract 16:38:43 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:38:43 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')]} 16:38:43 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/test_packages.json 16:38:43 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:38:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:38:43 INFO - Downloaded 1270 bytes. 16:38:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:38:43 INFO - Using the following test package requirements: 16:38:43 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 16:38:43 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:38:43 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:38:43 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:38:43 INFO - u'jsshell-linux-x86_64.zip'], 16:38:43 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:38:43 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:38:43 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 16:38:43 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:38:43 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 16:38:43 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:38:43 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 16:38:43 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:38:43 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:38:43 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 16:38:43 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 16:38:43 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:38:43 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:38:43 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')]} 16:38:43 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:38:43 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:38:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:38:44 INFO - Downloaded 22258475 bytes. 16:38:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:38:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:38:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:38:45 INFO - Return code: 0 16:38:45 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:45 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:38:45 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:38:45 INFO - Downloaded 22258475 bytes. 16:38:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:38:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 16:38:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:38:47 INFO - Return code: 0 16:38: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')]} 16:38:47 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 16:38:47 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 16:38:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:38:47 INFO - Downloaded 11132038 bytes. 16:38:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:38:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 16:38:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:38:47 INFO - Return code: 0 16:38: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')]} 16:38:47 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.tar.bz2 16:38:47 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 16:38:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:38:48 INFO - Downloaded 58337857 bytes. 16:38:48 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.tar.bz2 16:38:48 INFO - mkdir: /builds/slave/test-pgo/properties 16:38:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:38:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:38:48 INFO - Contents: 16:38:48 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.tar.bz2 16:38:48 INFO - Running post-action listener: _resource_record_post_action 16:38:48 INFO - Running post-action listener: set_extra_try_arguments 16:38:48 INFO - ##### 16:38:48 INFO - ##### Running populate-webroot step. 16:38:48 INFO - ##### 16:38:48 INFO - Running pre-action listener: _resource_record_pre_action 16:38:48 INFO - Running main action method: populate_webroot 16:38:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:38:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:38:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:38:48 INFO - '--tppagecycles', 16:38:48 INFO - '7'], 16:38:48 INFO - 'tests': ['tsvgm']}}, 16:38:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:38:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:38:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:38:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:38:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:38:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:38:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:48 INFO - 'talos_options': ['--e10s'], 16:38:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:48 INFO - 'tests': ['damp', 'tps']}, 16:38:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:48 INFO - 'talos_options': ['--e10s'], 16:38:48 INFO - 'tests': ['damp', 'tps']}, 16:38:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:38:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:38:48 INFO - 'other': {'tests': ['a11yr', 16:38:48 INFO - 'ts_paint', 16:38:48 INFO - 'tpaint', 16:38:48 INFO - 'sessionrestore', 16:38:48 INFO - 'sessionrestore_no_auto_restore']}, 16:38:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:38:48 INFO - 'tests': ['a11yr', 16:38:48 INFO - 'ts_paint', 16:38:48 INFO - 'tpaint', 16:38:48 INFO - 'sessionrestore', 16:38:48 INFO - 'sessionrestore_no_auto_restore']}, 16:38:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:38:48 INFO - 'tests': ['a11yr', 16:38:48 INFO - 'ts_paint', 16:38:48 INFO - 'tpaint', 16:38:48 INFO - 'sessionrestore', 16:38:48 INFO - 'sessionrestore_no_auto_restore']}, 16:38:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:38:48 INFO - 'tests': ['a11yr', 16:38:48 INFO - 'ts_paint', 16:38:48 INFO - 'tpaint', 16:38:48 INFO - 'sessionrestore', 16:38:48 INFO - 'sessionrestore_no_auto_restore']}, 16:38:48 INFO - 'other_l64': {'tests': ['a11yr', 16:38:48 INFO - 'ts_paint', 16:38:48 INFO - 'tpaint', 16:38:48 INFO - 'sessionrestore', 16:38:48 INFO - 'sessionrestore_no_auto_restore']}, 16:38:48 INFO - 'other_nol64': {'tests': ['a11yr', 16:38:48 INFO - 'ts_paint', 16:38:48 INFO - 'tpaint', 16:38:48 INFO - 'sessionrestore', 16:38:48 INFO - 'sessionrestore_no_auto_restore']}, 16:38:48 INFO - 'svgr': {'tests': ['tsvgx', 16:38:48 INFO - 'tsvgr_opacity', 16:38:48 INFO - 'tart', 16:38:48 INFO - 'tscrollx', 16:38:48 INFO - 'cart']}, 16:38:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:38:48 INFO - 'tests': ['tsvgx', 16:38:48 INFO - 'tsvgr_opacity', 16:38:48 INFO - 'tart', 16:38:48 INFO - 'tscrollx', 16:38:48 INFO - 'cart']}, 16:38:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:48 INFO - 'tests': ['tp5o']}, 16:38:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:48 INFO - 'talos_options': ['--e10s'], 16:38:48 INFO - 'tests': ['tp5o']}, 16:38:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:48 INFO - 'talos_options': ['--xperf_path', 16:38:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:48 INFO - 'tests': ['tp5n']}, 16:38:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:48 INFO - 'talos_options': ['--e10s', 16:38:48 INFO - '--xperf_path', 16:38:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:48 INFO - 'tests': ['tp5n']}}, 16:38:48 INFO - 'talos.zip': {'path': '', 16:38:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:38:48 INFO - Running post-action listener: _resource_record_post_action 16:38:48 INFO - ##### 16:38:48 INFO - ##### Running create-virtualenv step. 16:38:48 INFO - ##### 16:38:48 INFO - Running pre-action listener: _resource_record_pre_action 16:38:48 INFO - Running main action method: create_virtualenv 16:38:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:38:48 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 16:38:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:38:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:38:48 INFO - Using real prefix '/usr' 16:38:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:38:49 INFO - Installing distribute.............................................................................................................................................................................................done. 16:38:51 INFO - Installing pip.................done. 16:38:51 INFO - Return code: 0 16:38:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31f5300f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1269600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f8350>, '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 0x12f9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f96e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', '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 16:38:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:38:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:38:51 INFO - Using env: {'DISPLAY': ':0', 16:38:51 INFO - 'HOME': '/home/cltbld', 16:38:51 INFO - 'LANG': 'en_US.UTF-8', 16:38:51 INFO - 'LANGUAGE': 'en_US:en', 16:38:51 INFO - 'LOGNAME': 'cltbld', 16:38:51 INFO - 'MAIL': '/var/mail/cltbld', 16:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:51 INFO - 'MOZ_NO_REMOTE': '1', 16:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:51 INFO - 'NO_EM_RESTART': '1', 16:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:51 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:51 INFO - 'SHELL': '/bin/bash', 16:38:51 INFO - 'SHLVL': '1', 16:38:51 INFO - 'TERM': 'linux', 16:38:51 INFO - 'TMOUT': '86400', 16:38:51 INFO - 'USER': 'cltbld', 16:38:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', 16:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:51 INFO - '_': '/tools/buildbot/bin/python'} 16:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:51 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 16:38:51 INFO - Cleaning up... 16:38:51 INFO - Return code: 0 16:38:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f31f5300f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1269600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f8350>, '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 0x12f9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f96e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', '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 16:38:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:38:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:38:51 INFO - Using env: {'DISPLAY': ':0', 16:38:51 INFO - 'HOME': '/home/cltbld', 16:38:51 INFO - 'LANG': 'en_US.UTF-8', 16:38:51 INFO - 'LANGUAGE': 'en_US:en', 16:38:51 INFO - 'LOGNAME': 'cltbld', 16:38:51 INFO - 'MAIL': '/var/mail/cltbld', 16:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:51 INFO - 'MOZ_NO_REMOTE': '1', 16:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:51 INFO - 'NO_EM_RESTART': '1', 16:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:51 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:51 INFO - 'SHELL': '/bin/bash', 16:38:51 INFO - 'SHLVL': '1', 16:38:51 INFO - 'TERM': 'linux', 16:38:51 INFO - 'TMOUT': '86400', 16:38:51 INFO - 'USER': 'cltbld', 16:38:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', 16:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:51 INFO - '_': '/tools/buildbot/bin/python'} 16:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:51 INFO - Downloading/unpacking psutil>=0.7.1 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:38:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:53 INFO - Installing collected packages: psutil 16:38:53 INFO - Running setup.py install for psutil 16:38:53 INFO - building 'psutil._psutil_linux' extension 16:38:53 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 16:38:53 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 16:38:53 INFO - building 'psutil._psutil_posix' extension 16:38:53 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 16:38:53 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 16:38:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:54 INFO - Successfully installed psutil 16:38:54 INFO - Cleaning up... 16:38:54 INFO - Return code: 0 16:38:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:54 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 0x7f31f5300f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1269600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f8350>, '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 0x12f9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f96e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', '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 16:38:54 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 16:38:54 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 16:38:54 INFO - Using env: {'DISPLAY': ':0', 16:38:54 INFO - 'HOME': '/home/cltbld', 16:38:54 INFO - 'LANG': 'en_US.UTF-8', 16:38:54 INFO - 'LANGUAGE': 'en_US:en', 16:38:54 INFO - 'LOGNAME': 'cltbld', 16:38:54 INFO - 'MAIL': '/var/mail/cltbld', 16:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:54 INFO - 'MOZ_NO_REMOTE': '1', 16:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:54 INFO - 'NO_EM_RESTART': '1', 16:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:54 INFO - 'SHELL': '/bin/bash', 16:38:54 INFO - 'SHLVL': '1', 16:38:54 INFO - 'TERM': 'linux', 16:38:54 INFO - 'TMOUT': '86400', 16:38:54 INFO - 'USER': 'cltbld', 16:38:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', 16:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:54 INFO - '_': '/tools/buildbot/bin/python'} 16:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:38:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:38:56 INFO - Installing collected packages: mozsystemmonitor 16:38:56 INFO - Running setup.py install for mozsystemmonitor 16:38:56 INFO - Successfully installed mozsystemmonitor 16:38:56 INFO - Cleaning up... 16:38:56 INFO - Return code: 0 16:38:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:38: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')]} 16:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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')]} 16:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:56 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 0x7f31f5300f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1269600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f8350>, '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 0x12f9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f96e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', '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 16:38:56 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 16:38:56 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 16:38:56 INFO - Using env: {'DISPLAY': ':0', 16:38:56 INFO - 'HOME': '/home/cltbld', 16:38:56 INFO - 'LANG': 'en_US.UTF-8', 16:38:56 INFO - 'LANGUAGE': 'en_US:en', 16:38:56 INFO - 'LOGNAME': 'cltbld', 16:38:56 INFO - 'MAIL': '/var/mail/cltbld', 16:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:56 INFO - 'MOZ_NO_REMOTE': '1', 16:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:56 INFO - 'NO_EM_RESTART': '1', 16:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:56 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:56 INFO - 'SHELL': '/bin/bash', 16:38:56 INFO - 'SHLVL': '1', 16:38:56 INFO - 'TERM': 'linux', 16:38:56 INFO - 'TMOUT': '86400', 16:38:56 INFO - 'USER': 'cltbld', 16:38:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', 16:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:56 INFO - '_': '/tools/buildbot/bin/python'} 16:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:56 INFO - Downloading/unpacking blobuploader==1.2.4 16:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:58 INFO - Downloading blobuploader-1.2.4.tar.gz 16:38:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:38:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:38:58 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 16:38:58 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 16:38:58 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 16:38:58 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 16:38:58 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 16:38:58 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 16:38:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:38:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:38:58 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 16:38:58 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 16:38:58 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 16:38:58 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 16:38:58 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 16:38:58 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 16:38:58 INFO - Downloading docopt-0.6.1.tar.gz 16:38:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:38:59 INFO - Installing collected packages: blobuploader, requests, docopt 16:38:59 INFO - Running setup.py install for blobuploader 16:38:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:38:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:38:59 INFO - Running setup.py install for requests 16:38:59 INFO - Running setup.py install for docopt 16:38:59 INFO - Successfully installed blobuploader requests docopt 16:38:59 INFO - Cleaning up... 16:38:59 INFO - Return code: 0 16:38:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:59 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 0x7f31f5300f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1269600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f8350>, '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 0x12f9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f96e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', '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 16:38:59 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 16:38:59 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 16:38:59 INFO - Using env: {'DISPLAY': ':0', 16:38:59 INFO - 'HOME': '/home/cltbld', 16:38:59 INFO - 'LANG': 'en_US.UTF-8', 16:38:59 INFO - 'LANGUAGE': 'en_US:en', 16:38:59 INFO - 'LOGNAME': 'cltbld', 16:38:59 INFO - 'MAIL': '/var/mail/cltbld', 16:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:59 INFO - 'MOZ_NO_REMOTE': '1', 16:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:59 INFO - 'NO_EM_RESTART': '1', 16:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:59 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:59 INFO - 'SHELL': '/bin/bash', 16:38:59 INFO - 'SHLVL': '1', 16:38:59 INFO - 'TERM': 'linux', 16:38:59 INFO - 'TMOUT': '86400', 16:38:59 INFO - 'USER': 'cltbld', 16:38:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', 16:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:59 INFO - '_': '/tools/buildbot/bin/python'} 16:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:38:59 INFO - Running setup.py (path:/tmp/pip-sU0r0F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:38:59 INFO - Running setup.py (path:/tmp/pip-6WFo4R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:38:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:38:59 INFO - Running setup.py (path:/tmp/pip-xvE43r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:39:00 INFO - Running setup.py (path:/tmp/pip-1stngn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:39:00 INFO - Running setup.py (path:/tmp/pip-iHXszf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:39:00 INFO - Running setup.py (path:/tmp/pip-4_0atz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:39:00 INFO - Running setup.py (path:/tmp/pip-nWT1Cb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:39:00 INFO - Running setup.py (path:/tmp/pip-as9Fpy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:39:00 INFO - Running setup.py (path:/tmp/pip-pzkNNh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:39:00 INFO - Running setup.py (path:/tmp/pip-nowfw1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:39:00 INFO - Running setup.py (path:/tmp/pip-uW76Uh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:39:00 INFO - Running setup.py (path:/tmp/pip-bWVua_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:39:00 INFO - Running setup.py (path:/tmp/pip-Zo_KP7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:39:00 INFO - Running setup.py (path:/tmp/pip-VtWbCE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:39:00 INFO - Running setup.py (path:/tmp/pip-onaMFg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:39:00 INFO - Running setup.py (path:/tmp/pip-sidTSi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:39:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:39:00 INFO - Running setup.py (path:/tmp/pip-ys5u6c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:39:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:39:01 INFO - Running setup.py install for manifestparser 16:39:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:39:01 INFO - Running setup.py install for mozcrash 16:39:01 INFO - Running setup.py install for mozdebug 16:39:01 INFO - Running setup.py install for mozdevice 16:39:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:39:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:39:01 INFO - Running setup.py install for mozfile 16:39:01 INFO - Running setup.py install for mozhttpd 16:39:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:39:01 INFO - Running setup.py install for mozinfo 16:39:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:39:01 INFO - Running setup.py install for mozInstall 16:39:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:39:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:39:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:39:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:39:01 INFO - Running setup.py install for mozleak 16:39:01 INFO - Running setup.py install for mozlog 16:39:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:39:02 INFO - Running setup.py install for moznetwork 16:39:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:39:02 INFO - Running setup.py install for mozprocess 16:39:02 INFO - Running setup.py install for mozprofile 16:39:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:39:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:39:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:39:02 INFO - Running setup.py install for mozrunner 16:39:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:39:02 INFO - Running setup.py install for mozscreenshot 16:39:02 INFO - Running setup.py install for moztest 16:39:02 INFO - Running setup.py install for mozversion 16:39:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:39:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:39:02 INFO - Cleaning up... 16:39:02 INFO - Return code: 0 16:39:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:39: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')]} 16:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39: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')]} 16:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:02 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 0x7f31f5300f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1269600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f8350>, '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 0x12f9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f96e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', '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 16:39:02 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 16:39:02 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 16:39:02 INFO - Using env: {'DISPLAY': ':0', 16:39:02 INFO - 'HOME': '/home/cltbld', 16:39:02 INFO - 'LANG': 'en_US.UTF-8', 16:39:02 INFO - 'LANGUAGE': 'en_US:en', 16:39:02 INFO - 'LOGNAME': 'cltbld', 16:39:02 INFO - 'MAIL': '/var/mail/cltbld', 16:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:02 INFO - 'MOZ_NO_REMOTE': '1', 16:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:02 INFO - 'NO_EM_RESTART': '1', 16:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:39:02 INFO - 'PWD': '/builds/slave/test-pgo', 16:39:02 INFO - 'SHELL': '/bin/bash', 16:39:02 INFO - 'SHLVL': '1', 16:39:02 INFO - 'TERM': 'linux', 16:39:02 INFO - 'TMOUT': '86400', 16:39:02 INFO - 'USER': 'cltbld', 16:39:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', 16:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:02 INFO - '_': '/tools/buildbot/bin/python'} 16:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:39:03 INFO - Running setup.py (path:/tmp/pip-dmZpjf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:39:03 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)) 16:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:39:03 INFO - Running setup.py (path:/tmp/pip-c64n9D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:39:03 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)) 16:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:39:03 INFO - Running setup.py (path:/tmp/pip-8OeaTJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:39:03 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)) 16:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:39:03 INFO - Running setup.py (path:/tmp/pip-R4rOTQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 16:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:39:03 INFO - Running setup.py (path:/tmp/pip-nbFu4H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:39:03 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)) 16:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:39:03 INFO - Running setup.py (path:/tmp/pip-jWKBqK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:39:03 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)) 16:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:39:03 INFO - Running setup.py (path:/tmp/pip-JotRYi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:39:03 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)) 16:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:39:03 INFO - Running setup.py (path:/tmp/pip-AoHgnc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:39:03 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)) 16:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:39:03 INFO - Running setup.py (path:/tmp/pip-guTbm8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:39:03 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)) 16:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:39:03 INFO - Running setup.py (path:/tmp/pip-gUGEsM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:39:03 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)) 16:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:39:03 INFO - Running setup.py (path:/tmp/pip-HxT57u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:39:03 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)) 16:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:39:03 INFO - Running setup.py (path:/tmp/pip-yzNCSV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:39:03 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)) 16:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:39:03 INFO - Running setup.py (path:/tmp/pip-rLhG9f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 16:39:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:39:04 INFO - Running setup.py (path:/tmp/pip-v_SiRn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:39:04 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)) 16:39:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:39:04 INFO - Running setup.py (path:/tmp/pip-G4A51M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:39:04 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)) 16:39:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:39:04 INFO - Running setup.py (path:/tmp/pip-x6l1Pu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:39:04 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)) 16:39:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:39:04 INFO - Running setup.py (path:/tmp/pip-7nIoP4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:39:04 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)) 16:39:04 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)) 16:39:04 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)) 16:39:04 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)) 16:39:04 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:39:04 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:39:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:39: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 16:39: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 16:39: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 16:39: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 16:39: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 16:39: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 16:39:06 INFO - Downloading blessings-1.6.tar.gz 16:39:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:39:06 INFO - Installing collected packages: blessings 16:39:06 INFO - Running setup.py install for blessings 16:39:06 INFO - Successfully installed blessings 16:39:06 INFO - Cleaning up... 16:39:06 INFO - Return code: 0 16:39:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:39:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:39:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:39:06 INFO - Reading from file tmpfile_stdout 16:39:06 INFO - Current package versions: 16:39:06 INFO - argparse == 1.2.1 16:39:06 INFO - blessings == 1.6 16:39:06 INFO - blobuploader == 1.2.4 16:39:06 INFO - docopt == 0.6.1 16:39:06 INFO - manifestparser == 1.1 16:39:06 INFO - mozInstall == 1.12 16:39:06 INFO - mozcrash == 0.16 16:39:06 INFO - mozdebug == 0.1 16:39:06 INFO - mozdevice == 0.47 16:39:06 INFO - mozfile == 1.2 16:39:06 INFO - mozhttpd == 0.7 16:39:06 INFO - mozinfo == 0.9 16:39:06 INFO - mozleak == 0.1 16:39:06 INFO - mozlog == 3.1 16:39:06 INFO - moznetwork == 0.27 16:39:06 INFO - mozprocess == 0.22 16:39:06 INFO - mozprofile == 0.27 16:39:06 INFO - mozrunner == 6.11 16:39:06 INFO - mozscreenshot == 0.1 16:39:06 INFO - mozsystemmonitor == 0.0 16:39:06 INFO - moztest == 0.7 16:39:06 INFO - mozversion == 1.4 16:39:06 INFO - psutil == 3.1.1 16:39:06 INFO - requests == 1.2.3 16:39:06 INFO - wsgiref == 0.1.2 16:39:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:06 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 0x7f31f5300f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1269600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f8350>, '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 0x12f9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f96e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', '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 16:39:06 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 16:39:06 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 16:39:06 INFO - Using env: {'DISPLAY': ':0', 16:39:06 INFO - 'HOME': '/home/cltbld', 16:39:06 INFO - 'LANG': 'en_US.UTF-8', 16:39:06 INFO - 'LANGUAGE': 'en_US:en', 16:39:06 INFO - 'LOGNAME': 'cltbld', 16:39:06 INFO - 'MAIL': '/var/mail/cltbld', 16:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:06 INFO - 'MOZ_NO_REMOTE': '1', 16:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:06 INFO - 'NO_EM_RESTART': '1', 16:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:39:06 INFO - 'PWD': '/builds/slave/test-pgo', 16:39:06 INFO - 'SHELL': '/bin/bash', 16:39:06 INFO - 'SHLVL': '1', 16:39:06 INFO - 'TERM': 'linux', 16:39:06 INFO - 'TMOUT': '86400', 16:39:06 INFO - 'USER': 'cltbld', 16:39:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', 16:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:06 INFO - '_': '/tools/buildbot/bin/python'} 16:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:06 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 1)) 16:39:06 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 2)) 16:39:06 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 3)) 16:39:06 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 4)) 16:39:06 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 5)) 16:39:06 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 6)) 16:39:06 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 7)) 16:39:06 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 8)) 16:39:06 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:39:06 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 3)) 16:39:06 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:39:06 INFO - Cleaning up... 16:39:06 INFO - Return code: 0 16:39:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31f5300f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1269600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f8350>, '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 0x12f9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f96e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', '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 16:39:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:39:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:39:06 INFO - Using env: {'DISPLAY': ':0', 16:39:06 INFO - 'HOME': '/home/cltbld', 16:39:06 INFO - 'LANG': 'en_US.UTF-8', 16:39:06 INFO - 'LANGUAGE': 'en_US:en', 16:39:06 INFO - 'LOGNAME': 'cltbld', 16:39:06 INFO - 'MAIL': '/var/mail/cltbld', 16:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:06 INFO - 'MOZ_NO_REMOTE': '1', 16:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:06 INFO - 'NO_EM_RESTART': '1', 16:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:39:06 INFO - 'PWD': '/builds/slave/test-pgo', 16:39:06 INFO - 'SHELL': '/bin/bash', 16:39:06 INFO - 'SHLVL': '1', 16:39:06 INFO - 'TERM': 'linux', 16:39:06 INFO - 'TMOUT': '86400', 16:39:06 INFO - 'USER': 'cltbld', 16:39:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', 16:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:06 INFO - '_': '/tools/buildbot/bin/python'} 16:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:06 INFO - Downloading/unpacking jsonschema 16:39:06 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 16:39:06 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 16:39:06 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 16:39:06 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 16:39:06 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 16:39:06 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 16:39:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:39:08 INFO - Downloading/unpacking functools32 (from jsonschema) 16:39:08 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 16:39:08 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 16:39:08 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 16:39:08 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 16:39:08 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 16:39:08 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 16:39:08 INFO - Downloading functools32-3.2.3-2.tar.gz 16:39:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:39:09 INFO - warning: no files found matching '*.txt' 16:39:09 INFO - no previously-included directories found matching 'build' 16:39:09 INFO - no previously-included directories found matching 'dist' 16:39:09 INFO - no previously-included directories found matching '.git*' 16:39:09 INFO - Installing collected packages: jsonschema, functools32 16:39:09 INFO - Running setup.py install for functools32 16:39:09 INFO - warning: no files found matching '*.txt' 16:39:09 INFO - no previously-included directories found matching 'build' 16:39:09 INFO - no previously-included directories found matching 'dist' 16:39:09 INFO - no previously-included directories found matching '.git*' 16:39:09 INFO - Successfully installed jsonschema functools32 16:39:09 INFO - Cleaning up... 16:39:09 INFO - Return code: 0 16:39:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:39:09 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')]} 16:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:09 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')]} 16:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:09 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 0x7f31f5300f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1269600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f8350>, '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 0x12f9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f96e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', '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 16:39:09 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 16:39:09 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 16:39:09 INFO - Using env: {'DISPLAY': ':0', 16:39:09 INFO - 'HOME': '/home/cltbld', 16:39:09 INFO - 'LANG': 'en_US.UTF-8', 16:39:09 INFO - 'LANGUAGE': 'en_US:en', 16:39:09 INFO - 'LOGNAME': 'cltbld', 16:39:09 INFO - 'MAIL': '/var/mail/cltbld', 16:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:09 INFO - 'MOZ_NO_REMOTE': '1', 16:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:09 INFO - 'NO_EM_RESTART': '1', 16:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:39:09 INFO - 'PWD': '/builds/slave/test-pgo', 16:39:09 INFO - 'SHELL': '/bin/bash', 16:39:09 INFO - 'SHLVL': '1', 16:39:09 INFO - 'TERM': 'linux', 16:39:09 INFO - 'TMOUT': '86400', 16:39:09 INFO - 'USER': 'cltbld', 16:39:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', 16:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:09 INFO - '_': '/tools/buildbot/bin/python'} 16:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:09 INFO - Downloading/unpacking flake8 16:39:09 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 16:39:09 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 16:39:09 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 16:39:09 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 16:39:09 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 16:39:09 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 16:39:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:39:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:39:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:39:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:39:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:39:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:39:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:39:11 INFO - no previously-included directories found matching 'docs/_build' 16:39:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:39:12 INFO - Running setup.py install for pep8 16:39:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:39:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:39:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:39:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:39:12 INFO - no previously-included directories found matching 'docs/_build' 16:39:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:39:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:39:12 INFO - Cleaning up... 16:39:12 INFO - Return code: 0 16:39:12 INFO - Running post-action listener: _resource_record_post_action 16:39:12 INFO - Running post-action listener: _start_resource_monitoring 16:39:12 INFO - Starting resource monitoring. 16:39:12 INFO - ##### 16:39:12 INFO - ##### Running install step. 16:39:12 INFO - ##### 16:39:12 INFO - Running pre-action listener: _resource_record_pre_action 16:39:12 INFO - Running main action method: install 16:39:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:39:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:39:12 INFO - Reading from file tmpfile_stdout 16:39:12 INFO - Detecting whether we're running mozinstall >=1.0... 16:39:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:39:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:39:12 INFO - Reading from file tmpfile_stdout 16:39:12 INFO - Output received: 16:39:12 INFO - Usage: mozinstall [options] installer 16:39:12 INFO - Options: 16:39:12 INFO - -h, --help show this help message and exit 16:39:12 INFO - -d DEST, --destination=DEST 16:39:12 INFO - Directory to install application into. [default: 16:39:12 INFO - "/builds/slave/test-pgo"] 16:39:12 INFO - --app=APP Application being installed. [default: firefox] 16:39:12 INFO - mkdir: /builds/slave/test-pgo/build/application 16:39:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:39:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:39:27 INFO - Reading from file tmpfile_stdout 16:39:27 INFO - Output received: 16:39:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:39:27 INFO - Running post-action listener: _resource_record_post_action 16:39:27 INFO - ##### 16:39:27 INFO - ##### Running run-tests step. 16:39:27 INFO - ##### 16:39:27 INFO - Running pre-action listener: _resource_record_pre_action 16:39:27 INFO - Running main action method: run_tests 16:39:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:39:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:39:27 INFO - Python 2.7.3 16:39:27 INFO - Return code: 0 16:39:27 INFO - grabbing minidump binary from tooltool 16:39:27 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')]} 16:39:27 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 0x12f8350>, '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 0x12f9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f96e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:39:27 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 16:39:27 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 16:39:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:39:27 INFO - Return code: 0 16:39:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:39:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:39:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:39:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:39:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:39:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:39:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:39:28 INFO - Return code: 0 16:39:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:39:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost 16:39:28 INFO - Using env: {'DISPLAY': ':0', 16:39:28 INFO - 'HOME': '/home/cltbld', 16:39:28 INFO - 'LANG': 'en_US.UTF-8', 16:39:28 INFO - 'LANGUAGE': 'en_US:en', 16:39:28 INFO - 'LOGNAME': 'cltbld', 16:39:28 INFO - 'MAIL': '/var/mail/cltbld', 16:39:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:39:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:28 INFO - 'MOZ_NO_REMOTE': '1', 16:39:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:39:28 INFO - 'NO_EM_RESTART': '1', 16:39:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:39:28 INFO - 'PWD': '/builds/slave/test-pgo', 16:39:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:39:28 INFO - 'SHELL': '/bin/bash', 16:39:28 INFO - 'SHLVL': '1', 16:39:28 INFO - 'TERM': 'linux', 16:39:28 INFO - 'TMOUT': '86400', 16:39:28 INFO - 'USER': 'cltbld', 16:39:28 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871', 16:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:28 INFO - '_': '/tools/buildbot/bin/python'} 16:39:28 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] with output_timeout 3600 16:39:28 INFO - mozversion INFO | application_buildid: 20160218141425 16:39:28 INFO - mozversion INFO | application_changeset: 811cb8884a03ddd1d3b722b8b37590d4ca53fe61 16:39:28 INFO - mozversion INFO | application_display_name: Nightly 16:39:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:39:28 INFO - mozversion INFO | application_name: Firefox 16:39:28 INFO - mozversion INFO | application_remotingname: firefox 16:39:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:39:28 INFO - mozversion INFO | application_vendor: Mozilla 16:39:28 INFO - mozversion INFO | application_version: 45.0 16:39:28 INFO - mozversion INFO | platform_buildid: 20160218141425 16:39:28 INFO - mozversion INFO | platform_changeset: 811cb8884a03ddd1d3b722b8b37590d4ca53fe61 16:39:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:39:28 INFO - mozversion INFO | platform_version: 45.0 16:39:28 INFO - 2016-02-18 16:39:28,485 DEBUG : using testdate: 1455842368 16:39:28 INFO - 2016-02-18 16:39:28,485 DEBUG : actual date: 1455842368 16:39:28 INFO - 2016-02-18 16:39:28,494 INFO : starting webserver on 'localhost:44364' 16:39:28 INFO - 2016-02-18 16:39:28,495 INFO : Starting test suite talos-linux64-ix-019 16:39:28 INFO - 2016-02-18 16:39:28,495 INFO : Starting test dromaeo_css 16:39:28 INFO - 2016-02-18 16:39:28,495 DEBUG : operating with platform_type : linux_ 16:39:28 INFO - 2016-02-18 16:39:28,496 INFO : Initialising browser for dromaeo_css test... 16:39:28 INFO - 2016-02-18 16:39:28,512 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_8Wf9x/profile http://localhost:44364/getInfo.html 16:39:32 INFO - 2016-02-18 16:39:32,676 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:39:32 INFO - 2016-02-18 16:39:32,676 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:39:32 INFO - 2016-02-18 16:39:32,676 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:39:32 INFO - 2016-02-18 16:39:32,676 DEBUG : BROWSER_OUTPUT: __metrics 16:39:32 INFO - 2016-02-18 16:39:32,885 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:39:34 INFO - 2016-02-18 16:39:34,070 INFO : Browser initialized. 16:39:34 INFO - 2016-02-18 16:39:34,070 INFO : Running cycle 1/1 for dromaeo_css test... 16:39:34 INFO - 2016-02-18 16:39:34,071 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_8Wf9x/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:39:45 INFO - 2016-02-18 16:39:45,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 133226496 16:39:45 INFO - 2016-02-18 16:39:45,724 DEBUG : BROWSER_OUTPUT: 16:40:36 INFO - 2016-02-18 16:40:36,478 DEBUG : BROWSER_OUTPUT: 1455842436477 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] 16:42:44 INFO - 2016-02-18 16:42:44,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44364/tests/dromaeo/cssquery-ext.html) 16:42:45 INFO - 2016-02-18 16:42:45,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 237289472 16:42:45 INFO - 2016-02-18 16:42:45,903 DEBUG : BROWSER_OUTPUT: 16:45:47 INFO - 2016-02-18 16:45:47,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/dromaeo/cssquery-ext.html (next: http://localhost:44364/tests/dromaeo/cssquery-jquery.html) 16:45:48 INFO - 2016-02-18 16:45:48,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 213696512 16:45:48 INFO - 2016-02-18 16:45:48,557 DEBUG : BROWSER_OUTPUT: 16:48:50 INFO - 2016-02-18 16:48:50,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44364/tests/dromaeo/cssquery-mootools.html) 16:48:50 INFO - 2016-02-18 16:48:50,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 208003072 16:48:50 INFO - 2016-02-18 16:48:50,884 DEBUG : BROWSER_OUTPUT: 16:51:52 INFO - 2016-02-18 16:51:52,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44364/tests/dromaeo/cssquery-prototype.html) 16:51:53 INFO - 2016-02-18 16:51:53,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 203706368 16:51:53 INFO - 2016-02-18 16:51:53,185 DEBUG : BROWSER_OUTPUT: 16:54:55 INFO - 2016-02-18 16:54:55,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44364/tests/dromaeo/cssquery-yui.html) 16:54:55 INFO - 2016-02-18 16:54:55,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 202555392 16:54:55 INFO - 2016-02-18 16:54:55,962 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-02-18 16:57:58,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/dromaeo/cssquery-yui.html (next: http://localhost:44364/tests/dromaeo/cssquery-dojo.html) 16:57:58 INFO - 2016-02-18 16:57:58,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 229793792 16:57:58 INFO - 2016-02-18 16:57:58,483 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-02-18 16:57:58,484 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:57:58 INFO - 2016-02-18 16:57:58,485 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:57:58 INFO - 2016-02-18 16:57:58,485 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:57:58 INFO - 2016-02-18 16:57:58,485 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:57:58 INFO - 2016-02-18 16:57:58,486 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3315.867365305387;3379.5437615921874;3416.385050690875;3423.5891692996843;3431.931361372772;5537.307836520435;5545.916811247829;5587.161925711145;5599.0201714699915;5607.831765047045;5594.636348637346;5611.775528978836;5613.045782217023;5620.185073164399;5622.269105016342;4822.590079843218;5067.543921047096;5112.8977420451565;5162.457941916101;5202.219667049935;4930.556249937505;5033.295338652591;5101.107306221396;5101.234814777795;5102.668326558781;5003.549680528752;5079.873003174913;5107.438181799999;5111.591072714193;5147.073526765181;5119.027384796896;5161.200013997799;5171.301874246966;5171.5862730981435;5201.765920533585;4899.58353539946;4902.950970490285;4994.375703037121;5076.340075790161;5079.314292570492;5320.148776195829;5373.650712703701;5375.220593013991;5406.810761623364;5420.756065977041;5893.086571581412;5899.46904778572;5959.642421454727;5967;5973.611715238539;5697;5806.883862322772;5943.138244954501;6007.249093863267;6036.9396306036815;5562.054450743383;5616.775328986836;5622.522085622686;5622.971885140589;5625.746841392106;6076.179715738319;6096.939030609726;6097;6108.633481991094;6116.480099191618;5668.744906479218;5762.164486149485;5804.854878628068;5868.589198756046;5933.910991335133;5974.910376344358;5982.461578457873;5984.311804142492;5987.550933679991;5988.431099045583;5524.14375771756;5949.762009519571;5959.463648271676;5969.343372229051;5970.641761494324;5761.366249712528;5866.970665146647;5974.880502389928;5975.133605627159;6012.098185272157;4556.908861822745;4589.977050114728;4592.609628181575;4599.425071866017;4616.192166370939;4009.298372784751;4092.386142078712;4131.462909821764;4132.090939993197;4135.937960930589;5502.504774570308;5582.581306401955;5611.607187496836;5612.579056570774;5649.180868774005;6041.607295525777;6070.332263451017;6070.514358851281;6071.878562428727;6075.787347442818;5473.425290344457;5585.609007369445;5598.300212473441;5738.598298119092;5746.195532625436;5034.748262586856;5049.31834202378;5056.772445239973;5058.772355244023;5073.797048118107;6109;6115.388461153849;6120.387961203844;6126.632402055801;6140.938590614037;5747.252857128547;5863.970680146572;5943.049112142036;6013.037913933749;6071.392860713893;6179.876402472015;6240.500759939103;6243.8126856194385;6244.750209991549;6257.812265632038;5960.761569537343;6023.297660763442;6023.879522409615;6025.849353766191;6063.696815159313;5674.914876276776;5844.094165404369;5953.404659534185;6052.576319657582;6058.212432383762;5814.738336774771;5814.912776308274;5818.796342128175;5832.096025116114;5896.823095307148;5630.577706671934;5795.043817770021;5811.535077193899;5821.912671309849;5829.59192856513;5631.493165615114;5714.828555143353;5789.131630255495;5791.247137872218;5815.3893841147765;5799.2750906136735;5826.970865145647;5831.533477321889;5833.67914764692;5837.562182836219;5512.531434827924;5639.041362968223;5785.190073389645;5793.131030345482;5796.76812927495 16:57:58 INFO - 2016-02-18 16:57:58,490 DEBUG : BROWSER_OUTPUT: |1;ext.html;592.9229200203973;623.2583225961106;627.2410383436043;627.4102343796831;637.5791977294987;28254.71745282549;42577.78711106444;42587.78706106465;42653.36019959703;42713.57286427135;47237.76381118098;47783;47863.76068119663;47900.281495777504;48141.75929120358;7825.452218344718;7896.486728362666;7910;9101.226395756368;9329.300302477308;11027.117830573536;11313.264637798558;11316.886831131707;11328.886711132907;11332.09343252542;10957;11006.119510439146;11051.336919784799;11060.778784424347;11063.446827658625;10925.125989920787;11006.119510439146;11026.669199924016;11031.558737650485;11031.613893513728;10714.089302409304;10874.401907895062;10886.40124793136;10886.67339979802;10888.237823352369;44385.77807110976;44756.77621611871;44780.3282950756;44820;44898.77550612258;3650.2699460108083;3751.8311675974373;3766.773993560395;3860.4595356650093;4041.6362527372676;32918.835405823054;33930.1517462063;34287;34311.31377372439;34975.30049398998;4189.434426352434;4248.171606536726;4275.102228532012;4316.460442444694;4356.869293921188;295274;297599;298470;298584;299006;57221;58101;58755;72977;74577;66166.33833661601;66207.66896165488;66237.33762662408;66314;66452.66773666101;15953.760693589606;15999.760003599955;16090.436834710963;16113.838861611468;16131.354745810271;12628.242305461701;12630.621081367573;12640.051996100145;12684.23894566329;12748.936255318664;22334;22564.887175564018;22601;22638.320850374515;22698.773012269998;7903.881441778378;7913.723019694398;7963.124056353797;7994.1606131355375;8153.836923261501;957.9089986451276;1049.7218237167158;1083.3770581915273;1112.872019717743;1115.4144074360863;30090.84954575213;30255.69744302529;31309;33002.83498582492;33123.50314745281;1068.2682362581656;1162.2503485252134;1181.6809461445534;1217.0689422591724;1234.8394708687813;13079;15118.924405377902;15225.086494810346;15295.388184472718;15459;384738;393155;394060;395137;395212;54278.728606356715;55693.164602531;55758.16362754562;55853.44146558482;56099.439005610235;1284.794432890733;1357.640225340266;1414.589768966988;1460.6567456647679;1480.6002379357512;27333.72666273312;27346.726532735214;27534.72465275402;27701.722982769916;27784.44431111326;43388.34917476177;43622.56377436185;43782.34326485169;43865;43900.56099439092;235145;237386;237837;237999;238115;35891.820540897126;36651.816740916125;36799.816000919825;36810.447843281836;36870.07824804294;47367;47404.288935666686;48260.7586962077;48416;48469.27296090632;39804.800975994935;40664;40675.79662101671;40717.59282407138;41202.79398602988;40100;40304.79847600743;40647.39028914509;41387;41467.7926610365;39699.007524812114;40358.1928361437;40628.39057414082;40911.7954410226;40930.386044209954;35252.29495410026;36263.27473450569;36471;37002;37220.44169337408;27672.861635691694;27709.168724938285;27775.583366249117;27839.721602783713;28201.57697634496 16:57:58 INFO - 2016-02-18 16:57:58,490 DEBUG : BROWSER_OUTPUT: |2;jquery.html;372.8415423445037;375.04787580642756;375.9567649720281;382.9061879839439;383.38466760848837;14835.332410041547;16541;16820.915895420538;18056.819431805696;18136.365227217033;17006.659866802656;17168.484945451626;17237.482875513753;17251;17448.30206791727;4180.707350485467;5486.149646804742;5616.297962754656;5616.887662246752;5620;4193.979030104845;6101.725422355982;6261.624302541839;6272.372762723737;6277.1839660844025;5933.792317268896;6047.697615119227;6155.292141403729;6196.256449226099;6196.318404975449;6043.7280322385595;6049.969750151221;6056.424639659225;6062.787802426916;6072.30168530618;5324.92012619811;5396.217548455491;5433.293671822637;5447.12845944647;5447.591430642718;11541.480633371519;11583.420828958519;12457.1902826316;12624.305663188521;12841.614751557468;2202.559488102386;2251.7748225177515;2332.2420213430532;2443.511297740441;2469.086438017945;9869.753256168582;10139.493025348704;10247.333923294962;11152.996230339308;13910.443582256697;1910.9713354299697;1914.904254787255;1915.3200613782185;1931.652302585534;1948.3375652278294;62463.37536624666;63450;63560;64872.02691959625;65437.67281163564;10384.42885641297;10484.21368397358;10514.21143414247;10528.894711052792;10548.314359566604;13512.324383780771;13553.796693049611;13556.864431355758;13604.251766152956;13607.931960340135;7111.751088711871;7120;7263.527870688388;7417.072865891763;7496.212897645669;6927.445804335641;6951.0616066830335;6967.93032069683;7034.92965070353;7066.540674856118;4185.748855068706;4305.354196870495;4407.493138289074;4479.843205487858;4511.390962220124;1801.828826261503;1819.4905426480607;1833.8899666020081;1870.307986045172;1875.915583798705;851.7529916324321;991.826430374696;1008.4503945349802;1014.8274793285159;1016.983016983017;16222.83777162237;16362.345506179858;16689.749653755203;16812.411565595146;17629.559261018578;924.6347692661361;952.6332362040664;952.9618815247451;957.5499515227832;984.8030393921101;7836.568988705676;9517.524123793783;9566.473843938651;10298.845517317246;10313.639022634172;649051;651175;662991;665806;667918;79020.60489697514;79566;86660.56669716611;87680;88243.55878220568;1204.277433539869;1210.4734440518403;1210.8970737487411;1226.4542278686079;1241.4351470081092;15232.543023709306;15656.295466703798;15949.760753588938;16456.177191140636;16482.01107933528;35430.29139417249;36079.45880811843;36916.26167476582;37641.247175055796;37794;44703.55296446994;45158.54841451543;46238.76880615576;46379.76810115928;47396.52603474059;9762;9823.754406139904;9893.703188904345;9984.500774961369;10221.74445638865;17888.373906913195;18477;18990.715139273198;18995.05024748785;19025.42923712291;14774.778378324549;15067.171305578298;15131.319090641167;15381.923090384476;15851.682966340839;14695.265236737907;15069;15199.392024318904;15285.6178595536;15837.366505339658;15572.532824015298;15718.292676829798;15823.129727865078;15869.12719800422;16241.187940603158;8352.290055345364;9548.379355342158;9776.462294573583;9855.556499957662;9865.802683946424;10184.898151018395;14076.296185190904;14296.213708246147;14327.283635818376;14349.63231066904 16:57:58 INFO - 2016-02-18 16:57:58,491 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1493.8506149385057;1761.1106391272408;1795.349895394903;1834.7247912813084;1841.0518582929785;7613.7335193268245;7827.765167044983;7830.451868369223;7836.981192444974;7859.882101768478;6753.459723222143;6889.517733758639;7215.747448839292;7338.706451741938;7667.309942105209;2200.3618950504333;2216.5788500184913;2237.7314722233355;2237.9216727414546;2241.506868488938;2003.4891102768847;2258.446680563256;2299.3331933739196;2304.2626359564947;2307.0195167054017;1939.4181745476371;2191.8904054797194;2255.357223191391;2260.819134469247;2263.196565219348;2168.0352243251837;2201.482651576878;2204.0302267002626;2205.6250437425674;2212.026708248374;2228.342638921522;2242.5178586603797;2254.9323520294415;2255.1881322723807;2257.7403598586206;7571.3942884569105;7625.923740762632;7630.961845190794;7631.847363052763;7639.236076392372;4577.176108300505;4638.814447422099;4658.557437043475;4662.230731929228;4664.323673067386;2942.1173647905543;2943.0729320264263;2980.7019298070236;2989.61135052444;3028.8939887104066;989.2185173712759;995.1988649137442;1049.2759995603085;1086.4459125845797;1090.5855774805602;10376.65103536543;10381.42902140382;10386.584536618602;10389.27275090744;10405;4029.7783621901076;4074.8573799916862;4078.836846526165;4131.338985762263;4131.855385061508;8892.555372231363;8919.42023768453;8933.776655583662;8936.32977526688;8945.329100317373;4610.1471227822285;4633.142868569325;4651.162790697639;4652.790624421909;4652.790624421909;4239.491261048694;4242.703010789277;4253.064325848309;4254.127903779718;4256.638185754184;3554.4845997330244;3588.4258518637416;3595.7123430125525;3619.167591453928;3620.1673615068157;1078.962236321725;1091.2524920429373;1163.51714038673;1165.213480900389;1168.567629976914;906.1391677906016;1108.9500972456258;1125.7692173104494;1128.3737525673166;1132.2017977325966;6975.825604359931;7025.297470253036;7032.753853615099;7038;7038.753643622448;1127.0983213429388;1129.4804389980536;1165.1319766773809;1202.5971299614553;1216.0636310041396;5723.341815691166;5730;5807.88384232313;5808.30300363959;5812.476877081083;9020.774480637905;9313.767155821024;9314.48770317639;9317.534123293945;9347;9110.954445227864;9120.179183873483;9195.080491950885;9209.95395023034;9233.676821311356;7109.395701365338;7316.0489136411925;7364.668589913466;7371.3734332582335;7381.88927166093;7020.719171233093;7132.429405647639;7201.891971620535;7204.063471748639;7215.458840586872;8124;8405.453645513022;8412.495250285003;8473.66105355779;8481.151884811716;8370.916290837258;8430.030546487233;8480.703175388831;8559.400841941004;8564.871526927225;6579.671016449062;6614.437772789367;6616.206055273398;6618.569792963442;6630.270670226175;7400;7426.220246874001;7438.59087750179;7446;7452.813679658052;6174.166487524127;6793.558418702769;7009.7897063088185;7047.859042819013;7102.431805455448;6234.127222188988;6496.837579060561;6869.553479023847;6954.130733658293;6974.337437943387;7034.437245020488;7046.753363632249;7083;7083.114610673666;7085.539439936594;6011.639301641915;6031.185789918481;6042.395760423922;6042.456178943916;6042.486388656837;6159.414855588891;6167;6169.2288463942;6174.845628859314;6179.505639548735 16:57:58 INFO - 2016-02-18 16:57:58,493 DEBUG : BROWSER_OUTPUT: |4;prototype.html;318.7641145552292;323.0727811181907;325.9022293312006;332.7171903881699;333.7480202447152;6126.571140020201;6219.8134055978335;6223.751049958008;6267.247930248376;6275.7489700411925;6108.725107370168;6113.480354169889;6115.205023346959;6117.143599896007;6124.081387791834;4667.88330291742;4697.201475749113;4705.411823522059;4705.741184234866;4717.363155973934;4625.606823420013;4707.670463067587;4713.811447542112;4723.976380118094;4728.527147285278;4670.929936050962;4673.462551806551;4680.438347398317;4682.859514214579;4690.812367505296;4437.866863994085;4657.813687452498;4659.347691323217;4671.672982891182;4672.275797251432;3958.4656071430563;4079.73481723687;4128.071183983609;4135.276326642826;4141.482314710661;5834.241548598698;5858.5898987070495;5865.882682346371;5870.706464676749;5871.324797648283;5185.714785686786;5341.305630268041;5341.839744807662;5487.835364939058;5505.614606977513;6486.189226346707;6499.447546958514;6507.869842603169;6514.902276465857;6524.412802847766;4587.472440669332;4591.885202869921;4592.517785632527;4593.058423023273;4601.332806743037;6587.50593705474;6733.192016957947;6749.2238392584495;6749.628770417625;6756.729730810713;4711.52884711533;4717.599004084623;4722.6221902247735;4723.6929599575915;4725.716457012591;4778.856634300976;4780.49804770501;4787.928181077286;4788.473267940523;4797.4482934462985;5484;5491.36849262332;5493.807716729895;5502.449755024546;5503.642263252876;6463.612183269019;6536.934630653633;6557.901631475532;6558.770443034471;6575.243846957565;1659.4938543744274;1683.6127690631224;1686.5530634381898;1688.2909178145208;1690.3661127077346;1114.8550688410455;1120.7534342444812;1121.9439028048728;1131.8754936956927;1149.5516748468103;6372.7132279047555;6375.043743438521;6376.33048529907;6377.585456945284;6381.329960354096;6785.812482815488;6786.558873673195;6793.830154246183;6797.5581587196675;6799.218089919723;6258.718357673915;6376.234851817719;6376.808695739135;6379.457746091634;6383.521235907326;3674.926501469956;3713.591504934455;3715.2198038412234;3717.386631205821;3718.0890681783135;7044.119485064367;7052.188998265163;7060.152781666233;7060.54106483077;7068.646567671596;6902;7015.719371225094;7028.648567571601;7029.0862187915245;7032.8945065824055;7021.824454388681;7033.331833475811;7043.9647801761685;7045.577265363992;7051.717931282794;6874.690638921361;6875.690593923386;6876;6880.4839637026425;6880.5527640705195;6552.803415897531;6650.600963942179;6741.797746067429;6764.188297404343;6769.153855768029;6875.312468753084;7034.613096279753;7035.366816986496;7041.823954401181;7044.626297872071;4709.929351059805;4726.03116361152;4754.619630429488;4759.595434387978;4762.857114286577;6739.898901516383;6799.558028728117;6853.451723862178;6866.6566671667215;6869.793906182823;6634.270230274569;6670.499712521678;6670.599764014175;6671.799846004627;6680.966595166993;6648.0360347750275;6652.201735791736;6657.966710166418;6662.100616416916;6666;6425.742970281136;6544.934550654623;6545.312742162005;6559.442447391834;6563.868722625425;6646.102776125162;6659.167604049494;6660.267370589135;6663.633500157344;6667.099941507834;6515.934840651533;6528.445082168069;6541.364658835291;6544.640044797582;6548.050532672641 16:57:58 INFO - 2016-02-18 16:57:58,494 DEBUG : BROWSER_OUTPUT: |5;yui.html;833.1793183714041;839.5214727605263;841.2050612171497;916.5188276155018;960.1310813713592;13451.260180690058;15829.839962826209;16147.111908845009;16154.757678634829;16173.75739363909;14392.208428536427;14494.565163045125;14503.05730127541;14545.927270363632;14556.272186390665;701.9192792828813;709.8154479835229;837.7109897085511;850.7320194138857;850.961706723199;706.3889735378912;854.0008190417227;864.4813112132733;867.2411639815161;868.7741187291318;886.118312279283;892.5091199840094;898.7213963671251;900.995495022524;901.0178904993555;737.5242968285453;744.9979777199658;884.6903583745702;894.5884892949251;895.8118795053047;658.2397331082559;659.7789740436912;659.7855696898479;660.5442244851038;660.6234446365573;13930.37313320903;14235.928820355935;14337.56987290383;14371.281435928162;14388.784168237486;12175.93912030443;12628.558000470031;12843.678908027374;12940.547080852219;13240.271785051818;10775.137988960943;10882.727931801768;10902.890971090266;10963.725906852313;11168.218224724273;3848.65362117408;3857;3893.610638936084;3920.7059470539825;3935.940960885589;46427.53572464266;47490.525094748955;47846.76076619595;47924.04151916977;49638;9526;9773.951130244302;10022.949885250528;10031.097201251923;10041.497925103715;17703.911480442515;17888.821111788977;17899.10504474771;17934.91032544829;17974.5506362342;7686.385089192851;7831.921680783119;7916.722914697958;7920.168382319889;7961.243681850215;4574.268117101248;4614.077184563101;4630.606398456169;4646.767661616973;4655.138799322136;3218.275887925245;3229.0797122819886;3234.514822776602;3235.029491152645;3235.7573182010974;587.5886879184502;601.6239850093691;603.9939600604025;609.281048362936;612.3325575123138;691.4779341597063;706.5054461876707;712.9679164437613;719.133444199738;730.1092666946317;8385.538795366314;8645.221930026328;8664.653413863502;8839.955800221087;8928.196462318423;530.8168681804772;595.3778301674761;642.5309524047472;716.1012928774459;729.8394353242278;3798.4492248624347;3835.9041023974623;3915.7846318452757;3928.273269445162;4063.9796801015805;57858.421415785306;57859.71070144622;58306;58757.41242587519;58761.706191468766;51684.22473662898;54167.18749218765;54649.45350546444;55093.44906550963;55280.44719552834;51202.74398627983;53985.22103452799;54130.18804717933;55075.17387239195;55129.448705512434;8522.70170544028;8661.669165417292;8723.869141962748;8962.596683149404;8986.101389861224;36814.81592592127;36987.81506092452;37229.25541489209;40372.3944140844;41462.58537414587;48725.269120962505;49429.75285123551;49685.25472117849;50318.748406257735;50607.49392506028;10321.535530901278;10545.578176873147;10840.945795270973;11103.666889993314;11457.312561246352;12078.51685932553;12342.074344424025;12392.56626018085;12641.557545485864;12973.481060757464;10861.979582070733;11202.83195752048;11316.547338106384;11361.204715669825;11689.064874810165;10239;10409.583616655553;10783.191260655325;10854.728631784268;10856.294340867818;9645.517724113626;10014;10938.507767150339;11066.502007409525;11133.498992545517;9431.764205894908;9827.606895724377;9866.950665246628;9927.81854370054;10405.583776649151;8089.555074470961;8923.910760892308;8973.416727912665;9134.451932884049;9444.386114902509 16:57:58 INFO - 2016-02-18 16:57:58,494 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:57:58 INFO - 2016-02-18 16:57:58,494 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:57:58 INFO - 2016-02-18 16:57:58,494 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,804 16:57:58 INFO - 2016-02-18 16:57:58,494 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:57:58 INFO - 2016-02-18 16:57:58,494 DEBUG : BROWSER_OUTPUT: __startTimestamp1455843478483__endTimestamp 16:57:58 INFO - 2016-02-18 16:57:58,494 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-02-18 16:57:58,495 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:57:58 INFO - 2016-02-18 16:57:58,495 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:57:58 INFO - 2016-02-18 16:57:58,495 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-02-18 16:57:58,495 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5533.57 Median:5738.60 stddev:609.31 (10.6%) stddev-sans-first:585.82 16:57:58 INFO - 2016-02-18 16:57:58,496 DEBUG : BROWSER_OUTPUT: Values: 3315.9 3379.5 3416.4 3423.6 3431.9 5537.3 5545.9 5587.2 5599.0 5607.8 5594.6 5611.8 5613.0 5620.2 5622.3 4822.6 5067.5 5112.9 5162.5 5202.2 4930.6 5033.3 5101.1 5101.2 5102.7 5003.5 5079.9 5107.4 5111.6 5147.1 5119.0 5161.2 5171.3 5171.6 5201.8 4899.6 4903.0 4994.4 5076.3 5079.3 5320.1 5373.7 5375.2 5406.8 5420.8 5893.1 5899.5 5959.6 5967.0 5973.6 5697.0 5806.9 5943.1 6007.2 6036.9 5562.1 5616.8 5622.5 5623.0 5625.7 6076.2 6096.9 6097.0 6108.6 6116.5 5668.7 5762.2 5804.9 5868.6 5933.9 5974.9 5982.5 5984.3 5987.6 5988.4 5524.1 5949.8 5959.5 5969.3 5970.6 5761.4 5867.0 5974.9 5975.1 6012.1 4556.9 4590.0 4592.6 4599.4 4616.2 4009.3 4092.4 4131.5 4132.1 4135.9 5502.5 5582.6 5611.6 5612.6 5649.2 6041.6 6070.3 6070.5 6071.9 6075.8 5473.4 5585.6 5598.3 5738.6 5746.2 5034.7 5049.3 5056.8 5058.8 5073.8 6109.0 6115.4 6120.4 6126.6 6140.9 5747.3 5864.0 5943.0 6013.0 6071.4 6179.9 6240.5 6243.8 6244.8 6257.8 5960.8 6023.3 6023.9 6025.8 6063.7 5674.9 5844.1 5953.4 6052.6 6058.2 5814.7 5814.9 5818.8 5832.1 5896.8 5630.6 5795.0 5811.5 5821.9 5829.6 5631.5 5714.8 5789.1 5791.2 5815.4 5799.3 5827.0 5831.5 5833.7 5837.6 5512.5 5639.0 5785.2 5793.1 5796.8 16:57:58 INFO - 2016-02-18 16:57:58,496 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-02-18 16:57:58,496 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49795.44 Median:36725.82 stddev:82671.13 (225.1%) stddev-sans-first:82820.51 16:57:58 INFO - 2016-02-18 16:57:58,496 DEBUG : BROWSER_OUTPUT: Values: 592.9 623.3 627.2 627.4 637.6 28254.7 42577.8 42587.8 42653.4 42713.6 47237.8 47783.0 47863.8 47900.3 48141.8 7825.5 7896.5 7910.0 9101.2 9329.3 11027.1 11313.3 11316.9 11328.9 11332.1 10957.0 11006.1 11051.3 11060.8 11063.4 10925.1 11006.1 11026.7 11031.6 11031.6 10714.1 10874.4 10886.4 10886.7 10888.2 44385.8 44756.8 44780.3 44820.0 44898.8 3650.3 3751.8 3766.8 3860.5 4041.6 32918.8 33930.2 34287.0 34311.3 34975.3 4189.4 4248.2 4275.1 4316.5 4356.9 295274.0 297599.0 298470.0 298584.0 299006.0 57221.0 58101.0 58755.0 72977.0 74577.0 66166.3 66207.7 66237.3 66314.0 66452.7 15953.8 15999.8 16090.4 16113.8 16131.4 12628.2 12630.6 12640.1 12684.2 12748.9 22334.0 22564.9 22601.0 22638.3 22698.8 7903.9 7913.7 7963.1 7994.2 8153.8 957.9 1049.7 1083.4 1112.9 1115.4 30090.8 30255.7 31309.0 33002.8 33123.5 1068.3 1162.3 1181.7 1217.1 1234.8 13079.0 15118.9 15225.1 15295.4 15459.0 384738.0 393155.0 394060.0 395137.0 395212.0 54278.7 55693.2 55758.2 55853.4 56099.4 1284.8 1357.6 1414.6 1460.7 1480.6 27333.7 27346.7 27534.7 27701.7 27784.4 43388.3 43622.6 43782.3 43865.0 43900.6 235145.0 237386.0 237837.0 237999.0 238115.0 35891.8 36651.8 36799.8 36810.4 36870.1 47367.0 47404.3 48260.8 48416.0 48469.3 39804.8 40664.0 40675.8 40717.6 41202.8 40100.0 40304.8 40647.4 41387.0 41467.8 39699.0 40358.2 40628.4 40911.8 40930.4 35252.3 36263.3 36471.0 37002.0 37220.4 27672.9 27709.2 27775.6 27839.7 28201.6 16:57:58 INFO - 2016-02-18 16:57:58,496 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-02-18 16:57:58,496 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32466.32 Median:35754.88 stddev:107679.40 (301.2%) stddev-sans-first:107954.50 16:57:58 INFO - 2016-02-18 16:57:58,498 DEBUG : BROWSER_OUTPUT: Values: 372.8 375.0 376.0 382.9 383.4 14835.3 16541.0 16820.9 18056.8 18136.4 17006.7 17168.5 17237.5 17251.0 17448.3 4180.7 5486.1 5616.3 5616.9 5620.0 4194.0 6101.7 6261.6 6272.4 6277.2 5933.8 6047.7 6155.3 6196.3 6196.3 6043.7 6050.0 6056.4 6062.8 6072.3 5324.9 5396.2 5433.3 5447.1 5447.6 11541.5 11583.4 12457.2 12624.3 12841.6 2202.6 2251.8 2332.2 2443.5 2469.1 9869.8 10139.5 10247.3 11153.0 13910.4 1911.0 1914.9 1915.3 1931.7 1948.3 62463.4 63450.0 63560.0 64872.0 65437.7 10384.4 10484.2 10514.2 10528.9 10548.3 13512.3 13553.8 13556.9 13604.3 13607.9 7111.8 7120.0 7263.5 7417.1 7496.2 6927.4 6951.1 6967.9 7034.9 7066.5 4185.7 4305.4 4407.5 4479.8 4511.4 1801.8 1819.5 1833.9 1870.3 1875.9 851.8 991.8 1008.5 1014.8 1017.0 16222.8 16362.3 16689.7 16812.4 17629.6 924.6 952.6 953.0 957.5 984.8 7836.6 9517.5 9566.5 10298.8 10313.6 649051.0 651175.0 662991.0 665806.0 667918.0 79020.6 79566.0 86660.6 87680.0 88243.6 1204.3 1210.5 1210.9 1226.5 1241.4 15232.5 15656.3 15949.8 16456.2 16482.0 35430.3 36079.5 36916.3 37641.2 37794.0 44703.6 45158.5 46238.8 46379.8 47396.5 9762.0 9823.8 9893.7 9984.5 10221.7 17888.4 18477.0 18990.7 18995.1 19025.4 14774.8 15067.2 15131.3 15381.9 15851.7 14695.3 15069.0 15199.4 15285.6 15837.4 15572.5 15718.3 15823.1 15869.1 16241.2 8352.3 9548.4 9776.5 9855.6 9865.8 10184.9 14076.3 14296.2 14327.3 14349.6 16:57:58 INFO - 2016-02-18 16:57:58,498 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-02-18 16:57:58,498 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5354.32 Median:6042.47 stddev:2759.90 (45.7%) stddev-sans-first:2752.39 16:57:58 INFO - 2016-02-18 16:57:58,499 DEBUG : BROWSER_OUTPUT: Values: 1493.9 1761.1 1795.3 1834.7 1841.1 7613.7 7827.8 7830.5 7837.0 7859.9 6753.5 6889.5 7215.7 7338.7 7667.3 2200.4 2216.6 2237.7 2237.9 2241.5 2003.5 2258.4 2299.3 2304.3 2307.0 1939.4 2191.9 2255.4 2260.8 2263.2 2168.0 2201.5 2204.0 2205.6 2212.0 2228.3 2242.5 2254.9 2255.2 2257.7 7571.4 7625.9 7631.0 7631.8 7639.2 4577.2 4638.8 4658.6 4662.2 4664.3 2942.1 2943.1 2980.7 2989.6 3028.9 989.2 995.2 1049.3 1086.4 1090.6 10376.7 10381.4 10386.6 10389.3 10405.0 4029.8 4074.9 4078.8 4131.3 4131.9 8892.6 8919.4 8933.8 8936.3 8945.3 4610.1 4633.1 4651.2 4652.8 4652.8 4239.5 4242.7 4253.1 4254.1 4256.6 3554.5 3588.4 3595.7 3619.2 3620.2 1079.0 1091.3 1163.5 1165.2 1168.6 906.1 1109.0 1125.8 1128.4 1132.2 6975.8 7025.3 7032.8 7038.0 7038.8 1127.1 1129.5 1165.1 1202.6 1216.1 5723.3 5730.0 5807.9 5808.3 5812.5 9020.8 9313.8 9314.5 9317.5 9347.0 9111.0 9120.2 9195.1 9210.0 9233.7 7109.4 7316.0 7364.7 7371.4 7381.9 7020.7 7132.4 7201.9 7204.1 7215.5 8124.0 8405.5 8412.5 8473.7 8481.2 8370.9 8430.0 8480.7 8559.4 8564.9 6579.7 6614.4 6616.2 6618.6 6630.3 7400.0 7426.2 7438.6 7446.0 7452.8 6174.2 6793.6 7009.8 7047.9 7102.4 6234.1 6496.8 6869.6 6954.1 6974.3 7034.4 7046.8 7083.0 7083.1 7085.5 6011.6 6031.2 6042.4 6042.5 6042.5 6159.4 6167.0 6169.2 6174.8 6179.5 16:57:58 INFO - 2016-02-18 16:57:58,499 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-02-18 16:57:58,499 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5510.37 Median:6324.23 stddev:1665.63 (26.3%) stddev-sans-first:1624.08 16:57:58 INFO - 2016-02-18 16:57:58,499 DEBUG : BROWSER_OUTPUT: Values: 318.8 323.1 325.9 332.7 333.7 6126.6 6219.8 6223.8 6267.2 6275.7 6108.7 6113.5 6115.2 6117.1 6124.1 4667.9 4697.2 4705.4 4705.7 4717.4 4625.6 4707.7 4713.8 4724.0 4728.5 4670.9 4673.5 4680.4 4682.9 4690.8 4437.9 4657.8 4659.3 4671.7 4672.3 3958.5 4079.7 4128.1 4135.3 4141.5 5834.2 5858.6 5865.9 5870.7 5871.3 5185.7 5341.3 5341.8 5487.8 5505.6 6486.2 6499.4 6507.9 6514.9 6524.4 4587.5 4591.9 4592.5 4593.1 4601.3 6587.5 6733.2 6749.2 6749.6 6756.7 4711.5 4717.6 4722.6 4723.7 4725.7 4778.9 4780.5 4787.9 4788.5 4797.4 5484.0 5491.4 5493.8 5502.4 5503.6 6463.6 6536.9 6557.9 6558.8 6575.2 1659.5 1683.6 1686.6 1688.3 1690.4 1114.9 1120.8 1121.9 1131.9 1149.6 6372.7 6375.0 6376.3 6377.6 6381.3 6785.8 6786.6 6793.8 6797.6 6799.2 6258.7 6376.2 6376.8 6379.5 6383.5 3674.9 3713.6 3715.2 3717.4 3718.1 7044.1 7052.2 7060.2 7060.5 7068.6 6902.0 7015.7 7028.6 7029.1 7032.9 7021.8 7033.3 7044.0 7045.6 7051.7 6874.7 6875.7 6876.0 6880.5 6880.6 6552.8 6650.6 6741.8 6764.2 6769.2 6875.3 7034.6 7035.4 7041.8 7044.6 4709.9 4726.0 4754.6 4759.6 4762.9 6739.9 6799.6 6853.5 6866.7 6869.8 6634.3 6670.5 6670.6 6671.8 6681.0 6648.0 6652.2 6658.0 6662.1 6666.0 6425.7 6544.9 6545.3 6559.4 6563.9 6646.1 6659.2 6660.3 6663.6 6667.1 6515.9 6528.4 6541.4 6544.6 6548.1 16:57:58 INFO - 2016-02-18 16:57:58,499 DEBUG : BROWSER_OUTPUT: 16:57:58 INFO - 2016-02-18 16:57:58,499 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14466.47 Median:50002.00 stddev:17054.33 (34.1%) stddev-sans-first:17071.44 16:57:58 INFO - 2016-02-18 16:57:58,501 DEBUG : BROWSER_OUTPUT: Values: 833.2 839.5 841.2 916.5 960.1 13451.3 15829.8 16147.1 16154.8 16173.8 14392.2 14494.6 14503.1 14545.9 14556.3 701.9 709.8 837.7 850.7 851.0 706.4 854.0 864.5 867.2 868.8 886.1 892.5 898.7 901.0 901.0 737.5 745.0 884.7 894.6 895.8 658.2 659.8 659.8 660.5 660.6 13930.4 14235.9 14337.6 14371.3 14388.8 12175.9 12628.6 12843.7 12940.5 13240.3 10775.1 10882.7 10902.9 10963.7 11168.2 3848.7 3857.0 3893.6 3920.7 3935.9 46427.5 47490.5 47846.8 47924.0 49638.0 9526.0 9774.0 10022.9 10031.1 10041.5 17703.9 17888.8 17899.1 17934.9 17974.6 7686.4 7831.9 7916.7 7920.2 7961.2 4574.3 4614.1 4630.6 4646.8 4655.1 3218.3 3229.1 3234.5 3235.0 3235.8 587.6 601.6 604.0 609.3 612.3 691.5 706.5 713.0 719.1 730.1 8385.5 8645.2 8664.7 8840.0 8928.2 530.8 595.4 642.5 716.1 729.8 3798.4 3835.9 3915.8 3928.3 4064.0 57858.4 57859.7 58306.0 58757.4 58761.7 51684.2 54167.2 54649.5 55093.4 55280.4 51202.7 53985.2 54130.2 55075.2 55129.4 8522.7 8661.7 8723.9 8962.6 8986.1 36814.8 36987.8 37229.3 40372.4 41462.6 48725.3 49429.8 49685.3 50318.7 50607.5 10321.5 10545.6 10840.9 11103.7 11457.3 12078.5 12342.1 12392.6 12641.6 12973.5 10862.0 11202.8 11316.5 11361.2 11689.1 10239.0 10409.6 10783.2 10854.7 10856.3 9645.5 10014.0 10938.5 11066.5 11133.5 9431.8 9827.6 9867.0 9927.8 10405.6 8089.6 8923.9 8973.4 9134.5 9444.4 16:57:58 INFO - 2016-02-18 16:57:58,501 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:57:58 INFO - 2016-02-18 16:57:58,501 DEBUG : BROWSER_OUTPUT: 16:57:59 INFO - 2016-02-18 16:57:59,082 INFO : Browser exited with error code: 0 16:57:59 INFO - 2016-02-18 16:57:59,098 INFO : Completed test dromaeo_css (00:18:30) 16:57:59 INFO - 2016-02-18 16:57:59,098 INFO : Starting test kraken 16:57:59 INFO - 2016-02-18 16:57:59,098 DEBUG : operating with platform_type : linux_ 16:57:59 INFO - 2016-02-18 16:57:59,098 INFO : Initialising browser for kraken test... 16:57:59 INFO - 2016-02-18 16:57:59,104 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPoogzX/profile http://localhost:44364/getInfo.html 16:58:03 INFO - 2016-02-18 16:58:03,027 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:58:03 INFO - 2016-02-18 16:58:03,027 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:58:03 INFO - 2016-02-18 16:58:03,027 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:58:03 INFO - 2016-02-18 16:58:03,027 DEBUG : BROWSER_OUTPUT: __metrics 16:58:03 INFO - 2016-02-18 16:58:03,346 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:58:04 INFO - 2016-02-18 16:58:04,321 INFO : Browser initialized. 16:58:04 INFO - 2016-02-18 16:58:04,322 INFO : Running cycle 1/1 for kraken test... 16:58:04 INFO - 2016-02-18 16:58:04,322 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPoogzX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:58:16 INFO - 2016-02-18 16:58:16,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 133611520 16:58:16 INFO - 2016-02-18 16:58:16,011 DEBUG : BROWSER_OUTPUT: 16:58:18 INFO - 2016-02-18 16:58:18,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44364/tests/kraken/driver.html?testName=audio-beat-detection) 16:58:19 INFO - 2016-02-18 16:58:19,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 162533376 16:58:19 INFO - 2016-02-18 16:58:19,019 DEBUG : BROWSER_OUTPUT: 16:58:21 INFO - 2016-02-18 16:58:21,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44364/tests/kraken/driver.html?testName=audio-dft) 16:58:22 INFO - 2016-02-18 16:58:22,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 162648064 16:58:22 INFO - 2016-02-18 16:58:22,168 DEBUG : BROWSER_OUTPUT: 16:58:24 INFO - 2016-02-18 16:58:24,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44364/tests/kraken/driver.html?testName=audio-fft) 16:58:25 INFO - 2016-02-18 16:58:25,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 159977472 16:58:25 INFO - 2016-02-18 16:58:25,519 DEBUG : BROWSER_OUTPUT: 16:58:27 INFO - 2016-02-18 16:58:27,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44364/tests/kraken/driver.html?testName=audio-oscillator) 16:58:28 INFO - 2016-02-18 16:58:28,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 159854592 16:58:28 INFO - 2016-02-18 16:58:28,085 DEBUG : BROWSER_OUTPUT: 16:58:30 INFO - 2016-02-18 16:58:30,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44364/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:58:30 INFO - 2016-02-18 16:58:30,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 158142464 16:58:30 INFO - 2016-02-18 16:58:30,834 DEBUG : BROWSER_OUTPUT: 16:58:33 INFO - 2016-02-18 16:58:33,701 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44364/tests/kraken/driver.html?testName=imaging-darkroom) 16:58:34 INFO - 2016-02-18 16:58:34,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 157376512 16:58:34 INFO - 2016-02-18 16:58:34,269 DEBUG : BROWSER_OUTPUT: 16:58:37 INFO - 2016-02-18 16:58:37,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44364/tests/kraken/driver.html?testName=imaging-desaturate) 16:58:38 INFO - 2016-02-18 16:58:38,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 160096256 16:58:38 INFO - 2016-02-18 16:58:38,174 DEBUG : BROWSER_OUTPUT: 16:58:40 INFO - 2016-02-18 16:58:40,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44364/tests/kraken/driver.html?testName=json-parse-financial) 16:58:41 INFO - 2016-02-18 16:58:41,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 158273536 16:58:41 INFO - 2016-02-18 16:58:41,471 DEBUG : BROWSER_OUTPUT: 16:58:43 INFO - 2016-02-18 16:58:43,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44364/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:58:43 INFO - 2016-02-18 16:58:43,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 165961728 16:58:43 INFO - 2016-02-18 16:58:43,586 DEBUG : BROWSER_OUTPUT: 16:58:45 INFO - 2016-02-18 16:58:45,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44364/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:58:45 INFO - 2016-02-18 16:58:45,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 162443264 16:58:45 INFO - 2016-02-18 16:58:45,934 DEBUG : BROWSER_OUTPUT: 16:58:47 INFO - 2016-02-18 16:58:47,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44364/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:58:48 INFO - 2016-02-18 16:58:48,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 169353216 16:58:48 INFO - 2016-02-18 16:58:48,470 DEBUG : BROWSER_OUTPUT: 16:58:50 INFO - 2016-02-18 16:58:50,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:58:51 INFO - 2016-02-18 16:58:51,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 177655808 16:58:51 INFO - 2016-02-18 16:58:51,411 DEBUG : BROWSER_OUTPUT: 16:58:53 INFO - 2016-02-18 16:58:53,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:58:54 INFO - 2016-02-18 16:58:54,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 174342144 16:58:54 INFO - 2016-02-18 16:58:54,457 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44364/tests/kraken/driver.html?testName=ai-astar) 16:58:56 INFO - 2016-02-18 16:58:56,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 232022016 16:58:56 INFO - 2016-02-18 16:58:56,373 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,374 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:58:56 INFO - 2016-02-18 16:58:56,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:58:56 INFO - 2016-02-18 16:58:56,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:58:56 INFO - 2016-02-18 16:58:56,375 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:58:56 INFO - 2016-02-18 16:58:56,375 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;108;102;108;108;109;98;108;111;108 16:58:56 INFO - 2016-02-18 16:58:56,375 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;124;162;154;125;148;149;123;176;121 16:58:56 INFO - 2016-02-18 16:58:56,375 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;160;161;160;160;162;161;160 16:58:56 INFO - 2016-02-18 16:58:56,375 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;71;151;71;71;73;73;154;70 16:58:56 INFO - 2016-02-18 16:58:56,377 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;137;92;91;91;135;92;93;135 16:58:56 INFO - 2016-02-18 16:58:56,377 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;108;109;110;108;109;109;110;109;109;109 16:58:56 INFO - 2016-02-18 16:58:56,377 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;145 16:58:56 INFO - 2016-02-18 16:58:56,377 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;95;95;95;94;95;95 16:58:56 INFO - 2016-02-18 16:58:56,377 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;56;56;57;55;55;56;56;54;54 16:58:56 INFO - 2016-02-18 16:58:56,377 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;65;65;64;65;64;65;65;66 16:58:56 INFO - 2016-02-18 16:58:56,377 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;78;79;80;78;77;78;78;79;81 16:58:56 INFO - 2016-02-18 16:58:56,377 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;115;108;112;115;116;123;116;109;125 16:58:56 INFO - 2016-02-18 16:58:56,377 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;141;144;141;143;142;142;141;137;140 16:58:56 INFO - 2016-02-18 16:58:56,378 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;63;65;63;65;64;62;64;65;64 16:58:56 INFO - 2016-02-18 16:58:56,378 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:58:56 INFO - 2016-02-18 16:58:56,378 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:58:56 INFO - 2016-02-18 16:58:56,378 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,901 16:58:56 INFO - 2016-02-18 16:58:56,378 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:58:56 INFO - 2016-02-18 16:58:56,378 DEBUG : BROWSER_OUTPUT: __startTimestamp1455843536374__endTimestamp 16:58:56 INFO - 2016-02-18 16:58:56,378 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,379 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:58:56 INFO - 2016-02-18 16:58:56,379 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:58:56 INFO - 2016-02-18 16:58:56,379 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,379 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.70 Median:108.00 stddev:3.80 (3.5%) stddev-sans-first:4.03 16:58:56 INFO - 2016-02-18 16:58:56,379 DEBUG : BROWSER_OUTPUT: Values: 107.0 108.0 102.0 108.0 108.0 109.0 98.0 108.0 111.0 108.0 16:58:56 INFO - 2016-02-18 16:58:56,380 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,380 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.10 Median:149.00 stddev:18.96 (12.7%) stddev-sans-first:19.99 16:58:56 INFO - 2016-02-18 16:58:56,380 DEBUG : BROWSER_OUTPUT: Values: 149.0 124.0 162.0 154.0 125.0 148.0 149.0 123.0 176.0 121.0 16:58:56 INFO - 2016-02-18 16:58:56,380 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,380 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 16:58:56 INFO - 2016-02-18 16:58:56,380 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 160.0 161.0 160.0 160.0 162.0 161.0 160.0 16:58:56 INFO - 2016-02-18 16:58:56,380 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,380 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.80 Median:71.00 stddev:34.12 (48.1%) stddev-sans-first:35.65 16:58:56 INFO - 2016-02-18 16:58:56,380 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 71.0 151.0 71.0 71.0 73.0 73.0 154.0 70.0 16:58:56 INFO - 2016-02-18 16:58:56,380 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,380 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:92.00 stddev:21.11 (22.9%) stddev-sans-first:21.85 16:58:56 INFO - 2016-02-18 16:58:56,380 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 137.0 92.0 91.0 91.0 135.0 92.0 93.0 135.0 16:58:56 INFO - 2016-02-18 16:58:56,381 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,381 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 16:58:56 INFO - 2016-02-18 16:58:56,381 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 110.0 108.0 109.0 109.0 110.0 109.0 109.0 109.0 16:58:56 INFO - 2016-02-18 16:58:56,381 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,381 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:58:56 INFO - 2016-02-18 16:58:56,381 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 16:58:56 INFO - 2016-02-18 16:58:56,381 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,381 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 16:58:56 INFO - 2016-02-18 16:58:56,382 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 16:58:56 INFO - 2016-02-18 16:58:56,382 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,382 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:2.00 (3.6%) stddev-sans-first:1.01 16:58:56 INFO - 2016-02-18 16:58:56,382 DEBUG : BROWSER_OUTPUT: Values: 61.0 56.0 56.0 57.0 55.0 55.0 56.0 56.0 54.0 54.0 16:58:56 INFO - 2016-02-18 16:58:56,383 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,383 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 16:58:56 INFO - 2016-02-18 16:58:56,383 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 65.0 65.0 64.0 65.0 64.0 65.0 65.0 66.0 16:58:56 INFO - 2016-02-18 16:58:56,383 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,383 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:78.50 stddev:1.17 (1.5%) stddev-sans-first:1.22 16:58:56 INFO - 2016-02-18 16:58:56,383 DEBUG : BROWSER_OUTPUT: Values: 78.0 78.0 79.0 80.0 78.0 77.0 78.0 78.0 79.0 81.0 16:58:56 INFO - 2016-02-18 16:58:56,383 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,383 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.90 Median:116.00 stddev:5.55 (4.8%) stddev-sans-first:5.68 16:58:56 INFO - 2016-02-18 16:58:56,383 DEBUG : BROWSER_OUTPUT: Values: 120.0 115.0 108.0 112.0 115.0 116.0 123.0 116.0 109.0 125.0 16:58:56 INFO - 2016-02-18 16:58:56,383 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,384 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.30 Median:142.00 stddev:1.89 (1.3%) stddev-sans-first:1.99 16:58:56 INFO - 2016-02-18 16:58:56,384 DEBUG : BROWSER_OUTPUT: Values: 142.0 141.0 144.0 141.0 143.0 142.0 142.0 141.0 137.0 140.0 16:58:56 INFO - 2016-02-18 16:58:56,384 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,384 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:1.64 (2.5%) stddev-sans-first:1.05 16:58:56 INFO - 2016-02-18 16:58:56,384 DEBUG : BROWSER_OUTPUT: Values: 68.0 63.0 65.0 63.0 65.0 64.0 62.0 64.0 65.0 64.0 16:58:56 INFO - 2016-02-18 16:58:56,384 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:58:56 INFO - 2016-02-18 16:58:56,384 DEBUG : BROWSER_OUTPUT: 16:58:56 INFO - 2016-02-18 16:58:56,962 INFO : Browser exited with error code: 0 16:58:57 INFO - 2016-02-18 16:58:57,015 INFO : Completed test kraken (00:00:57) 16:58:57 INFO - 2016-02-18 16:58:57,016 INFO : Starting test v8_7 16:58:57 INFO - 2016-02-18 16:58:57,016 DEBUG : operating with platform_type : linux_ 16:58:57 INFO - 2016-02-18 16:58:57,016 INFO : Initialising browser for v8_7 test... 16:58:57 INFO - 2016-02-18 16:58:57,022 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv44yzH/profile http://localhost:44364/getInfo.html 16:59:01 INFO - 2016-02-18 16:59:01,248 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:59:01 INFO - 2016-02-18 16:59:01,248 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:59:01 INFO - 2016-02-18 16:59:01,248 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:59:01 INFO - 2016-02-18 16:59:01,248 DEBUG : BROWSER_OUTPUT: __metrics 16:59:01 INFO - 2016-02-18 16:59:01,397 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:59:02 INFO - 2016-02-18 16:59:02,313 INFO : Browser initialized. 16:59:02 INFO - 2016-02-18 16:59:02,314 INFO : Running cycle 1/1 for v8_7 test... 16:59:02 INFO - 2016-02-18 16:59:02,314 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv44yzH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:59:13 INFO - 2016-02-18 16:59:13,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 132927488 16:59:13 INFO - 2016-02-18 16:59:13,960 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2016-02-18 16:59:35,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44364/tests/v8_7/run.html (next: http://localhost:44364/tests/v8_7/run.html) 16:59:35 INFO - 2016-02-18 16:59:35,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 425308160 16:59:35 INFO - 2016-02-18 16:59:35,529 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2016-02-18 16:59:35,530 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:59:35 INFO - 2016-02-18 16:59:35,531 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:59:35 INFO - 2016-02-18 16:59:35,531 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:59:35 INFO - 2016-02-18 16:59:35,532 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:59:35 INFO - 2016-02-18 16:59:35,532 DEBUG : BROWSER_OUTPUT: |0;Richards;164.31153466973382 16:59:35 INFO - 2016-02-18 16:59:35,532 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.5001665001665 16:59:35 INFO - 2016-02-18 16:59:35,532 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 16:59:35 INFO - 2016-02-18 16:59:35,533 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 16:59:35 INFO - 2016-02-18 16:59:35,533 DEBUG : BROWSER_OUTPUT: |4;RayTrace;953.2888465204957 16:59:35 INFO - 2016-02-18 16:59:35,533 DEBUG : BROWSER_OUTPUT: |5;Earley;541.4185165132648 16:59:35 INFO - 2016-02-18 16:59:35,533 DEBUG : BROWSER_OUTPUT: |6;Boyer;10526.315789473685 16:59:35 INFO - 2016-02-18 16:59:35,533 DEBUG : BROWSER_OUTPUT: |7;RegExp;24023.809523809523 16:59:35 INFO - 2016-02-18 16:59:35,534 DEBUG : BROWSER_OUTPUT: |8;Splay;515.1983513652756 16:59:35 INFO - 2016-02-18 16:59:35,534 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 16:59:35 INFO - 2016-02-18 16:59:35,534 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:59:35 INFO - 2016-02-18 16:59:35,534 DEBUG : BROWSER_OUTPUT: __startTimestamp1455843575529__endTimestamp 16:59:35 INFO - 2016-02-18 16:59:35,534 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2016-02-18 16:59:35,534 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:59:35 INFO - 2016-02-18 16:59:35,534 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:59:35 INFO - 2016-02-18 16:59:35,534 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2016-02-18 16:59:35,535 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.31 Median:164.31 stddev:0.00 (0.0%) 16:59:35 INFO - 2016-02-18 16:59:35,535 DEBUG : BROWSER_OUTPUT: Values: 164.3 16:59:35 INFO - 2016-02-18 16:59:35,535 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2016-02-18 16:59:35,535 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.50 Median:166.50 stddev:0.00 (0.0%) 16:59:35 INFO - 2016-02-18 16:59:35,535 DEBUG : BROWSER_OUTPUT: Values: 166.5 16:59:35 INFO - 2016-02-18 16:59:35,535 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2016-02-18 16:59:35,535 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 16:59:35 INFO - 2016-02-18 16:59:35,535 DEBUG : BROWSER_OUTPUT: Values: 278.3 16:59:35 INFO - 2016-02-18 16:59:35,536 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2016-02-18 16:59:35,536 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 16:59:35 INFO - 2016-02-18 16:59:35,536 DEBUG : BROWSER_OUTPUT: Values: 5186.5 16:59:35 INFO - 2016-02-18 16:59:35,536 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2016-02-18 16:59:35,537 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:953.29 Median:953.29 stddev:0.00 (0.0%) 16:59:35 INFO - 2016-02-18 16:59:35,538 DEBUG : BROWSER_OUTPUT: Values: 953.3 16:59:35 INFO - 2016-02-18 16:59:35,538 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2016-02-18 16:59:35,538 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:541.42 Median:541.42 stddev:0.00 (0.0%) 16:59:35 INFO - 2016-02-18 16:59:35,538 DEBUG : BROWSER_OUTPUT: Values: 541.4 16:59:35 INFO - 2016-02-18 16:59:35,538 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2016-02-18 16:59:35,538 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10526.32 Median:10526.32 stddev:0.00 (0.0%) 16:59:35 INFO - 2016-02-18 16:59:35,538 DEBUG : BROWSER_OUTPUT: Values: 10526.3 16:59:35 INFO - 2016-02-18 16:59:35,538 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2016-02-18 16:59:35,538 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24023.81 Median:24023.81 stddev:0.00 (0.0%) 16:59:35 INFO - 2016-02-18 16:59:35,539 DEBUG : BROWSER_OUTPUT: Values: 24023.8 16:59:35 INFO - 2016-02-18 16:59:35,539 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2016-02-18 16:59:35,539 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:515.20 Median:515.20 stddev:0.00 (0.0%) 16:59:35 INFO - 2016-02-18 16:59:35,539 DEBUG : BROWSER_OUTPUT: Values: 515.2 16:59:35 INFO - 2016-02-18 16:59:35,539 DEBUG : BROWSER_OUTPUT: 16:59:35 INFO - 2016-02-18 16:59:35,539 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 16:59:35 INFO - 2016-02-18 16:59:35,539 DEBUG : BROWSER_OUTPUT: Values: 4822.1 16:59:35 INFO - 2016-02-18 16:59:35,539 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:59:35 INFO - 2016-02-18 16:59:35,539 DEBUG : BROWSER_OUTPUT: 16:59:36 INFO - 2016-02-18 16:59:36,221 INFO : Browser exited with error code: 0 16:59:36 INFO - 2016-02-18 16:59:36,234 INFO : Completed test v8_7 (00:00:39) 16:59:36 INFO - 2016-02-18 16:59:36,618 INFO : Completed test suite (00:20:08) 16:59:36 INFO - 2016-02-18 16:59:36,618 DEBUG : Working with test: dromaeo_css 16:59:36 INFO - 2016-02-18 16:59:36,618 DEBUG : Generating results file: dromaeo_css 16:59:36 INFO - 2016-02-18 16:59:36,619 DEBUG : Working with test: kraken 16:59:36 INFO - 2016-02-18 16:59:36,620 DEBUG : Generating results file: kraken 16:59:36 INFO - 2016-02-18 16:59:36,620 INFO : javascript benchmark 16:59:36 INFO - 2016-02-18 16:59:36,620 DEBUG : Working with test: v8_7 16:59:36 INFO - 2016-02-18 16:59:36,620 DEBUG : Generating results file: v8_7 16:59:36 INFO - 2016-02-18 16:59:36,620 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:59:36 INFO - 2016-02-18 16:59:36,680 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 16:59:36 INFO - 2016-02-18 16:59:36,680 DEBUG : process_Request line: dromaeo_css 7247.08 graph.html#tests=[[72,53,35]] 16:59:36 INFO - 2016-02-18 16:59:36,680 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:59:36 INFO - 2016-02-18 16:59:36,709 DEBUG : process_Request line: kraken 1473.40 graph.html#tests=[[232,53,35]] 16:59:36 INFO - 2016-02-18 16:59:36,709 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:59:36 INFO - 2016-02-18 16:59:36,744 DEBUG : process_Request line: v8_7 23369.44 graph.html#tests=[[230,53,35]] 16:59:36 INFO - 2016-02-18 16:59:36,745 INFO : javascript benchmark 16:59:36 INFO - 2016-02-18 16:59:36,749 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3315.867365305387, 3379.5437615921874, 3416.385050690875, 3423.5891692996843, 3431.931361372772, 5537.307836520435, 5545.916811247829, 5587.161925711145, 5599.0201714699915, 5607.831765047045, 5594.636348637346, 5611.775528978836, 5613.045782217023, 5620.185073164399, 5622.269105016342, 4822.590079843218, 5067.543921047096, 5112.8977420451565, 5162.457941916101, 5202.219667049935, 4930.556249937505, 5033.295338652591, 5101.107306221396, 5101.234814777795, 5102.668326558781, 5003.549680528752, 5079.873003174913, 5107.438181799999, 5111.591072714193, 5147.073526765181, 5119.027384796896, 5161.200013997799, 5171.301874246966, 5171.5862730981435, 5201.765920533585, 4899.58353539946, 4902.950970490285, 4994.375703037121, 5076.340075790161, 5079.314292570492, 5320.148776195829, 5373.650712703701, 5375.220593013991, 5406.810761623364, 5420.756065977041, 5893.086571581412, 5899.46904778572, 5959.642421454727, 5967.0, 5973.611715238539, 5697.0, 5806.883862322772, 5943.138244954501, 6007.249093863267, 6036.9396306036815, 5562.054450743383, 5616.775328986836, 5622.522085622686, 5622.971885140589, 5625.746841392106, 6076.179715738319, 6096.939030609726, 6097.0, 6108.633481991094, 6116.480099191618, 5668.744906479218, 5762.164486149485, 5804.854878628068, 5868.589198756046, 5933.910991335133, 5974.910376344358, 5982.461578457873, 5984.311804142492, 5987.550933679991, 5988.431099045583, 5524.14375771756, 5949.762009519571, 5959.463648271676, 5969.343372229051, 5970.641761494324, 5761.366249712528, 5866.970665146647, 5974.880502389928, 5975.133605627159, 6012.098185272157, 4556.908861822745, 4589.977050114728, 4592.609628181575, 4599.425071866017, 4616.192166370939, 4009.298372784751, 4092.386142078712, 4131.462909821764, 4132.090939993197, 4135.937960930589, 5502.504774570308, 5582.581306401955, 5611.607187496836, 5612.579056570774, 5649.180868774005, 6041.607295525777, 6070.332263451017, 6070.514358851281, 6071.878562428727, 6075.787347442818, 5473.425290344457, 5585.609007369445, 5598.300212473441, 5738.598298119092, 5746.195532625436, 5034.748262586856, 5049.31834202378, 5056.772445239973, 5058.772355244023, 5073.797048118107, 6109.0, 6115.388461153849, 6120.387961203844, 6126.632402055801, 6140.938590614037, 5747.252857128547, 5863.970680146572, 5943.049112142036, 6013.037913933749, 6071.392860713893, 6179.876402472015, 6240.500759939103, 6243.8126856194385, 6244.750209991549, 6257.812265632038, 5960.761569537343, 6023.297660763442, 6023.879522409615, 6025.849353766191, 6063.696815159313, 5674.914876276776, 5844.094165404369, 5953.404659534185, 6052.576319657582, 6058.212432383762, 5814.738336774771, 5814.912776308274, 5818.796342128175, 5832.096025116114, 5896.823095307148, 5630.577706671934, 5795.043817770021, 5811.535077193899, 5821.912671309849, 5829.59192856513, 5631.493165615114, 5714.828555143353, 5789.131630255495, 5791.247137872218, 5815.3893841147765, 5799.2750906136735, 5826.970865145647, 5831.533477321889, 5833.67914764692, 5837.562182836219, 5512.531434827924, 5639.041362968223, 5785.190073389645, 5793.131030345482, 5796.76812927495], "unit": "ms", "name": "dojo.html", "value": 5494.97173334065}, {"lowerIsBetter": false, "replicates": [592.9229200203973, 623.2583225961106, 627.2410383436043, 627.4102343796831, 637.5791977294987, 28254.71745282549, 42577.78711106444, 42587.78706106465, 42653.36019959703, 42713.57286427135, 47237.76381118098, 47783.0, 47863.76068119663, 47900.281495777504, 48141.75929120358, 7825.452218344718, 7896.486728362666, 7910.0, 9101.226395756368, 9329.300302477308, 11027.117830573536, 11313.264637798558, 11316.886831131707, 11328.886711132907, 11332.09343252542, 10957.0, 11006.119510439146, 11051.336919784799, 11060.778784424347, 11063.446827658625, 10925.125989920787, 11006.119510439146, 11026.669199924016, 11031.558737650485, 11031.613893513728, 10714.089302409304, 10874.401907895062, 10886.40124793136, 10886.67339979802, 10888.237823352369, 44385.77807110976, 44756.77621611871, 44780.3282950756, 44820.0, 44898.77550612258, 3650.2699460108083, 3751.8311675974373, 3766.773993560395, 3860.4595356650093, 4041.6362527372676, 32918.835405823054, 33930.1517462063, 34287.0, 34311.31377372439, 34975.30049398998, 4189.434426352434, 4248.171606536726, 4275.102228532012, 4316.460442444694, 4356.869293921188, 295274.0, 297599.0, 298470.0, 298584.0, 299006.0, 57221.0, 58101.0, 58755.0, 72977.0, 74577.0, 66166.33833661601, 66207.66896165488, 66237.33762662408, 66314.0, 66452.66773666101, 15953.760693589606, 15999.760003599955, 16090.436834710963, 16113.838861611468, 16131.354745810271, 12628.242305461701, 12630.621081367573, 12640.051996100145, 12684.23894566329, 12748.936255318664, 22334.0, 22564.887175564018, 22601.0, 22638.320850374515, 22698.773012269998, 7903.881441778378, 7913.723019694398, 7963.124056353797, 7994.1606131355375, 8153.836923261501, 957.9089986451276, 1049.7218237167158, 1083.3770581915273, 1112.872019717743, 1115.4144074360863, 30090.84954575213, 30255.69744302529, 31309.0, 33002.83498582492, 33123.50314745281, 1068.2682362581656, 1162.2503485252134, 1181.6809461445534, 1217.0689422591724, 1234.8394708687813, 13079.0, 15118.924405377902, 15225.086494810346, 15295.388184472718, 15459.0, 384738.0, 393155.0, 394060.0, 395137.0, 395212.0, 54278.728606356715, 55693.164602531, 55758.16362754562, 55853.44146558482, 56099.439005610235, 1284.794432890733, 1357.640225340266, 1414.589768966988, 1460.6567456647679, 1480.6002379357512, 27333.72666273312, 27346.726532735214, 27534.72465275402, 27701.722982769916, 27784.44431111326, 43388.34917476177, 43622.56377436185, 43782.34326485169, 43865.0, 43900.56099439092, 235145.0, 237386.0, 237837.0, 237999.0, 238115.0, 35891.820540897126, 36651.816740916125, 36799.816000919825, 36810.447843281836, 36870.07824804294, 47367.0, 47404.288935666686, 48260.7586962077, 48416.0, 48469.27296090632, 39804.800975994935, 40664.0, 40675.79662101671, 40717.59282407138, 41202.79398602988, 40100.0, 40304.79847600743, 40647.39028914509, 41387.0, 41467.7926610365, 39699.007524812114, 40358.1928361437, 40628.39057414082, 40911.7954410226, 40930.386044209954, 35252.29495410026, 36263.27473450569, 36471.0, 37002.0, 37220.44169337408, 27672.861635691694, 27709.168724938285, 27775.583366249117, 27839.721602783713, 28201.57697634496], "unit": "ms", "name": "ext.html", "value": 20232.692280069357}, {"lowerIsBetter": false, "replicates": [372.8415423445037, 375.04787580642756, 375.9567649720281, 382.9061879839439, 383.38466760848837, 14835.332410041547, 16541.0, 16820.915895420538, 18056.819431805696, 18136.365227217033, 17006.659866802656, 17168.484945451626, 17237.482875513753, 17251.0, 17448.30206791727, 4180.707350485467, 5486.149646804742, 5616.297962754656, 5616.887662246752, 5620.0, 4193.979030104845, 6101.725422355982, 6261.624302541839, 6272.372762723737, 6277.1839660844025, 5933.792317268896, 6047.697615119227, 6155.292141403729, 6196.256449226099, 6196.318404975449, 6043.7280322385595, 6049.969750151221, 6056.424639659225, 6062.787802426916, 6072.30168530618, 5324.92012619811, 5396.217548455491, 5433.293671822637, 5447.12845944647, 5447.591430642718, 11541.480633371519, 11583.420828958519, 12457.1902826316, 12624.305663188521, 12841.614751557468, 2202.559488102386, 2251.7748225177515, 2332.2420213430532, 2443.511297740441, 2469.086438017945, 9869.753256168582, 10139.493025348704, 10247.333923294962, 11152.996230339308, 13910.443582256697, 1910.9713354299697, 1914.904254787255, 1915.3200613782185, 1931.652302585534, 1948.3375652278294, 62463.37536624666, 63450.0, 63560.0, 64872.02691959625, 65437.67281163564, 10384.42885641297, 10484.21368397358, 10514.21143414247, 10528.894711052792, 10548.314359566604, 13512.324383780771, 13553.796693049611, 13556.864431355758, 13604.251766152956, 13607.931960340135, 7111.751088711871, 7120.0, 7263.527870688388, 7417.072865891763, 7496.212897645669, 6927.445804335641, 6951.0616066830335, 6967.93032069683, 7034.92965070353, 7066.540674856118, 4185.748855068706, 4305.354196870495, 4407.493138289074, 4479.843205487858, 4511.390962220124, 1801.828826261503, 1819.4905426480607, 1833.8899666020081, 1870.307986045172, 1875.915583798705, 851.7529916324321, 991.826430374696, 1008.4503945349802, 1014.8274793285159, 1016.983016983017, 16222.83777162237, 16362.345506179858, 16689.749653755203, 16812.411565595146, 17629.559261018578, 924.6347692661361, 952.6332362040664, 952.9618815247451, 957.5499515227832, 984.8030393921101, 7836.568988705676, 9517.524123793783, 9566.473843938651, 10298.845517317246, 10313.639022634172, 649051.0, 651175.0, 662991.0, 665806.0, 667918.0, 79020.60489697514, 79566.0, 86660.56669716611, 87680.0, 88243.55878220568, 1204.277433539869, 1210.4734440518403, 1210.8970737487411, 1226.4542278686079, 1241.4351470081092, 15232.543023709306, 15656.295466703798, 15949.760753588938, 16456.177191140636, 16482.01107933528, 35430.29139417249, 36079.45880811843, 36916.26167476582, 37641.247175055796, 37794.0, 44703.55296446994, 45158.54841451543, 46238.76880615576, 46379.76810115928, 47396.52603474059, 9762.0, 9823.754406139904, 9893.703188904345, 9984.500774961369, 10221.74445638865, 17888.373906913195, 18477.0, 18990.715139273198, 18995.05024748785, 19025.42923712291, 14774.778378324549, 15067.171305578298, 15131.319090641167, 15381.923090384476, 15851.682966340839, 14695.265236737907, 15069.0, 15199.392024318904, 15285.6178595536, 15837.366505339658, 15572.532824015298, 15718.292676829798, 15823.129727865078, 15869.12719800422, 16241.187940603158, 8352.290055345364, 9548.379355342158, 9776.462294573583, 9855.556499957662, 9865.802683946424, 10184.898151018395, 14076.296185190904, 14296.213708246147, 14327.283635818376, 14349.63231066904], "unit": "ms", "name": "jquery.html", "value": 9121.572495119977}, {"lowerIsBetter": false, "replicates": [1493.8506149385057, 1761.1106391272408, 1795.349895394903, 1834.7247912813084, 1841.0518582929785, 7613.7335193268245, 7827.765167044983, 7830.451868369223, 7836.981192444974, 7859.882101768478, 6753.459723222143, 6889.517733758639, 7215.747448839292, 7338.706451741938, 7667.309942105209, 2200.3618950504333, 2216.5788500184913, 2237.7314722233355, 2237.9216727414546, 2241.506868488938, 2003.4891102768847, 2258.446680563256, 2299.3331933739196, 2304.2626359564947, 2307.0195167054017, 1939.4181745476371, 2191.8904054797194, 2255.357223191391, 2260.819134469247, 2263.196565219348, 2168.0352243251837, 2201.482651576878, 2204.0302267002626, 2205.6250437425674, 2212.026708248374, 2228.342638921522, 2242.5178586603797, 2254.9323520294415, 2255.1881322723807, 2257.7403598586206, 7571.3942884569105, 7625.923740762632, 7630.961845190794, 7631.847363052763, 7639.236076392372, 4577.176108300505, 4638.814447422099, 4658.557437043475, 4662.230731929228, 4664.323673067386, 2942.1173647905543, 2943.0729320264263, 2980.7019298070236, 2989.61135052444, 3028.8939887104066, 989.2185173712759, 995.1988649137442, 1049.2759995603085, 1086.4459125845797, 1090.5855774805602, 10376.65103536543, 10381.42902140382, 10386.584536618602, 10389.27275090744, 10405.0, 4029.7783621901076, 4074.8573799916862, 4078.836846526165, 4131.338985762263, 4131.855385061508, 8892.555372231363, 8919.42023768453, 8933.776655583662, 8936.32977526688, 8945.329100317373, 4610.1471227822285, 4633.142868569325, 4651.162790697639, 4652.790624421909, 4652.790624421909, 4239.491261048694, 4242.703010789277, 4253.064325848309, 4254.127903779718, 4256.638185754184, 3554.4845997330244, 3588.4258518637416, 3595.7123430125525, 3619.167591453928, 3620.1673615068157, 1078.962236321725, 1091.2524920429373, 1163.51714038673, 1165.213480900389, 1168.567629976914, 906.1391677906016, 1108.9500972456258, 1125.7692173104494, 1128.3737525673166, 1132.2017977325966, 6975.825604359931, 7025.297470253036, 7032.753853615099, 7038.0, 7038.753643622448, 1127.0983213429388, 1129.4804389980536, 1165.1319766773809, 1202.5971299614553, 1216.0636310041396, 5723.341815691166, 5730.0, 5807.88384232313, 5808.30300363959, 5812.476877081083, 9020.774480637905, 9313.767155821024, 9314.48770317639, 9317.534123293945, 9347.0, 9110.954445227864, 9120.179183873483, 9195.080491950885, 9209.95395023034, 9233.676821311356, 7109.395701365338, 7316.0489136411925, 7364.668589913466, 7371.3734332582335, 7381.88927166093, 7020.719171233093, 7132.429405647639, 7201.891971620535, 7204.063471748639, 7215.458840586872, 8124.0, 8405.453645513022, 8412.495250285003, 8473.66105355779, 8481.151884811716, 8370.916290837258, 8430.030546487233, 8480.703175388831, 8559.400841941004, 8564.871526927225, 6579.671016449062, 6614.437772789367, 6616.206055273398, 6618.569792963442, 6630.270670226175, 7400.0, 7426.220246874001, 7438.59087750179, 7446.0, 7452.813679658052, 6174.166487524127, 6793.558418702769, 7009.7897063088185, 7047.859042819013, 7102.431805455448, 6234.127222188988, 6496.837579060561, 6869.553479023847, 6954.130733658293, 6974.337437943387, 7034.437245020488, 7046.753363632249, 7083.0, 7083.114610673666, 7085.539439936594, 6011.639301641915, 6031.185789918481, 6042.395760423922, 6042.456178943916, 6042.486388656837, 6159.414855588891, 6167.0, 6169.2288463942, 6174.845628859314, 6179.505639548735], "unit": "ms", "name": "mootools.html", "value": 4417.022755100441}, {"lowerIsBetter": false, "replicates": [318.7641145552292, 323.0727811181907, 325.9022293312006, 332.7171903881699, 333.7480202447152, 6126.571140020201, 6219.8134055978335, 6223.751049958008, 6267.247930248376, 6275.7489700411925, 6108.725107370168, 6113.480354169889, 6115.205023346959, 6117.143599896007, 6124.081387791834, 4667.88330291742, 4697.201475749113, 4705.411823522059, 4705.741184234866, 4717.363155973934, 4625.606823420013, 4707.670463067587, 4713.811447542112, 4723.976380118094, 4728.527147285278, 4670.929936050962, 4673.462551806551, 4680.438347398317, 4682.859514214579, 4690.812367505296, 4437.866863994085, 4657.813687452498, 4659.347691323217, 4671.672982891182, 4672.275797251432, 3958.4656071430563, 4079.73481723687, 4128.071183983609, 4135.276326642826, 4141.482314710661, 5834.241548598698, 5858.5898987070495, 5865.882682346371, 5870.706464676749, 5871.324797648283, 5185.714785686786, 5341.305630268041, 5341.839744807662, 5487.835364939058, 5505.614606977513, 6486.189226346707, 6499.447546958514, 6507.869842603169, 6514.902276465857, 6524.412802847766, 4587.472440669332, 4591.885202869921, 4592.517785632527, 4593.058423023273, 4601.332806743037, 6587.50593705474, 6733.192016957947, 6749.2238392584495, 6749.628770417625, 6756.729730810713, 4711.52884711533, 4717.599004084623, 4722.6221902247735, 4723.6929599575915, 4725.716457012591, 4778.856634300976, 4780.49804770501, 4787.928181077286, 4788.473267940523, 4797.4482934462985, 5484.0, 5491.36849262332, 5493.807716729895, 5502.449755024546, 5503.642263252876, 6463.612183269019, 6536.934630653633, 6557.901631475532, 6558.770443034471, 6575.243846957565, 1659.4938543744274, 1683.6127690631224, 1686.5530634381898, 1688.2909178145208, 1690.3661127077346, 1114.8550688410455, 1120.7534342444812, 1121.9439028048728, 1131.8754936956927, 1149.5516748468103, 6372.7132279047555, 6375.043743438521, 6376.33048529907, 6377.585456945284, 6381.329960354096, 6785.812482815488, 6786.558873673195, 6793.830154246183, 6797.5581587196675, 6799.218089919723, 6258.718357673915, 6376.234851817719, 6376.808695739135, 6379.457746091634, 6383.521235907326, 3674.926501469956, 3713.591504934455, 3715.2198038412234, 3717.386631205821, 3718.0890681783135, 7044.119485064367, 7052.188998265163, 7060.152781666233, 7060.54106483077, 7068.646567671596, 6902.0, 7015.719371225094, 7028.648567571601, 7029.0862187915245, 7032.8945065824055, 7021.824454388681, 7033.331833475811, 7043.9647801761685, 7045.577265363992, 7051.717931282794, 6874.690638921361, 6875.690593923386, 6876.0, 6880.4839637026425, 6880.5527640705195, 6552.803415897531, 6650.600963942179, 6741.797746067429, 6764.188297404343, 6769.153855768029, 6875.312468753084, 7034.613096279753, 7035.366816986496, 7041.823954401181, 7044.626297872071, 4709.929351059805, 4726.03116361152, 4754.619630429488, 4759.595434387978, 4762.857114286577, 6739.898901516383, 6799.558028728117, 6853.451723862178, 6866.6566671667215, 6869.793906182823, 6634.270230274569, 6670.499712521678, 6670.599764014175, 6671.799846004627, 6680.966595166993, 6648.0360347750275, 6652.201735791736, 6657.966710166418, 6662.100616416916, 6666.0, 6425.742970281136, 6544.934550654623, 6545.312742162005, 6559.442447391834, 6563.868722625425, 6646.102776125162, 6659.167604049494, 6660.267370589135, 6663.633500157344, 6667.099941507834, 6515.934840651533, 6528.445082168069, 6541.364658835291, 6544.640044797582, 6548.050532672641], "unit": "ms", "name": "prototype.html", "value": 4962.218426050247}, {"lowerIsBetter": false, "replicates": [833.1793183714041, 839.5214727605263, 841.2050612171497, 916.5188276155018, 960.1310813713592, 13451.260180690058, 15829.839962826209, 16147.111908845009, 16154.757678634829, 16173.75739363909, 14392.208428536427, 14494.565163045125, 14503.05730127541, 14545.927270363632, 14556.272186390665, 701.9192792828813, 709.8154479835229, 837.7109897085511, 850.7320194138857, 850.961706723199, 706.3889735378912, 854.0008190417227, 864.4813112132733, 867.2411639815161, 868.7741187291318, 886.118312279283, 892.5091199840094, 898.7213963671251, 900.995495022524, 901.0178904993555, 737.5242968285453, 744.9979777199658, 884.6903583745702, 894.5884892949251, 895.8118795053047, 658.2397331082559, 659.7789740436912, 659.7855696898479, 660.5442244851038, 660.6234446365573, 13930.37313320903, 14235.928820355935, 14337.56987290383, 14371.281435928162, 14388.784168237486, 12175.93912030443, 12628.558000470031, 12843.678908027374, 12940.547080852219, 13240.271785051818, 10775.137988960943, 10882.727931801768, 10902.890971090266, 10963.725906852313, 11168.218224724273, 3848.65362117408, 3857.0, 3893.610638936084, 3920.7059470539825, 3935.940960885589, 46427.53572464266, 47490.525094748955, 47846.76076619595, 47924.04151916977, 49638.0, 9526.0, 9773.951130244302, 10022.949885250528, 10031.097201251923, 10041.497925103715, 17703.911480442515, 17888.821111788977, 17899.10504474771, 17934.91032544829, 17974.5506362342, 7686.385089192851, 7831.921680783119, 7916.722914697958, 7920.168382319889, 7961.243681850215, 4574.268117101248, 4614.077184563101, 4630.606398456169, 4646.767661616973, 4655.138799322136, 3218.275887925245, 3229.0797122819886, 3234.514822776602, 3235.029491152645, 3235.7573182010974, 587.5886879184502, 601.6239850093691, 603.9939600604025, 609.281048362936, 612.3325575123138, 691.4779341597063, 706.5054461876707, 712.9679164437613, 719.133444199738, 730.1092666946317, 8385.538795366314, 8645.221930026328, 8664.653413863502, 8839.955800221087, 8928.196462318423, 530.8168681804772, 595.3778301674761, 642.5309524047472, 716.1012928774459, 729.8394353242278, 3798.4492248624347, 3835.9041023974623, 3915.7846318452757, 3928.273269445162, 4063.9796801015805, 57858.421415785306, 57859.71070144622, 58306.0, 58757.41242587519, 58761.706191468766, 51684.22473662898, 54167.18749218765, 54649.45350546444, 55093.44906550963, 55280.44719552834, 51202.74398627983, 53985.22103452799, 54130.18804717933, 55075.17387239195, 55129.448705512434, 8522.70170544028, 8661.669165417292, 8723.869141962748, 8962.596683149404, 8986.101389861224, 36814.81592592127, 36987.81506092452, 37229.25541489209, 40372.3944140844, 41462.58537414587, 48725.269120962505, 49429.75285123551, 49685.25472117849, 50318.748406257735, 50607.49392506028, 10321.535530901278, 10545.578176873147, 10840.945795270973, 11103.666889993314, 11457.312561246352, 12078.51685932553, 12342.074344424025, 12392.56626018085, 12641.557545485864, 12973.481060757464, 10861.979582070733, 11202.83195752048, 11316.547338106384, 11361.204715669825, 11689.064874810165, 10239.0, 10409.583616655553, 10783.191260655325, 10854.728631784268, 10856.294340867818, 9645.517724113626, 10014.0, 10938.507767150339, 11066.502007409525, 11133.498992545517, 9431.764205894908, 9827.606895724377, 9866.950665246628, 9927.81854370054, 10405.583776649151, 8089.555074470961, 8923.910760892308, 8973.416727912665, 9134.451932884049, 9444.386114902509], "unit": "ms", "name": "yui.html", "value": 6516.950154949946}], "name": "dromaeo_css", "value": 7247.0840534049885}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 108.0, 102.0, 108.0, 108.0, 109.0, 98.0, 108.0, 111.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 106.7}, {"lowerIsBetter": true, "replicates": [149.0, 124.0, 162.0, 154.0, 125.0, 148.0, 149.0, 123.0, 176.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 160.0, 162.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 71.0, 151.0, 71.0, 71.0, 73.0, 73.0, 154.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 87.8}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 137.0, 92.0, 91.0, 91.0, 135.0, 92.0, 93.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 110.0, 108.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [61.0, 56.0, 56.0, 57.0, 55.0, 55.0, 56.0, 56.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 79.0, 80.0, 78.0, 77.0, 78.0, 78.0, 79.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.6}, {"lowerIsBetter": true, "replicates": [120.0, 115.0, 108.0, 112.0, 115.0, 116.0, 123.0, 116.0, 109.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.9}, {"lowerIsBetter": true, "replicates": [142.0, 141.0, 144.0, 141.0, 143.0, 142.0, 142.0, 141.0, 137.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.3}, {"lowerIsBetter": true, "replicates": [68.0, 63.0, 65.0, 63.0, 65.0, 64.0, 62.0, 64.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1473.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.31153466973382], "unit": "score", "name": "Richards", "value": 214.84797200000008}, {"lowerIsBetter": false, "replicates": [166.5001665001665], "unit": "score", "name": "DeltaBlue", "value": 397.10470799999985}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [953.2888465204957], "unit": "score", "name": "RayTrace", "value": 776.2484609999998}, {"lowerIsBetter": false, "replicates": [541.4185165132648], "unit": "score", "name": "Earley", "value": 1230.9571610000005}, {"lowerIsBetter": false, "replicates": [10526.315789473685], "unit": "score", "name": "Boyer", "value": 63.313984999999995}, {"lowerIsBetter": false, "replicates": [24023.809523809523], "unit": "score", "name": "RegExp", "value": 37.920089197225}, {"lowerIsBetter": false, "replicates": [515.1983513652756], "unit": "score", "name": "Splay", "value": 158.174031}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23369.43680471493}]} 16:59:36 INFO - RETURN: dromaeo_css: 7247.08 16:59:36 INFO - RETURN: kraken: 1473.40 16:59:36 INFO - RETURN: v8_7: 23369.44 16:59:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23369.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1473.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7247.08"}}} 16:59:36 INFO - Return code: 0 16:59:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:59:36 INFO - # TBPL SUCCESS # 16:59:36 INFO - Running post-action listener: _resource_record_post_action 16:59:36 INFO - Running post-run listener: _resource_record_post_run 16:59:37 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 323584; Write bytes: 517996544; Read time: 60; Write time: 615940 16:59:37 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 254013440; Read time: 0; Write time: 337404 16:59:38 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 323584; Write bytes: 263983104; Read time: 60; Write time: 278536 16:59:38 INFO - Running post-run listener: _upload_blobber_files 16:59:38 INFO - Blob upload gear active. 16:59:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:59:38 INFO - Copying logs to upload dir... 16:59:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1254.914329 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-18 16:59:37.610583) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-18 16:59:37.613682) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009829 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455833665/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-18 16:59:37.665579) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:59:37.665906) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1455842319.843121-1734135871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:59:37.716611) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 16:59:37.717186) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 16:59:37.717736) ========= ========= Total master_lag: 0.66 =========