builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1455555842.48 results: success (0) buildid: 20160215064021 builduid: dcf08222c31344a69ff17848b23d6dad revision: 1ce5ee8b5c55 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:02.481011) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:02.481532) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:02.481853) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004949 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:02.506298) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:02.506665) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:02.536152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:02.536586) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.038562 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:02.584856) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:02.585193) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:02.585611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:02.585921) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-15 09:04:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2016-02-15 09:04:02 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.213975 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:02.812285) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:02.812608) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.186438 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:03.011348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:03.011743) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1ce5ee8b5c55 --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 1ce5ee8b5c55 --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=2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-15 09:04:02,846 Setting DEBUG logging. 2016-02-15 09:04:02,846 attempt 1/10 2016-02-15 09:04:02,846 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1ce5ee8b5c55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-15 09:04:03,172 unpacking tar archive at: mozilla-beta-1ce5ee8b5c55/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632895 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:03.654997) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:03.655419) ========= echo 1ce5ee8b5c55 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1ce5ee8b5c55'] 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=2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1ce5ee8b5c55 program finished with exit code 0 elapsedTime=0.004560 script_repo_revision: '1ce5ee8b5c55' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:03.706558) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:03.706945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 09:04:03.717849) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-02-15 09:04:03.718283) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:04:03 INFO - MultiFileLogger online at 20160215 09:04:03 in /builds/slave/test-pgo 09:04:03 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 09:04:03 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:04:03 INFO - {'append_to_log': False, 09:04:03 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:04:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:04:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:04:03 INFO - 'branch': 'Mozilla-Beta', 09:04:03 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:03 INFO - 'config_files': ('talos/linux_config.py',), 09:04:03 INFO - 'default_actions': ('clobber', 09:04:03 INFO - 'read-buildbot-config', 09:04:03 INFO - 'download-and-extract', 09:04:03 INFO - 'populate-webroot', 09:04:03 INFO - 'create-virtualenv', 09:04:03 INFO - 'install', 09:04:03 INFO - 'run-tests'), 09:04:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:03 INFO - 'download_minidump_stackwalk': True, 09:04:03 INFO - 'download_symbols': 'ondemand', 09:04:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:03 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:03 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:03 INFO - 'installer_path': 'installer.exe', 09:04:03 INFO - 'log_level': 'info', 09:04:03 INFO - 'log_name': 'talos', 09:04:03 INFO - 'log_to_console': True, 09:04:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:04:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:04:03 INFO - 'opt_config_files': (), 09:04:03 INFO - 'pip_index': False, 09:04:03 INFO - 'sps_profile': False, 09:04:03 INFO - 'sps_profile_interval': 0, 09:04:03 INFO - 'suite': 'dromaeojs', 09:04:03 INFO - 'system_bits': '32', 09:04:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:03 INFO - 'title': 'talos-linux64-ix-012', 09:04:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:03 INFO - 'use_talos_json': True, 09:04:03 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:04:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:03 INFO - 'work_dir': 'build'} 09:04:03 INFO - ##### 09:04:03 INFO - ##### Running clobber step. 09:04:03 INFO - ##### 09:04:03 INFO - Running pre-action listener: _resource_record_pre_action 09:04:03 INFO - Running main action method: clobber 09:04:03 INFO - rmtree: /builds/slave/test-pgo/build 09:04:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:04:04 INFO - Running post-action listener: _resource_record_post_action 09:04:04 INFO - ##### 09:04:04 INFO - ##### Running read-buildbot-config step. 09:04:04 INFO - ##### 09:04:04 INFO - Running pre-action listener: _resource_record_pre_action 09:04:04 INFO - Running main action method: read_buildbot_config 09:04:04 INFO - Using buildbot properties: 09:04:04 INFO - { 09:04:04 INFO - "properties": { 09:04:04 INFO - "buildnumber": 118, 09:04:04 INFO - "product": "firefox", 09:04:04 INFO - "script_repo_revision": "production", 09:04:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:04:04 INFO - "repository": "", 09:04:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:04:04 INFO - "buildid": "20160215064021", 09:04:04 INFO - "slavename": "talos-linux64-ix-012", 09:04:04 INFO - "pgo_build": "True", 09:04:04 INFO - "basedir": "/builds/slave/test-pgo", 09:04:04 INFO - "project": "", 09:04:04 INFO - "platform": "ubuntu64_hw", 09:04:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:04:04 INFO - "slavebuilddir": "test", 09:04:04 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:04:04 INFO - "branch": "mozilla-beta", 09:04:04 INFO - "repo_path": "releases/mozilla-beta", 09:04:04 INFO - "stage_platform": "linux64-pgo", 09:04:04 INFO - "builduid": "dcf08222c31344a69ff17848b23d6dad", 09:04:04 INFO - "revision": "1ce5ee8b5c55" 09:04:04 INFO - }, 09:04:04 INFO - "sourcestamp": { 09:04:04 INFO - "repository": "", 09:04:04 INFO - "hasPatch": false, 09:04:04 INFO - "project": "", 09:04:04 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 09:04:04 INFO - "changes": [ 09:04:04 INFO - { 09:04:04 INFO - "category": null, 09:04:04 INFO - "files": [ 09:04:04 INFO - { 09:04:04 INFO - "url": null, 09:04:04 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/firefox-45.0.en-US.linux-x86_64.tar.bz2" 09:04:04 INFO - } 09:04:04 INFO - ], 09:04:04 INFO - "repository": "", 09:04:04 INFO - "rev": "1ce5ee8b5c55", 09:04:04 INFO - "who": "sendchange", 09:04:04 INFO - "when": 1455555743, 09:04:04 INFO - "number": 7606281, 09:04:04 INFO - "comments": "Bug 1245745 include libpulse version in update URL r=glandium, a=sylvestre", 09:04:04 INFO - "project": "", 09:04:04 INFO - "at": "Mon 15 Feb 2016 09:02:23", 09:04:04 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 09:04:04 INFO - "revlink": "", 09:04:04 INFO - "properties": [ 09:04:04 INFO - [ 09:04:04 INFO - "buildid", 09:04:04 INFO - "20160215064021", 09:04:04 INFO - "Change" 09:04:04 INFO - ], 09:04:04 INFO - [ 09:04:04 INFO - "builduid", 09:04:04 INFO - "dcf08222c31344a69ff17848b23d6dad", 09:04:04 INFO - "Change" 09:04:04 INFO - ], 09:04:04 INFO - [ 09:04:04 INFO - "pgo_build", 09:04:04 INFO - "True", 09:04:04 INFO - "Change" 09:04:04 INFO - ] 09:04:04 INFO - ], 09:04:04 INFO - "revision": "1ce5ee8b5c55" 09:04:04 INFO - } 09:04:04 INFO - ], 09:04:04 INFO - "revision": "1ce5ee8b5c55" 09:04:04 INFO - } 09:04:04 INFO - } 09:04:04 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/firefox-45.0.en-US.linux-x86_64.tar.bz2. 09:04:04 INFO - Running post-action listener: _resource_record_post_action 09:04:04 INFO - ##### 09:04:04 INFO - ##### Running download-and-extract step. 09:04:04 INFO - ##### 09:04:04 INFO - Running pre-action listener: _resource_record_pre_action 09:04:04 INFO - Running main action method: download_and_extract 09:04:04 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:04:04 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')]} 09:04:04 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/test_packages.json 09:04:04 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:04:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:04:04 INFO - Downloaded 1270 bytes. 09:04:04 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:04:04 INFO - Using the following test package requirements: 09:04:04 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:04:04 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:04:04 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:04:04 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:04:04 INFO - u'jsshell-linux-x86_64.zip'], 09:04:04 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:04:04 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:04:04 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:04:04 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:04:04 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 09:04:04 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:04:04 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 09:04:04 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:04:04 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:04:04 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:04:04 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:04:04 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:04:04 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:04:04 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')]} 09:04:04 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:04:04 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/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 09:04:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/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 09:04:10 INFO - Downloaded 21581551 bytes. 09:04:10 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 09:04:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:04:10 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 09:04:11 INFO - Return code: 0 09:04:12 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 09:04:12 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')]} 09:04:12 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:04:12 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/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 09:04:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/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 09:04:12 INFO - Downloaded 21581551 bytes. 09:04:12 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 09:04:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:04:12 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 09:04:16 INFO - Return code: 0 09:04:16 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')]} 09:04:16 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 09:04:16 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/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 09:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/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 09:04:16 INFO - Downloaded 11132038 bytes. 09:04:16 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 09:04:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 09:04:16 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 09:04:17 INFO - Return code: 0 09:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:04:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/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 09:04:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/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 09:04:29 INFO - Downloaded 57953832 bytes. 09:04:29 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:04:29 INFO - mkdir: /builds/slave/test-pgo/properties 09:04:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:04:29 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:04:29 INFO - Contents: 09:04:29 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:04:29 INFO - Running post-action listener: _resource_record_post_action 09:04:29 INFO - Running post-action listener: set_extra_try_arguments 09:04:29 INFO - ##### 09:04:29 INFO - ##### Running populate-webroot step. 09:04:29 INFO - ##### 09:04:29 INFO - Running pre-action listener: _resource_record_pre_action 09:04:29 INFO - Running main action method: populate_webroot 09:04:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:04:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:04:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:04:29 INFO - '--tppagecycles', 09:04:29 INFO - '7'], 09:04:29 INFO - 'tests': ['tsvgm']}}, 09:04:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:04:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:04:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:04:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:04:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'tests': ['damp', 'tps']}, 09:04:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['damp', 'tps']}, 09:04:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:04:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:04:29 INFO - 'other': {'tests': ['a11yr', 09:04:29 INFO - 'ts_paint', 09:04:29 INFO - 'tpaint', 09:04:29 INFO - 'sessionrestore', 09:04:29 INFO - 'sessionrestore_no_auto_restore']}, 09:04:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['a11yr', 09:04:29 INFO - 'ts_paint', 09:04:29 INFO - 'tpaint', 09:04:29 INFO - 'sessionrestore', 09:04:29 INFO - 'sessionrestore_no_auto_restore']}, 09:04:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['a11yr', 09:04:29 INFO - 'ts_paint', 09:04:29 INFO - 'tpaint', 09:04:29 INFO - 'sessionrestore', 09:04:29 INFO - 'sessionrestore_no_auto_restore']}, 09:04:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['a11yr', 09:04:29 INFO - 'ts_paint', 09:04:29 INFO - 'tpaint', 09:04:29 INFO - 'sessionrestore', 09:04:29 INFO - 'sessionrestore_no_auto_restore']}, 09:04:29 INFO - 'other_l64': {'tests': ['a11yr', 09:04:29 INFO - 'ts_paint', 09:04:29 INFO - 'tpaint', 09:04:29 INFO - 'sessionrestore', 09:04:29 INFO - 'sessionrestore_no_auto_restore']}, 09:04:29 INFO - 'other_nol64': {'tests': ['a11yr', 09:04:29 INFO - 'ts_paint', 09:04:29 INFO - 'tpaint', 09:04:29 INFO - 'sessionrestore', 09:04:29 INFO - 'sessionrestore_no_auto_restore']}, 09:04:29 INFO - 'svgr': {'tests': ['tsvgx', 09:04:29 INFO - 'tsvgr_opacity', 09:04:29 INFO - 'tart', 09:04:29 INFO - 'tscrollx', 09:04:29 INFO - 'cart']}, 09:04:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['tsvgx', 09:04:29 INFO - 'tsvgr_opacity', 09:04:29 INFO - 'tart', 09:04:29 INFO - 'tscrollx', 09:04:29 INFO - 'cart']}, 09:04:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'tests': ['tp5o']}, 09:04:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'talos_options': ['--e10s'], 09:04:29 INFO - 'tests': ['tp5o']}, 09:04:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'talos_options': ['--xperf_path', 09:04:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:29 INFO - 'tests': ['tp5n']}, 09:04:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:29 INFO - 'talos_options': ['--e10s', 09:04:29 INFO - '--xperf_path', 09:04:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:29 INFO - 'tests': ['tp5n']}}, 09:04:29 INFO - 'talos.zip': {'path': '', 09:04:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:04:29 INFO - Running post-action listener: _resource_record_post_action 09:04:29 INFO - ##### 09:04:29 INFO - ##### Running create-virtualenv step. 09:04:29 INFO - ##### 09:04:29 INFO - Running pre-action listener: _resource_record_pre_action 09:04:29 INFO - Running main action method: create_virtualenv 09:04:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:04:29 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 09:04:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:04:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:04:29 INFO - Using real prefix '/usr' 09:04:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:04:29 INFO - Installing distribute.............................................................................................................................................................................................done. 09:04:31 INFO - Installing pip.................done. 09:04:31 INFO - Return code: 0 09:04:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:04:31 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')]} 09:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:31 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')]} 09:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:31 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 0x7fa23c52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e350>, '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 0x219f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219f6e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', '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 09:04:31 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 09:04:31 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 09:04:31 INFO - Using env: {'DISPLAY': ':0', 09:04:31 INFO - 'HOME': '/home/cltbld', 09:04:31 INFO - 'LANG': 'en_US.UTF-8', 09:04:31 INFO - 'LANGUAGE': 'en_US:en', 09:04:31 INFO - 'LOGNAME': 'cltbld', 09:04:31 INFO - 'MAIL': '/var/mail/cltbld', 09:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:31 INFO - 'MOZ_NO_REMOTE': '1', 09:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:31 INFO - 'NO_EM_RESTART': '1', 09:04:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:31 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:31 INFO - 'SHELL': '/bin/bash', 09:04:31 INFO - 'SHLVL': '1', 09:04:31 INFO - 'TERM': 'linux', 09:04:31 INFO - 'TMOUT': '86400', 09:04:31 INFO - 'USER': 'cltbld', 09:04:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', 09:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:31 INFO - '_': '/tools/buildbot/bin/python'} 09:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:32 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 09:04:32 INFO - Cleaning up... 09:04:32 INFO - Return code: 0 09:04:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:32 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 0x7fa23c52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e350>, '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 0x219f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219f6e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', '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 09:04:32 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 09:04:32 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 09:04:32 INFO - Using env: {'DISPLAY': ':0', 09:04:32 INFO - 'HOME': '/home/cltbld', 09:04:32 INFO - 'LANG': 'en_US.UTF-8', 09:04:32 INFO - 'LANGUAGE': 'en_US:en', 09:04:32 INFO - 'LOGNAME': 'cltbld', 09:04:32 INFO - 'MAIL': '/var/mail/cltbld', 09:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:32 INFO - 'MOZ_NO_REMOTE': '1', 09:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:32 INFO - 'NO_EM_RESTART': '1', 09:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:32 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:32 INFO - 'SHELL': '/bin/bash', 09:04:32 INFO - 'SHLVL': '1', 09:04:32 INFO - 'TERM': 'linux', 09:04:32 INFO - 'TMOUT': '86400', 09:04:32 INFO - 'USER': 'cltbld', 09:04:32 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', 09:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:32 INFO - '_': '/tools/buildbot/bin/python'} 09:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:32 INFO - Downloading/unpacking psutil>=0.7.1 09:04:32 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 09:04:32 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 09:04:32 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 09:04:32 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 09:04:32 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 09:04:32 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 09:04:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:04:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:34 INFO - Installing collected packages: psutil 09:04:34 INFO - Running setup.py install for psutil 09:04:34 INFO - building 'psutil._psutil_linux' extension 09:04:34 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 09:04:35 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 09:04:35 INFO - building 'psutil._psutil_posix' extension 09:04:35 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 09:04:35 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 09:04:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:35 INFO - Successfully installed psutil 09:04:35 INFO - Cleaning up... 09:04:35 INFO - Return code: 0 09:04:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:04:35 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')]} 09:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:35 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')]} 09:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:35 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 0x7fa23c52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e350>, '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 0x219f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219f6e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', '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 09:04:35 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 09:04:35 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 09:04:35 INFO - Using env: {'DISPLAY': ':0', 09:04:35 INFO - 'HOME': '/home/cltbld', 09:04:35 INFO - 'LANG': 'en_US.UTF-8', 09:04:35 INFO - 'LANGUAGE': 'en_US:en', 09:04:35 INFO - 'LOGNAME': 'cltbld', 09:04:35 INFO - 'MAIL': '/var/mail/cltbld', 09:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:35 INFO - 'MOZ_NO_REMOTE': '1', 09:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:35 INFO - 'NO_EM_RESTART': '1', 09:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:35 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:35 INFO - 'SHELL': '/bin/bash', 09:04:35 INFO - 'SHLVL': '1', 09:04:35 INFO - 'TERM': 'linux', 09:04:35 INFO - 'TMOUT': '86400', 09:04:35 INFO - 'USER': 'cltbld', 09:04:35 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', 09:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:35 INFO - '_': '/tools/buildbot/bin/python'} 09:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:04:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:04:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:04:37 INFO - Installing collected packages: mozsystemmonitor 09:04:37 INFO - Running setup.py install for mozsystemmonitor 09:04:37 INFO - Successfully installed mozsystemmonitor 09:04:37 INFO - Cleaning up... 09:04:37 INFO - Return code: 0 09:04:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa23c52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e350>, '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 0x219f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219f6e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', '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 09:04:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:04:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:04:37 INFO - Using env: {'DISPLAY': ':0', 09:04:37 INFO - 'HOME': '/home/cltbld', 09:04:37 INFO - 'LANG': 'en_US.UTF-8', 09:04:37 INFO - 'LANGUAGE': 'en_US:en', 09:04:37 INFO - 'LOGNAME': 'cltbld', 09:04:37 INFO - 'MAIL': '/var/mail/cltbld', 09:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:37 INFO - 'MOZ_NO_REMOTE': '1', 09:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:37 INFO - 'NO_EM_RESTART': '1', 09:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:37 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:37 INFO - 'SHELL': '/bin/bash', 09:04:37 INFO - 'SHLVL': '1', 09:04:37 INFO - 'TERM': 'linux', 09:04:37 INFO - 'TMOUT': '86400', 09:04:37 INFO - 'USER': 'cltbld', 09:04:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', 09:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:37 INFO - '_': '/tools/buildbot/bin/python'} 09:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:37 INFO - Downloading/unpacking blobuploader==1.2.4 09:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:39 INFO - Downloading blobuploader-1.2.4.tar.gz 09:04:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:04:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:04:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:40 INFO - Downloading docopt-0.6.1.tar.gz 09:04:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:04:40 INFO - Installing collected packages: blobuploader, requests, docopt 09:04:40 INFO - Running setup.py install for blobuploader 09:04:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:04:40 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:04:40 INFO - Running setup.py install for requests 09:04:40 INFO - Running setup.py install for docopt 09:04:40 INFO - Successfully installed blobuploader requests docopt 09:04:40 INFO - Cleaning up... 09:04:41 INFO - Return code: 0 09:04:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:41 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 0x7fa23c52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e350>, '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 0x219f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219f6e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', '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 09:04:41 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 09:04:41 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 09:04:41 INFO - Using env: {'DISPLAY': ':0', 09:04:41 INFO - 'HOME': '/home/cltbld', 09:04:41 INFO - 'LANG': 'en_US.UTF-8', 09:04:41 INFO - 'LANGUAGE': 'en_US:en', 09:04:41 INFO - 'LOGNAME': 'cltbld', 09:04:41 INFO - 'MAIL': '/var/mail/cltbld', 09:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:41 INFO - 'MOZ_NO_REMOTE': '1', 09:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:41 INFO - 'NO_EM_RESTART': '1', 09:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:41 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:41 INFO - 'SHELL': '/bin/bash', 09:04:41 INFO - 'SHLVL': '1', 09:04:41 INFO - 'TERM': 'linux', 09:04:41 INFO - 'TMOUT': '86400', 09:04:41 INFO - 'USER': 'cltbld', 09:04:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', 09:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:41 INFO - '_': '/tools/buildbot/bin/python'} 09:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:04:41 INFO - Running setup.py (path:/tmp/pip-PIOtSB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:04:41 INFO - Running setup.py (path:/tmp/pip-wC7J8E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:04:41 INFO - Running setup.py (path:/tmp/pip-p0UTB3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:04:41 INFO - Running setup.py (path:/tmp/pip-KyZ1vR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:04:41 INFO - Running setup.py (path:/tmp/pip-7Bqgzx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:04:41 INFO - Running setup.py (path:/tmp/pip-Cd8kEy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:04:41 INFO - Running setup.py (path:/tmp/pip-FBVD4W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:04:41 INFO - Running setup.py (path:/tmp/pip-GLIQp0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:04:41 INFO - Running setup.py (path:/tmp/pip-3ik8dW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:04:41 INFO - Running setup.py (path:/tmp/pip-LSFvS_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:04:41 INFO - Running setup.py (path:/tmp/pip-cB_BLM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:04:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:04:42 INFO - Running setup.py (path:/tmp/pip-_xhz_G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:04:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:04:42 INFO - Running setup.py (path:/tmp/pip-FzYs7g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:04:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:04:42 INFO - Running setup.py (path:/tmp/pip-YY9b8P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:04:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:04:42 INFO - Running setup.py (path:/tmp/pip-ZqA0It-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:04:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:04:42 INFO - Running setup.py (path:/tmp/pip-6BjGR6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:04:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:04:42 INFO - Running setup.py (path:/tmp/pip-Z3DGyn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:04:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:04:42 INFO - Running setup.py install for manifestparser 09:04:42 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Running setup.py install for mozcrash 09:04:42 INFO - Running setup.py install for mozdebug 09:04:42 INFO - Running setup.py install for mozdevice 09:04:42 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:04:42 INFO - Running setup.py install for mozfile 09:04:42 INFO - Running setup.py install for mozhttpd 09:04:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:04:43 INFO - Running setup.py install for mozinfo 09:04:43 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:04:43 INFO - Running setup.py install for mozInstall 09:04:43 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:04:43 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:04:43 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:04:43 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:04:43 INFO - Running setup.py install for mozleak 09:04:43 INFO - Running setup.py install for mozlog 09:04:43 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:04:43 INFO - Running setup.py install for moznetwork 09:04:43 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:04:43 INFO - Running setup.py install for mozprocess 09:04:43 INFO - Running setup.py install for mozprofile 09:04:43 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:04:43 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:04:43 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:04:43 INFO - Running setup.py install for mozrunner 09:04:43 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:04:43 INFO - Running setup.py install for mozscreenshot 09:04:44 INFO - Running setup.py install for moztest 09:04:44 INFO - Running setup.py install for mozversion 09:04:44 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:04:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:04:44 INFO - Cleaning up... 09:04:44 INFO - Return code: 0 09:04:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:44 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 0x7fa23c52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e350>, '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 0x219f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219f6e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', '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 09:04:44 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 09:04:44 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 09:04:44 INFO - Using env: {'DISPLAY': ':0', 09:04:44 INFO - 'HOME': '/home/cltbld', 09:04:44 INFO - 'LANG': 'en_US.UTF-8', 09:04:44 INFO - 'LANGUAGE': 'en_US:en', 09:04:44 INFO - 'LOGNAME': 'cltbld', 09:04:44 INFO - 'MAIL': '/var/mail/cltbld', 09:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:44 INFO - 'MOZ_NO_REMOTE': '1', 09:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:44 INFO - 'NO_EM_RESTART': '1', 09:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:44 INFO - 'SHELL': '/bin/bash', 09:04:44 INFO - 'SHLVL': '1', 09:04:44 INFO - 'TERM': 'linux', 09:04:44 INFO - 'TMOUT': '86400', 09:04:44 INFO - 'USER': 'cltbld', 09:04:44 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', 09:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:44 INFO - '_': '/tools/buildbot/bin/python'} 09:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:04:44 INFO - Running setup.py (path:/tmp/pip-eOJ8M2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:04:44 INFO - Running setup.py (path:/tmp/pip-W7p3Bg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:04:44 INFO - Running setup.py (path:/tmp/pip-lPrxeH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:04:44 INFO - Running setup.py (path:/tmp/pip-Sm2Vmk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:04:44 INFO - Running setup.py (path:/tmp/pip-2tALTY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:04:44 INFO - Running setup.py (path:/tmp/pip-_aYRAY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:04:44 INFO - Running setup.py (path:/tmp/pip-8ip4BA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:04:44 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)) 09:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:04:44 INFO - Running setup.py (path:/tmp/pip-3OHrH6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:04:45 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)) 09:04:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:04:45 INFO - Running setup.py (path:/tmp/pip-XcMLr5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:04:45 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)) 09:04:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:04:45 INFO - Running setup.py (path:/tmp/pip-wRFqGq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:04:45 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)) 09:04:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:04:45 INFO - Running setup.py (path:/tmp/pip-lhZfXH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:04:45 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)) 09:04:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:04:45 INFO - Running setup.py (path:/tmp/pip-mIAgce-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:04:45 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)) 09:04:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:04:45 INFO - Running setup.py (path:/tmp/pip-zUwCuH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:04:45 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)) 09:04:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:04:45 INFO - Running setup.py (path:/tmp/pip-4SjjFB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:04:45 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)) 09:04:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:04:45 INFO - Running setup.py (path:/tmp/pip-8j39C1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:04:45 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)) 09:04:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:04:45 INFO - Running setup.py (path:/tmp/pip-an9L9O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:04:45 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)) 09:04:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:04:45 INFO - Running setup.py (path:/tmp/pip-sC30TB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:04:45 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)) 09:04:45 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)) 09:04:45 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)) 09:04:45 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)) 09:04:45 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)) 09:04:45 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)) 09:04:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:47 INFO - Downloading blessings-1.6.tar.gz 09:04:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:04:47 INFO - Installing collected packages: blessings 09:04:47 INFO - Running setup.py install for blessings 09:04:47 INFO - Successfully installed blessings 09:04:47 INFO - Cleaning up... 09:04:47 INFO - Return code: 0 09:04:47 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:04:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:04:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:04:47 INFO - Reading from file tmpfile_stdout 09:04:47 INFO - Current package versions: 09:04:47 INFO - argparse == 1.2.1 09:04:47 INFO - blessings == 1.6 09:04:47 INFO - blobuploader == 1.2.4 09:04:47 INFO - docopt == 0.6.1 09:04:47 INFO - manifestparser == 1.1 09:04:47 INFO - mozInstall == 1.12 09:04:47 INFO - mozcrash == 0.16 09:04:47 INFO - mozdebug == 0.1 09:04:47 INFO - mozdevice == 0.47 09:04:47 INFO - mozfile == 1.2 09:04:47 INFO - mozhttpd == 0.7 09:04:47 INFO - mozinfo == 0.9 09:04:47 INFO - mozleak == 0.1 09:04:47 INFO - mozlog == 3.1 09:04:47 INFO - moznetwork == 0.27 09:04:47 INFO - mozprocess == 0.22 09:04:47 INFO - mozprofile == 0.27 09:04:47 INFO - mozrunner == 6.11 09:04:47 INFO - mozscreenshot == 0.1 09:04:47 INFO - mozsystemmonitor == 0.0 09:04:47 INFO - moztest == 0.7 09:04:47 INFO - mozversion == 1.4 09:04:47 INFO - psutil == 3.1.1 09:04:47 INFO - requests == 1.2.3 09:04:47 INFO - wsgiref == 0.1.2 09:04:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:04: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')]} 09:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fa23c52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e350>, '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 0x219f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219f6e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', '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 09:04:47 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 09:04:47 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 09:04:47 INFO - Using env: {'DISPLAY': ':0', 09:04:47 INFO - 'HOME': '/home/cltbld', 09:04:47 INFO - 'LANG': 'en_US.UTF-8', 09:04:47 INFO - 'LANGUAGE': 'en_US:en', 09:04:47 INFO - 'LOGNAME': 'cltbld', 09:04:47 INFO - 'MAIL': '/var/mail/cltbld', 09:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:47 INFO - 'MOZ_NO_REMOTE': '1', 09:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:47 INFO - 'NO_EM_RESTART': '1', 09:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:47 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:47 INFO - 'SHELL': '/bin/bash', 09:04:47 INFO - 'SHLVL': '1', 09:04:47 INFO - 'TERM': 'linux', 09:04:47 INFO - 'TMOUT': '86400', 09:04:47 INFO - 'USER': 'cltbld', 09:04:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', 09:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:47 INFO - '_': '/tools/buildbot/bin/python'} 09:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 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)) 09:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:04:48 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)) 09:04:48 INFO - Cleaning up... 09:04:48 INFO - Return code: 0 09:04:48 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:04:48 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')]} 09:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:48 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')]} 09:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:48 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 0x7fa23c52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e350>, '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 0x219f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219f6e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', '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 09:04:48 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 09:04:48 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 09:04:48 INFO - Using env: {'DISPLAY': ':0', 09:04:48 INFO - 'HOME': '/home/cltbld', 09:04:48 INFO - 'LANG': 'en_US.UTF-8', 09:04:48 INFO - 'LANGUAGE': 'en_US:en', 09:04:48 INFO - 'LOGNAME': 'cltbld', 09:04:48 INFO - 'MAIL': '/var/mail/cltbld', 09:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:48 INFO - 'MOZ_NO_REMOTE': '1', 09:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:48 INFO - 'NO_EM_RESTART': '1', 09:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:48 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:48 INFO - 'SHELL': '/bin/bash', 09:04:48 INFO - 'SHLVL': '1', 09:04:48 INFO - 'TERM': 'linux', 09:04:48 INFO - 'TMOUT': '86400', 09:04:48 INFO - 'USER': 'cltbld', 09:04:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', 09:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:48 INFO - '_': '/tools/buildbot/bin/python'} 09:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:48 INFO - Downloading/unpacking jsonschema 09:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:04:50 INFO - Downloading/unpacking functools32 (from jsonschema) 09:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:50 INFO - Downloading functools32-3.2.3-2.tar.gz 09:04:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:04:50 INFO - warning: no files found matching '*.txt' 09:04:50 INFO - no previously-included directories found matching 'build' 09:04:50 INFO - no previously-included directories found matching 'dist' 09:04:50 INFO - no previously-included directories found matching '.git*' 09:04:50 INFO - Installing collected packages: jsonschema, functools32 09:04:50 INFO - Running setup.py install for functools32 09:04:50 INFO - warning: no files found matching '*.txt' 09:04:50 INFO - no previously-included directories found matching 'build' 09:04:50 INFO - no previously-included directories found matching 'dist' 09:04:50 INFO - no previously-included directories found matching '.git*' 09:04:50 INFO - Successfully installed jsonschema functools32 09:04:50 INFO - Cleaning up... 09:04:50 INFO - Return code: 0 09:04:50 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:04:50 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')]} 09:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:50 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')]} 09:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:50 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 0x7fa23c52ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x219e350>, '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 0x219f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219f6e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', '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 09:04:50 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 09:04:50 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 09:04:50 INFO - Using env: {'DISPLAY': ':0', 09:04:50 INFO - 'HOME': '/home/cltbld', 09:04:50 INFO - 'LANG': 'en_US.UTF-8', 09:04:50 INFO - 'LANGUAGE': 'en_US:en', 09:04:50 INFO - 'LOGNAME': 'cltbld', 09:04:50 INFO - 'MAIL': '/var/mail/cltbld', 09:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:50 INFO - 'MOZ_NO_REMOTE': '1', 09:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:50 INFO - 'NO_EM_RESTART': '1', 09:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:04:50 INFO - 'PWD': '/builds/slave/test-pgo', 09:04:50 INFO - 'SHELL': '/bin/bash', 09:04:50 INFO - 'SHLVL': '1', 09:04:50 INFO - 'TERM': 'linux', 09:04:50 INFO - 'TMOUT': '86400', 09:04:50 INFO - 'USER': 'cltbld', 09:04:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', 09:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:50 INFO - '_': '/tools/buildbot/bin/python'} 09:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:50 INFO - Downloading/unpacking flake8 09:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:04:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:04:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:04:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:53 INFO - no previously-included directories found matching 'docs/_build' 09:04:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:04:53 INFO - Running setup.py install for pep8 09:04:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:53 INFO - no previously-included directories found matching 'docs/_build' 09:04:53 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:04:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:04:53 INFO - Cleaning up... 09:04:53 INFO - Return code: 0 09:04:53 INFO - Running post-action listener: _resource_record_post_action 09:04:53 INFO - Running post-action listener: _start_resource_monitoring 09:04:53 INFO - Starting resource monitoring. 09:04:53 INFO - ##### 09:04:53 INFO - ##### Running install step. 09:04:53 INFO - ##### 09:04:53 INFO - Running pre-action listener: _resource_record_pre_action 09:04:53 INFO - Running main action method: install 09:04:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:04:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:04:53 INFO - Reading from file tmpfile_stdout 09:04:53 INFO - Detecting whether we're running mozinstall >=1.0... 09:04:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:04:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:04:53 INFO - Reading from file tmpfile_stdout 09:04:53 INFO - Output received: 09:04:53 INFO - Usage: mozinstall [options] installer 09:04:53 INFO - Options: 09:04:53 INFO - -h, --help show this help message and exit 09:04:53 INFO - -d DEST, --destination=DEST 09:04:53 INFO - Directory to install application into. [default: 09:04:53 INFO - "/builds/slave/test-pgo"] 09:04:53 INFO - --app=APP Application being installed. [default: firefox] 09:04:53 INFO - mkdir: /builds/slave/test-pgo/build/application 09:04:53 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'] 09:04:53 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 09:05:08 INFO - Reading from file tmpfile_stdout 09:05:08 INFO - Output received: 09:05:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:05:08 INFO - Running post-action listener: _resource_record_post_action 09:05:08 INFO - ##### 09:05:08 INFO - ##### Running run-tests step. 09:05:08 INFO - ##### 09:05:08 INFO - Running pre-action listener: _resource_record_pre_action 09:05:08 INFO - Running main action method: run_tests 09:05:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:05:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:05:08 INFO - Python 2.7.3 09:05:08 INFO - Return code: 0 09:05:08 INFO - grabbing minidump binary from tooltool 09:05:08 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')]} 09:05:08 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 0x219e350>, '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 0x219f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219f6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:05:08 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 09:05:08 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 09:05:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:05:08 INFO - Return code: 0 09:05:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:05:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:05:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:05:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:05:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:05:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:05:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:05:09 INFO - Return code: 0 09:05:09 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/1455547221/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:05:09 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/1455547221/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost 09:05:09 INFO - Using env: {'DISPLAY': ':0', 09:05:09 INFO - 'HOME': '/home/cltbld', 09:05:09 INFO - 'LANG': 'en_US.UTF-8', 09:05:09 INFO - 'LANGUAGE': 'en_US:en', 09:05:09 INFO - 'LOGNAME': 'cltbld', 09:05:09 INFO - 'MAIL': '/var/mail/cltbld', 09:05:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:05:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:09 INFO - 'MOZ_NO_REMOTE': '1', 09:05:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:09 INFO - 'NO_EM_RESTART': '1', 09:05:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:05:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:05:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:05:09 INFO - 'SHELL': '/bin/bash', 09:05:09 INFO - 'SHLVL': '1', 09:05:09 INFO - 'TERM': 'linux', 09:05:09 INFO - 'TMOUT': '86400', 09:05:09 INFO - 'USER': 'cltbld', 09:05:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426', 09:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:09 INFO - '_': '/tools/buildbot/bin/python'} 09:05:09 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/1455547221/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] with output_timeout 3600 09:05:10 INFO - mozversion INFO | application_buildid: 20160215064021 09:05:10 INFO - mozversion INFO | application_changeset: 1ce5ee8b5c55f206baeb86085ea942984b4b5336 09:05:10 INFO - mozversion INFO | application_display_name: Nightly 09:05:10 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:05:10 INFO - mozversion INFO | application_name: Firefox 09:05:10 INFO - mozversion INFO | application_remotingname: firefox 09:05:10 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:05:10 INFO - mozversion INFO | application_vendor: Mozilla 09:05:10 INFO - mozversion INFO | application_version: 45.0 09:05:10 INFO - mozversion INFO | platform_buildid: 20160215064021 09:05:10 INFO - mozversion INFO | platform_changeset: 1ce5ee8b5c55f206baeb86085ea942984b4b5336 09:05:10 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:05:10 INFO - mozversion INFO | platform_version: 45.0 09:05:10 INFO - 2016-02-15 09:05:10,005 DEBUG : using testdate: 1455555910 09:05:10 INFO - 2016-02-15 09:05:10,005 DEBUG : actual date: 1455555910 09:05:10 INFO - 2016-02-15 09:05:10,117 INFO : starting webserver on 'localhost:34573' 09:05:10 INFO - 2016-02-15 09:05:10,118 INFO : Starting test suite talos-linux64-ix-012 09:05:10 INFO - 2016-02-15 09:05:10,118 INFO : Starting test dromaeo_css 09:05:10 INFO - 2016-02-15 09:05:10,118 DEBUG : operating with platform_type : linux_ 09:05:10 INFO - 2016-02-15 09:05:10,119 INFO : Initialising browser for dromaeo_css test... 09:05:10 INFO - 2016-02-15 09:05:10,160 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxXwha3/profile http://localhost:34573/getInfo.html 09:05:14 INFO - 2016-02-15 09:05:14,930 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:05:14 INFO - 2016-02-15 09:05:14,930 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:05:14 INFO - 2016-02-15 09:05:14,930 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:05:14 INFO - 2016-02-15 09:05:14,930 DEBUG : BROWSER_OUTPUT: __metrics 09:05:15 INFO - 2016-02-15 09:05:15,047 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] 09:05:16 INFO - 2016-02-15 09:05:16,121 INFO : Browser initialized. 09:05:16 INFO - 2016-02-15 09:05:16,122 INFO : Running cycle 1/1 for dromaeo_css test... 09:05:16 INFO - 2016-02-15 09:05:16,122 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxXwha3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:05:27 INFO - 2016-02-15 09:05:27,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 132849664 09:05:27 INFO - 2016-02-15 09:05:27,791 DEBUG : BROWSER_OUTPUT: 09:06:18 INFO - 2016-02-15 09:06:18,686 DEBUG : BROWSER_OUTPUT: 1455555978685 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] 09:08:27 INFO - 2016-02-15 09:08:27,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34573/tests/dromaeo/cssquery-ext.html) 09:08:28 INFO - 2016-02-15 09:08:28,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 236007424 09:08:28 INFO - 2016-02-15 09:08:28,091 DEBUG : BROWSER_OUTPUT: 09:11:30 INFO - 2016-02-15 09:11:30,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/dromaeo/cssquery-ext.html (next: http://localhost:34573/tests/dromaeo/cssquery-jquery.html) 09:11:30 INFO - 2016-02-15 09:11:30,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 211505152 09:11:30 INFO - 2016-02-15 09:11:30,714 DEBUG : BROWSER_OUTPUT: 09:14:32 INFO - 2016-02-15 09:14:32,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34573/tests/dromaeo/cssquery-mootools.html) 09:14:32 INFO - 2016-02-15 09:14:32,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 206802944 09:14:32 INFO - 2016-02-15 09:14:32,955 DEBUG : BROWSER_OUTPUT: 09:17:34 INFO - 2016-02-15 09:17:34,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34573/tests/dromaeo/cssquery-prototype.html) 09:17:35 INFO - 2016-02-15 09:17:35,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 197185536 09:17:35 INFO - 2016-02-15 09:17:35,206 DEBUG : BROWSER_OUTPUT: 09:20:37 INFO - 2016-02-15 09:20:37,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34573/tests/dromaeo/cssquery-yui.html) 09:20:38 INFO - 2016-02-15 09:20:38,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 198225920 09:20:38 INFO - 2016-02-15 09:20:38,203 DEBUG : BROWSER_OUTPUT: 09:23:40 INFO - 2016-02-15 09:23:40,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/dromaeo/cssquery-yui.html (next: http://localhost:34573/tests/dromaeo/cssquery-dojo.html) 09:23:40 INFO - 2016-02-15 09:23:40,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 241471488 09:23:40 INFO - 2016-02-15 09:23:40,621 DEBUG : BROWSER_OUTPUT: 09:23:40 INFO - 2016-02-15 09:23:40,623 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:23:40 INFO - 2016-02-15 09:23:40,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:23:40 INFO - 2016-02-15 09:23:40,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:23:40 INFO - 2016-02-15 09:23:40,623 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:23:40 INFO - 2016-02-15 09:23:40,624 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3254.5931758530182;3318.2865683877963;3341.5823022122217;3345.8327083645813;3376.9493457598132;5543.113101903697;5547.278853749012;5565;5576.163575463683;5586.190002449643;5524.944750552493;5544.251526043983;5549.223108764776;5557.972210138953;5560.555155587554;4983.975080124595;5063.5949124070075;5074.720890351029;5105.795768169269;5169.2504586835075;5000.249962505617;5057.924131138036;5121.974390128044;5124.92312615311;5130;5066.797328106872;5157.58739300855;5170.121079416489;5171.0692075426405;5188.558972487343;5162.354705661793;5240.318758561362;5245.108331583621;5250;5269.394019687708;4878.268259761029;4952.207646776498;4963.379577552806;5147.510986456281;5157.097507936133;5363.731813409314;5442.102053161224;5459.808906688287;5461.399246082928;5471.644343117685;6010.459058684695;6015.879682406371;6026.337102918676;6047.183630209909;6062.939370606326;5798.623089499211;5866.560007999417;5877.52979761618;6007.789727359565;6084.787032453887;5623.718814059281;5626.606137570372;5654.349749778746;5656.971715141439;5672.06410942194;6108.602940808833;6112.969435152885;6114.205153330127;6116.5718399711595;6117.265928088658;5649.209110724501;5761.567882408753;5829.912551311733;5934.762609495572;5967.37342579023;6031.547633927473;6048.939510604926;6061.333253342129;6063.54523410746;6066.908996365058;5758.3090029196765;5984.311804142492;6012.248468941382;6017.69911504423;6020.4280593343565;5886.264216972879;5899.46904778572;5968.1644569760265;5969.164316995624;5991.221141251696;4563.612092972068;4617.145828021827;4647.651426143053;4648.442186937589;4671.369365135663;3968.6428221460205;4057.006033521806;4151.377293406013;4152.1072969311745;4161.188568229166;5586.469285417878;5658.0381335173115;5681.715914204273;5681.829545113653;5699.259096317535;6046.697665116814;6093.421124993119;6097.298810636745;6098.176746139215;6114.327423983358;5472.26124473199;5567.192757050286;5702.572307076903;5717.456841600041;5719.170720245541;5120.308758317579;5179.249008893689;5183.222516622537;5188.325517682752;5220.347456567929;6119.785807496716;6201.224846894138;6204.689765511616;6205.81382558524;6213.844653883689;5719.628224165416;5916.171735957056;6038.094285857156;6069.393060693896;6091.360407157184;6105.473631592102;6127.111568822406;6130.264368275835;6136.693165341626;6140.960224688808;5861.1501332307425;5895.557833162444;5922.230110085661;5929.970350148222;5952.0476723724;5796.04365279741;5883.529317654492;6038.215032045981;6047.0929360596265;6165.383461653799;5912.556558258234;5914.4381283777975;5935.139404786368;5943.138244954544;5973.611715238496;5896.498797602252;5927.762889484372;5929.733162007634;5935.109733540004;5946.048632218824;5579.525740311957;5657.519110875622;5689.943100568941;5742.339630942495;5808.941910581009;5876.706164691834;5907.793227237026;5917.704114794157;5956.97021514907;5977.372375900468;5561.499465048003;5838.503727183067;5841.766329346779;5843.474087332161;5844.064949608212 09:23:40 INFO - 2016-02-15 09:23:40,625 DEBUG : BROWSER_OUTPUT: |1;ext.html;580.892534881047;619.4765423217381;627.0281064350256;628.4689437425374;642.6465444005798;32182.517262241057;32995.835020824925;33016.66983330169;33017.5047374289;39634;44505.77747111268;44722.77638611811;45059.77470112653;45150.548494515126;45282.773586132105;8913.598888050037;9111.635534578609;9115.95442022789;9120.58957346921;9146.588403521824;8111.878321825177;8293.917060829404;8296.170382961685;8995.055519170492;10625.73435664107;10769.515371808247;10851.403172825492;10870.836937445945;10873.83689244662;10874.67375978718;10697.732556686067;10772.138228941705;10772.73068173294;10785.946070269638;10804.72988175294;10667.093297069758;10800.891991080067;10804.78390432187;10805.83791243132;10815.621453249098;42601.14797704059;43025.78487107576;43051.569484305066;43130.784346078384;43144.56855431468;3582.140286331288;3608.8736894208578;3641.617630148849;3901.765894046338;4214.936775948363;32075.83962080198;32126.839365803255;32280.838595806872;32367.352652947044;32368.028959131265;3819.866304679351;3866.2460820140086;3906.8632597858937;3949.723519353646;4101.241270364992;294019;295109;296023;296070;389555.0522247399;46292.537074629494;66867;68385.3161468379;68461;68810;60254.397456025756;60768.39231607716;60871.391286087455;60883;60889.39110608926;16261.105639189958;16580.58548536296;16618.50144495667;16655.083970381744;16655.3337866484;12400.31798251105;12545.749085018431;12567;12574.748505029847;12579.11946163778;19848.20607175697;19958.401247962585;19983.900080499505;20122.094505747278;20128.094235759425;7774.30031297186;7818;7912.367010639135;7915.12933577306;8063.153368896299;931.7344556801414;1060.2366296266675;1103.862017247844;1110.6834552152598;1119.361963680694;29239.269018274288;29241.415171696874;29354.412911741645;30352.84823575868;30366.696333036387;1059.0944742245424;1077.4451157653814;1083.6044843632176;1084.7721978384627;1215.3862299538853;13432.597022089352;14161.362738676784;14256.144631322153;15187.848121518864;15957.680846383008;262210;264338;265706;265755;266543;49905.75047124814;50449.49550504448;50672.493275067514;50699.49300507022;50738.23892641613;1351.4121357209644;1354.2348573056388;1465.377214683755;1481.2149560732828;1494.125936327239;26111;26995.460090798468;27580.58629120605;28371.57442638321;28743.281417964718;43253.56746432621;43704.56295437132;43775;43847.78076109599;43889.122217556105;228627;229369;229878;230023;230694;32495.375231238817;32743.836280818443;33059;33104.50343244901;33239.16902077467;43055;43556.56443435652;43753.34369984389;44054;44471;36520.63479365173;37027.62972370242;38228.235435291695;38469.42295865508;38480.422793658676;35783.46324805078;36355.45466818053;36751.816240918626;36951.445728313556;37297.627023729416;37631.62368376391;37682;38012.80993595014;38144;38604.613953861226;29745.405091898472;30543.2364190897;30705.692943070284;31788.682113178573;31828.840855795574;24143.51712965766;24267.27198184057;24283.757162428148;24467.877660611583;24650.63024054605 09:23:40 INFO - 2016-02-15 09:23:40,626 DEBUG : BROWSER_OUTPUT: |2;jquery.html;389.5870377399954;397.0807580451257;400.0618549501419;400.57539008650815;403.3586597310276;14292.428302867898;17419.216135273913;17827.910860445696;17843.910780446113;20127.29554465594;17442.30230790767;18090;19535.21859125637;19554.511137221576;19572.11925463354;6186.257649082117;6337.493000559967;6343.714532846033;6344.429001389874;6344.524160687944;5329.893402131955;5452.890942181154;5455.8363249102595;6284.183056202687;6341.71462284196;4008.719389642726;4557.407537020183;5429.348478182624;5441.319835020622;5444.265024221739;5648.350439699446;5673.971630141844;5698.259226300575;5708.800191993281;5709.229254050691;5420.972895135499;5472.835814925558;5484.862878428032;5585.469380408896;5608.971955140199;13105.541306054241;13474.797878031739;13479.460821567125;21101.47246318839;21339.35981920545;2194.133317339642;2212.192549719357;2234.9329520114425;2277.8974946127464;2405.134151705402;9350;9561.665341713007;10157.847632285522;11284.379359135244;13606.251656158907;1863.245385618813;1877.8216069473378;1926.0273561851316;1928.392556344747;1936.8353689936373;66726;67905.32094679089;68921.31078689199;69997;70196;11327.886721132683;11374.658760237206;11403.201775875608;11420.257683250727;11497.080233581293;15023;15039.624009399853;15096.698066038618;15137.848621513864;15156.545303640909;8249.505029698237;8276.627551760184;8279.213474720013;8297.8340433191;8318;7908.960455197687;7928.286454219033;7933.761987140395;7987.480813747088;7999.0801057877925;4471;4498.257787465097;4865.781039853215;4982.078315511642;4995.075910956485;1732.0087822812466;1799.3972019373657;1933.709943508485;1938.70919362094;2017.9091940862697;909.3043821476575;950.538988590533;1036.616451912782;1054.483303181451;1113.832925061231;17347.479575612753;17735.911320443574;17979.73030404545;18038.639227215383;18148.455546333633;964.5804075227298;971.6356366362614;982.3516479123887;985.8521221816785;1052.936823790575;7380.446466515033;10231.13035391985;10298.22763292741;10299.609552710439;10339.327943683636;416591;417758;446911;558553;561172;84480.57759711162;87484.5625771867;88494;88852;89636.5518172418;1172.7419967607113;1203.9337836418906;1211.7273613437083;1219.3598360860442;1221.1390969366753;16109.355625774837;16130.193490325672;16177.919110404373;16335.59161020984;16568.83431165673;36585.45121823228;36755.44866826946;37032.814835925645;37516.81241593775;38343;53614;54220.18669720036;54328.72835635796;56611.71694141503;57131.71434142803;10115.595376185165;10254.487275636338;10457.215708821717;10538.525766340379;10543.57825686964;12363.505459781867;12375.62873113808;12465.750684986067;14666.41334346657;18839.529011774815;15084.622884427537;15275.236238187825;15291.923540382228;15501.224938752792;15928.522144335688;14506.34721437559;14916.105033698013;15034;15108.169050702318;15750.212489375715;15785.842141578896;15884.761728573849;16034.839651603801;16040.919795401414;16067.598310042342;10385.117265032557;10402.687919362432;10522.684319470429;10683.94658026705;10688.305260158066;10829.783404332027;12196.939015304866;14912.701745965236;15143.167125808186;15513.45702900393 09:23:40 INFO - 2016-02-15 09:23:40,627 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1561.6642421879294;1575.1887777794432;1781.4566557200064;1821.8633602479813;1852.2498388152799;7782.105057918334;8060.234277743612;8063.032436107668;8063.233992770692;8081.757547273592;6729.629870357128;6818.147731533559;7685.807854803633;7764.262395072473;7876.173001834811;2293.20884294918;2358.6344116661944;2385.2128797496785;2385.7017872765905;2387.6776635154292;2068.6586713192305;2277.943051423711;2306.042992158261;2336.077249486452;2336.754640762721;2043.8467114966363;2325.430269583946;2344.906203751848;2360.799332056777;2371.027878569787;2287.794098531132;2290.4273931517123;2296.1963312840458;2332.090484710964;2332.7783860533223;2348.553774782803;2355.564220619191;2376.9049238030457;2392.2823153054014;2394.724606670238;7981.760547183594;8135.715249966282;8159.428839981204;8165.2243036911395;8172.713955011546;4887.120318342697;4990.476000019982;4997.5002499749735;5000.199968005102;5003.5997120230295;3168.2396224905856;3180.634227063871;3184.2198661327893;3189.2345836999184;3256.2836176041233;916.4867674102458;939.196986576481;951.286535098676;956.3544607390054;1036.331566139843;11146.275492092987;11166.274192177483;11168.776624467546;11179.888201118047;11206.719832004184;4404.11917616478;4456.5766252205985;4457.796394973339;4467.709598876063;4522.389477420572;9422.387544809566;9437.669681561112;9445.858312125323;9457.810843783085;9474.431534107976;4947.431045429822;4953.43035550909;4965;4970.826021089317;5003.424606170264;4545.431821022372;4561.521040290788;4563.155816174019;4565.429321334833;4573.199690054227;3833.9041523962123;3901.7268791184347;3908.159745654641;3923.2938071146896;3928.724989250782;1136.3295655563256;1165.7493638867516;1205.8070708686569;1261.9305938173304;1273.2933222061658;1195.3545085653823;1199.5501686867424;1237.7586370657816;1475.6753514226853;1477.0030229594981;7501.624918754041;7514.586697731568;7588.886166707503;7597.658105385271;7601.961990190013;1180.6812160716559;1192.9940350298193;1213.8725433829497;1216.9452374643163;1233.2477188914754;6001.969990150109;6073.082861554294;6149.96925015381;6154.815355539341;6195;9360.157585817173;9702.563384647567;9798.951005244928;9831.213502919893;9858;9543.188828949616;9617.182539484222;9721.513924303756;9731.172850307661;9743.853842192373;7365.52124111931;7439.51643143194;7522.849543009109;7529.548227106501;7535.434842386843;7447.106347238366;7529.962350188214;7544.924550754642;7548.245175482628;7581.658825352983;8690.478571285743;8722.91277087221;8768.386212965286;8887.022427533095;8892.59983300766;8910.198082172636;8931.821363572562;9108.043655416086;9125.908740912506;9216.815663686555;7335.339819416278;7345.338919497271;7364.968904353288;7391.556506609621;7412.0364352633815;7730.884036739566;7795.844083118419;7820.804479888048;7880.33017193522;7993.080795708568;6112.449879510866;7008.439324853897;7329.560226386434;7388.667509961957;7426.591537465275;7236.819079523054;7282.854342913218;7309.086364204474;7353.522021068614;7393.07586551681;6892.172939247323;7456.627168641655;7485.363744081814;7508.662110204945;7517.398608111447;6496.707648155939;6519.445847103049;6523.086767852599;6528.183977002875;6539.607623542603;7013.123359580052;7029.402500787491;7044.788656340318;7045.365917067488;7048.224695283618 09:23:40 INFO - 2016-02-15 09:23:40,627 DEBUG : BROWSER_OUTPUT: |4;prototype.html;362.521471657412;363.919937613725;364.2496457297965;368.08347215433577;370.52202658570445;5968.5523585731025;6060.757569697213;6136.877262454759;6154.522914500516;6167.414095660916;5877;6042.395760423967;6069.362716914716;6078.908816367747;6079.240094988127;4720.787564559586;4721.268203428457;4722.527747225285;4726.716397016182;4727.929081063787;4518.457785065797;4601.7238965662;4627.490975992638;4724.338592597039;4775.5463230993;4715.92926106107;4723.409573803275;4724.645651576128;4730.81076756931;4739.952600474003;4702.882427939312;4713.717176969359;4718.339432479438;4728.172569800306;4737.099951009297;4167.10407262437;4169.91660166795;4170.270202714543;4171.91656166875;4191.811368488426;5645.125005624135;5808.97095514524;5813.360530341659;5831.912521312183;5847.766089356421;5508.862278443031;5509.283793106911;5514.172874068881;5515.944840551583;5523.28197334344;6446.484281257488;6454.903176452357;6457.903131453032;6460.870782584369;6464.547481676284;4518.796654150571;4608.032313214229;4624.7687615619425;4631.9346550293285;4632.351470794091;6745.865082698368;6747.224069232052;6755.763548275836;6755.797326080176;6760.18877734675;4730.716157030589;4733.692309999839;4735.384400027974;4737.478877323491;4742.454617718938;4771.570558649738;4788.04239152171;4792.305115758196;4794.496577859344;4794.7362895040405;5385.380681221632;5473.75368108436;5493.313335833021;5495.505404513613;5497.147942068986;6492.772752953719;6525.706343214567;6531.216254049449;6539.411452969255;6545.934540654628;1679;1702.6935151672817;1702.838230368113;1704.1734758642049;1704.9147542623068;1163.784699830534;1169.2341516306833;1169.8888605582456;1191.136426091077;1198.9580364687195;6351.96824015877;6355.205599300088;6364.7135878885565;6370.490360771128;6370.872582548323;6515.609063456113;6605.933940660628;6677.332266773284;6754.45964322853;6769.458443324522;6320.399562041599;6358.491320694426;6384.265809431975;6391.169148010729;6398.552101352953;3618.5295911531334;3651.1967367179177;3655.250673611903;3655.7440979131206;3656.634336566375;6753.358430949052;6944.548604340702;6949.687264073129;6957.234704182536;6966.79099627012;6914.585124892523;6916.6541672916155;6924.826879328057;6931.341522555349;6968.930310696828;6936.098307220029;6961.547499412522;6969.16370035599;6971.860562788817;6977.1278590176225;6660.367265109807;6781.694823732845;6789.694463749044;6792.150981127359;6797.28628494001;6684.4652427804685;6692.899606506004;6694.59832410057;6697.229818570732;6703.564268322543;6962.547434416747;6966.373026427443;6968.756093536702;6972.198197207386;6973.6164510952385;4562.520935301745;4689.788959496899;4690.953090469188;4695.694779839299;4701.764911754331;6761.492888033319;6763.154605674291;6767.89848152288;6773.001964420606;6773.153355830521;6569.441597464269;6582.703778329891;6585.374389432996;6590.637514936724;6602.3397660233595;6427.164468619049;6569.9343006569325;6621;6627.966860165861;6631.834204144742;6481.870362592627;6512.511561632991;6524.412802847766;6525.771597994048;6526.184226971629;6655.434288085567;6657.500687448364;6658.334166583303;6664.067030615621;6665.233498147775;6205.162303089025;6351.96824015877;6362.840928976812;6486.383793539606;6503.934960650522 09:23:40 INFO - 2016-02-15 09:23:40,628 DEBUG : BROWSER_OUTPUT: |5;yui.html;775.1899265267795;807.2250639386189;828.680957831235;829.8921140251766;865.6970060478833;14370;14778.556643300692;14830.406783728638;14835.332410041547;14848;13678.931605341984;13770.036097473181;13810.240436775974;13816.447342106329;13834.23911684857;729.438332483987;734.636355004271;865.7878819689154;878.556329053827;886.3883920095146;889.7597648634865;893.5264309915755;896.2605850173633;900.4822227219342;903.1510380242551;915.1854849184232;921.7373048681127;922.077922077922;922.4695799915042;922.7923717163652;756.7691853984533;760.646299470746;915.890093188815;927.091450378626;928.1321963963716;687.0552989639247;687.4706476013491;687.6492988575812;687.6596084937988;687.7730348984823;13720.108192967526;13925.164490130624;14033.368498417494;14034.087784293988;14046.85953140476;12620.495180192782;13005.804912926315;13120.737585248336;13138.802917956238;13235;9601.711948641552;9758.463284519348;9806;9843.360181588245;9913;3763.172102137525;3763.322601931651;3765.265773174232;3799.430085487199;3820.0640842993644;47973.280400794014;48312.516874831505;50416.74791626018;50555.24167137459;50589.494105058846;10275.126614237724;10275.691729248134;10346.948265258625;10517.421541815274;10638.255322127532;17546.122693865254;18024.36914707979;18064.36774712879;18149.183286752126;18152.364667236583;7635.923640763633;7685.807854803563;7745.264199901;7820.374370050382;7885.487443316166;4793.832215872428;4818.951810481921;4901.164633180187;4922.680025798311;4944.208926571803;3189.378071276079;3224.1294850390263;3225.4355487790012;3233.078572606843;3241.2059045533997;555.6188316158023;567.2427309541808;567.6026781253057;575.3814649252071;580.6283978253921;677.7187467201056;693.1647364925253;695.0651373902093;731.1847290271415;739.4010851210537;8655.740327790176;9008.59461324242;9082.636694532144;9099.590518426687;9282.0717928208;586.9005000074476;691.5919607431639;697.052009267396;714.6891102370486;714.8606021825798;4301.41930839339;4314.331278651814;4384.583464570861;4420.778961051935;4471.28459446487;64003.35996640067;64173;64413.677931610044;64622.67688661526;65637.67181164159;54537.181942270894;54985.1752223717;55288;55706;55896.72051639716;50081.24878126831;50327.496725033016;50630.49369506331;50708.74645626822;50750.74624626853;8840.071792461698;8929.196372326262;9108.362414630912;9210.078992100736;9305.581248843682;37399.813000934824;37867;38077.42883856689;38139;38761.80619096886;44573;50036;50288.49711502838;51762.48237517727;51968.22047669212;11078.05836503874;11149.498272577592;11191.832122518006;11196.384198868815;11225.214235003472;13031.739365212832;13479.797803033158;13728;13819.170849749047;14321.212333321351;11855.34795586251;12330.445129968994;12674.16988185445;12721.173123746927;12814.807777883152;12041.819372709591;12136.75726485483;12299.139060266054;12495.312757798409;12768.425420855898;10251.333663311862;10306.381617102697;11306.230216326476;11453.312801231952;11708.824367634663;9482.336236463658;9836.901630983884;10358.5338659762;10535.473226338805;10936.453177340942;9905.306628535933;10092.848607271044;10251.58993640246;10354.792904141725;10476.266661333939 09:23:40 INFO - 2016-02-15 09:23:40,629 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:23:40 INFO - 2016-02-15 09:23:40,629 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:23:40 INFO - 2016-02-15 09:23:40,629 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,748 09:23:40 INFO - 2016-02-15 09:23:40,629 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:23:40 INFO - 2016-02-15 09:23:40,629 DEBUG : BROWSER_OUTPUT: __startTimestamp1455557020622__endTimestamp 09:23:40 INFO - 2016-02-15 09:23:40,629 DEBUG : BROWSER_OUTPUT: 09:23:40 INFO - 2016-02-15 09:23:40,629 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:23:40 INFO - 2016-02-15 09:23:40,629 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:23:40 INFO - 2016-02-15 09:23:40,630 DEBUG : BROWSER_OUTPUT: 09:23:40 INFO - 2016-02-15 09:23:40,630 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5566.68 Median:5758.31 stddev:619.05 (10.8%) stddev-sans-first:593.78 09:23:40 INFO - 2016-02-15 09:23:40,630 DEBUG : BROWSER_OUTPUT: Values: 3254.6 3318.3 3341.6 3345.8 3376.9 5543.1 5547.3 5565.0 5576.2 5586.2 5524.9 5544.3 5549.2 5558.0 5560.6 4984.0 5063.6 5074.7 5105.8 5169.3 5000.2 5057.9 5122.0 5124.9 5130.0 5066.8 5157.6 5170.1 5171.1 5188.6 5162.4 5240.3 5245.1 5250.0 5269.4 4878.3 4952.2 4963.4 5147.5 5157.1 5363.7 5442.1 5459.8 5461.4 5471.6 6010.5 6015.9 6026.3 6047.2 6062.9 5798.6 5866.6 5877.5 6007.8 6084.8 5623.7 5626.6 5654.3 5657.0 5672.1 6108.6 6113.0 6114.2 6116.6 6117.3 5649.2 5761.6 5829.9 5934.8 5967.4 6031.5 6048.9 6061.3 6063.5 6066.9 5758.3 5984.3 6012.2 6017.7 6020.4 5886.3 5899.5 5968.2 5969.2 5991.2 4563.6 4617.1 4647.7 4648.4 4671.4 3968.6 4057.0 4151.4 4152.1 4161.2 5586.5 5658.0 5681.7 5681.8 5699.3 6046.7 6093.4 6097.3 6098.2 6114.3 5472.3 5567.2 5702.6 5717.5 5719.2 5120.3 5179.2 5183.2 5188.3 5220.3 6119.8 6201.2 6204.7 6205.8 6213.8 5719.6 5916.2 6038.1 6069.4 6091.4 6105.5 6127.1 6130.3 6136.7 6141.0 5861.2 5895.6 5922.2 5930.0 5952.0 5796.0 5883.5 6038.2 6047.1 6165.4 5912.6 5914.4 5935.1 5943.1 5973.6 5896.5 5927.8 5929.7 5935.1 5946.0 5579.5 5657.5 5689.9 5742.3 5808.9 5876.7 5907.8 5917.7 5957.0 5977.4 5561.5 5838.5 5841.8 5843.5 5844.1 09:23:40 INFO - 2016-02-15 09:23:40,630 DEBUG : BROWSER_OUTPUT: 09:23:40 INFO - 2016-02-15 09:23:40,630 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44925.96 Median:32619.61 stddev:71073.28 (217.9%) stddev-sans-first:71194.66 09:23:40 INFO - 2016-02-15 09:23:40,630 DEBUG : BROWSER_OUTPUT: Values: 580.9 619.5 627.0 628.5 642.6 32182.5 32995.8 33016.7 33017.5 39634.0 44505.8 44722.8 45059.8 45150.5 45282.8 8913.6 9111.6 9116.0 9120.6 9146.6 8111.9 8293.9 8296.2 8995.1 10625.7 10769.5 10851.4 10870.8 10873.8 10874.7 10697.7 10772.1 10772.7 10785.9 10804.7 10667.1 10800.9 10804.8 10805.8 10815.6 42601.1 43025.8 43051.6 43130.8 43144.6 3582.1 3608.9 3641.6 3901.8 4214.9 32075.8 32126.8 32280.8 32367.4 32368.0 3819.9 3866.2 3906.9 3949.7 4101.2 294019.0 295109.0 296023.0 296070.0 389555.1 46292.5 66867.0 68385.3 68461.0 68810.0 60254.4 60768.4 60871.4 60883.0 60889.4 16261.1 16580.6 16618.5 16655.1 16655.3 12400.3 12545.7 12567.0 12574.7 12579.1 19848.2 19958.4 19983.9 20122.1 20128.1 7774.3 7818.0 7912.4 7915.1 8063.2 931.7 1060.2 1103.9 1110.7 1119.4 29239.3 29241.4 29354.4 30352.8 30366.7 1059.1 1077.4 1083.6 1084.8 1215.4 13432.6 14161.4 14256.1 15187.8 15957.7 262210.0 264338.0 265706.0 265755.0 266543.0 49905.8 50449.5 50672.5 50699.5 50738.2 1351.4 1354.2 1465.4 1481.2 1494.1 26111.0 26995.5 27580.6 28371.6 28743.3 43253.6 43704.6 43775.0 43847.8 43889.1 228627.0 229369.0 229878.0 230023.0 230694.0 32495.4 32743.8 33059.0 33104.5 33239.2 43055.0 43556.6 43753.3 44054.0 44471.0 36520.6 37027.6 38228.2 38469.4 38480.4 35783.5 36355.5 36751.8 36951.4 37297.6 37631.6 37682.0 38012.8 38144.0 38604.6 29745.4 30543.2 30705.7 31788.7 31828.8 24143.5 24267.3 24283.8 24467.9 24650.6 09:23:40 INFO - 2016-02-15 09:23:40,630 DEBUG : BROWSER_OUTPUT: 09:23:40 INFO - 2016-02-15 09:23:40,630 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28257.31 Median:19563.32 stddev:79601.55 (406.9%) stddev-sans-first:79797.35 09:23:40 INFO - 2016-02-15 09:23:40,632 DEBUG : BROWSER_OUTPUT: Values: 389.6 397.1 400.1 400.6 403.4 14292.4 17419.2 17827.9 17843.9 20127.3 17442.3 18090.0 19535.2 19554.5 19572.1 6186.3 6337.5 6343.7 6344.4 6344.5 5329.9 5452.9 5455.8 6284.2 6341.7 4008.7 4557.4 5429.3 5441.3 5444.3 5648.4 5674.0 5698.3 5708.8 5709.2 5421.0 5472.8 5484.9 5585.5 5609.0 13105.5 13474.8 13479.5 21101.5 21339.4 2194.1 2212.2 2234.9 2277.9 2405.1 9350.0 9561.7 10157.8 11284.4 13606.3 1863.2 1877.8 1926.0 1928.4 1936.8 66726.0 67905.3 68921.3 69997.0 70196.0 11327.9 11374.7 11403.2 11420.3 11497.1 15023.0 15039.6 15096.7 15137.8 15156.5 8249.5 8276.6 8279.2 8297.8 8318.0 7909.0 7928.3 7933.8 7987.5 7999.1 4471.0 4498.3 4865.8 4982.1 4995.1 1732.0 1799.4 1933.7 1938.7 2017.9 909.3 950.5 1036.6 1054.5 1113.8 17347.5 17735.9 17979.7 18038.6 18148.5 964.6 971.6 982.4 985.9 1052.9 7380.4 10231.1 10298.2 10299.6 10339.3 416591.0 417758.0 446911.0 558553.0 561172.0 84480.6 87484.6 88494.0 88852.0 89636.6 1172.7 1203.9 1211.7 1219.4 1221.1 16109.4 16130.2 16177.9 16335.6 16568.8 36585.5 36755.4 37032.8 37516.8 38343.0 53614.0 54220.2 54328.7 56611.7 57131.7 10115.6 10254.5 10457.2 10538.5 10543.6 12363.5 12375.6 12465.8 14666.4 18839.5 15084.6 15275.2 15291.9 15501.2 15928.5 14506.3 14916.1 15034.0 15108.2 15750.2 15785.8 15884.8 16034.8 16040.9 16067.6 10385.1 10402.7 10522.7 10683.9 10688.3 10829.8 12196.9 14912.7 15143.2 15513.5 09:23:40 INFO - 2016-02-15 09:23:40,632 DEBUG : BROWSER_OUTPUT: 09:23:40 INFO - 2016-02-15 09:23:40,632 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5684.16 Median:6533.90 stddev:2928.81 (44.8%) stddev-sans-first:2920.63 09:23:40 INFO - 2016-02-15 09:23:40,632 DEBUG : BROWSER_OUTPUT: Values: 1561.7 1575.2 1781.5 1821.9 1852.2 7782.1 8060.2 8063.0 8063.2 8081.8 6729.6 6818.1 7685.8 7764.3 7876.2 2293.2 2358.6 2385.2 2385.7 2387.7 2068.7 2277.9 2306.0 2336.1 2336.8 2043.8 2325.4 2344.9 2360.8 2371.0 2287.8 2290.4 2296.2 2332.1 2332.8 2348.6 2355.6 2376.9 2392.3 2394.7 7981.8 8135.7 8159.4 8165.2 8172.7 4887.1 4990.5 4997.5 5000.2 5003.6 3168.2 3180.6 3184.2 3189.2 3256.3 916.5 939.2 951.3 956.4 1036.3 11146.3 11166.3 11168.8 11179.9 11206.7 4404.1 4456.6 4457.8 4467.7 4522.4 9422.4 9437.7 9445.9 9457.8 9474.4 4947.4 4953.4 4965.0 4970.8 5003.4 4545.4 4561.5 4563.2 4565.4 4573.2 3833.9 3901.7 3908.2 3923.3 3928.7 1136.3 1165.7 1205.8 1261.9 1273.3 1195.4 1199.6 1237.8 1475.7 1477.0 7501.6 7514.6 7588.9 7597.7 7602.0 1180.7 1193.0 1213.9 1216.9 1233.2 6002.0 6073.1 6150.0 6154.8 6195.0 9360.2 9702.6 9799.0 9831.2 9858.0 9543.2 9617.2 9721.5 9731.2 9743.9 7365.5 7439.5 7522.8 7529.5 7535.4 7447.1 7530.0 7544.9 7548.2 7581.7 8690.5 8722.9 8768.4 8887.0 8892.6 8910.2 8931.8 9108.0 9125.9 9216.8 7335.3 7345.3 7365.0 7391.6 7412.0 7730.9 7795.8 7820.8 7880.3 7993.1 6112.4 7008.4 7329.6 7388.7 7426.6 7236.8 7282.9 7309.1 7353.5 7393.1 6892.2 7456.6 7485.4 7508.7 7517.4 6496.7 6519.4 6523.1 6528.2 6539.6 7013.1 7029.4 7044.8 7045.4 7048.2 09:23:40 INFO - 2016-02-15 09:23:40,632 DEBUG : BROWSER_OUTPUT: 09:23:40 INFO - 2016-02-15 09:23:40,632 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5484.37 Median:6262.78 stddev:1632.79 (26.1%) stddev-sans-first:1591.47 09:23:40 INFO - 2016-02-15 09:23:40,632 DEBUG : BROWSER_OUTPUT: Values: 362.5 363.9 364.2 368.1 370.5 5968.6 6060.8 6136.9 6154.5 6167.4 5877.0 6042.4 6069.4 6078.9 6079.2 4720.8 4721.3 4722.5 4726.7 4727.9 4518.5 4601.7 4627.5 4724.3 4775.5 4715.9 4723.4 4724.6 4730.8 4740.0 4702.9 4713.7 4718.3 4728.2 4737.1 4167.1 4169.9 4170.3 4171.9 4191.8 5645.1 5809.0 5813.4 5831.9 5847.8 5508.9 5509.3 5514.2 5515.9 5523.3 6446.5 6454.9 6457.9 6460.9 6464.5 4518.8 4608.0 4624.8 4631.9 4632.4 6745.9 6747.2 6755.8 6755.8 6760.2 4730.7 4733.7 4735.4 4737.5 4742.5 4771.6 4788.0 4792.3 4794.5 4794.7 5385.4 5473.8 5493.3 5495.5 5497.1 6492.8 6525.7 6531.2 6539.4 6545.9 1679.0 1702.7 1702.8 1704.2 1704.9 1163.8 1169.2 1169.9 1191.1 1199.0 6352.0 6355.2 6364.7 6370.5 6370.9 6515.6 6605.9 6677.3 6754.5 6769.5 6320.4 6358.5 6384.3 6391.2 6398.6 3618.5 3651.2 3655.3 3655.7 3656.6 6753.4 6944.5 6949.7 6957.2 6966.8 6914.6 6916.7 6924.8 6931.3 6968.9 6936.1 6961.5 6969.2 6971.9 6977.1 6660.4 6781.7 6789.7 6792.2 6797.3 6684.5 6692.9 6694.6 6697.2 6703.6 6962.5 6966.4 6968.8 6972.2 6973.6 4562.5 4689.8 4691.0 4695.7 4701.8 6761.5 6763.2 6767.9 6773.0 6773.2 6569.4 6582.7 6585.4 6590.6 6602.3 6427.2 6569.9 6621.0 6628.0 6631.8 6481.9 6512.5 6524.4 6525.8 6526.2 6655.4 6657.5 6658.3 6664.1 6665.2 6205.2 6352.0 6362.8 6486.4 6503.9 09:23:40 INFO - 2016-02-15 09:23:40,633 DEBUG : BROWSER_OUTPUT: 09:23:40 INFO - 2016-02-15 09:23:40,634 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14765.88 Median:50058.62 stddev:17417.82 (34.8%) stddev-sans-first:17434.99 09:23:40 INFO - 2016-02-15 09:23:40,634 DEBUG : BROWSER_OUTPUT: Values: 775.2 807.2 828.7 829.9 865.7 14370.0 14778.6 14830.4 14835.3 14848.0 13678.9 13770.0 13810.2 13816.4 13834.2 729.4 734.6 865.8 878.6 886.4 889.8 893.5 896.3 900.5 903.2 915.2 921.7 922.1 922.5 922.8 756.8 760.6 915.9 927.1 928.1 687.1 687.5 687.6 687.7 687.8 13720.1 13925.2 14033.4 14034.1 14046.9 12620.5 13005.8 13120.7 13138.8 13235.0 9601.7 9758.5 9806.0 9843.4 9913.0 3763.2 3763.3 3765.3 3799.4 3820.1 47973.3 48312.5 50416.7 50555.2 50589.5 10275.1 10275.7 10346.9 10517.4 10638.3 17546.1 18024.4 18064.4 18149.2 18152.4 7635.9 7685.8 7745.3 7820.4 7885.5 4793.8 4819.0 4901.2 4922.7 4944.2 3189.4 3224.1 3225.4 3233.1 3241.2 555.6 567.2 567.6 575.4 580.6 677.7 693.2 695.1 731.2 739.4 8655.7 9008.6 9082.6 9099.6 9282.1 586.9 691.6 697.1 714.7 714.9 4301.4 4314.3 4384.6 4420.8 4471.3 64003.4 64173.0 64413.7 64622.7 65637.7 54537.2 54985.2 55288.0 55706.0 55896.7 50081.2 50327.5 50630.5 50708.7 50750.7 8840.1 8929.2 9108.4 9210.1 9305.6 37399.8 37867.0 38077.4 38139.0 38761.8 44573.0 50036.0 50288.5 51762.5 51968.2 11078.1 11149.5 11191.8 11196.4 11225.2 13031.7 13479.8 13728.0 13819.2 14321.2 11855.3 12330.4 12674.2 12721.2 12814.8 12041.8 12136.8 12299.1 12495.3 12768.4 10251.3 10306.4 11306.2 11453.3 11708.8 9482.3 9836.9 10358.5 10535.5 10936.5 9905.3 10092.8 10251.6 10354.8 10476.3 09:23:40 INFO - 2016-02-15 09:23:40,634 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:23:40 INFO - 2016-02-15 09:23:40,634 DEBUG : BROWSER_OUTPUT: 09:23:41 INFO - 2016-02-15 09:23:41,245 INFO : Browser exited with error code: 0 09:23:41 INFO - 2016-02-15 09:23:41,266 INFO : Completed test dromaeo_css (00:18:31) 09:23:41 INFO - 2016-02-15 09:23:41,266 INFO : Starting test kraken 09:23:41 INFO - 2016-02-15 09:23:41,266 DEBUG : operating with platform_type : linux_ 09:23:41 INFO - 2016-02-15 09:23:41,266 INFO : Initialising browser for kraken test... 09:23:41 INFO - 2016-02-15 09:23:41,273 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsTIAfK/profile http://localhost:34573/getInfo.html 09:23:44 INFO - 2016-02-15 09:23:44,928 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:23:44 INFO - 2016-02-15 09:23:44,928 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:23:44 INFO - 2016-02-15 09:23:44,928 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:23:44 INFO - 2016-02-15 09:23:44,928 DEBUG : BROWSER_OUTPUT: __metrics 09:23:45 INFO - 2016-02-15 09:23:45,057 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] 09:23:45 INFO - 2016-02-15 09:23:45,905 INFO : Browser initialized. 09:23:45 INFO - 2016-02-15 09:23:45,906 INFO : Running cycle 1/1 for kraken test... 09:23:45 INFO - 2016-02-15 09:23:45,906 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsTIAfK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:23:57 INFO - 2016-02-15 09:23:57,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 133574656 09:23:57 INFO - 2016-02-15 09:23:57,666 DEBUG : BROWSER_OUTPUT: 09:24:00 INFO - 2016-02-15 09:24:00,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34573/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:00 INFO - 2016-02-15 09:24:00,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 165146624 09:24:00 INFO - 2016-02-15 09:24:00,666 DEBUG : BROWSER_OUTPUT: 09:24:03 INFO - 2016-02-15 09:24:03,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34573/tests/kraken/driver.html?testName=audio-dft) 09:24:03 INFO - 2016-02-15 09:24:03,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 164085760 09:24:03 INFO - 2016-02-15 09:24:03,818 DEBUG : BROWSER_OUTPUT: 09:24:06 INFO - 2016-02-15 09:24:06,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34573/tests/kraken/driver.html?testName=audio-fft) 09:24:07 INFO - 2016-02-15 09:24:07,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 160460800 09:24:07 INFO - 2016-02-15 09:24:07,150 DEBUG : BROWSER_OUTPUT: 09:24:09 INFO - 2016-02-15 09:24:09,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34573/tests/kraken/driver.html?testName=audio-oscillator) 09:24:09 INFO - 2016-02-15 09:24:09,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 161558528 09:24:09 INFO - 2016-02-15 09:24:09,690 DEBUG : BROWSER_OUTPUT: 09:24:11 INFO - 2016-02-15 09:24:11,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34573/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:24:12 INFO - 2016-02-15 09:24:12,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 159277056 09:24:12 INFO - 2016-02-15 09:24:12,451 DEBUG : BROWSER_OUTPUT: 09:24:15 INFO - 2016-02-15 09:24:15,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34573/tests/kraken/driver.html?testName=imaging-darkroom) 09:24:15 INFO - 2016-02-15 09:24:15,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 159768576 09:24:15 INFO - 2016-02-15 09:24:15,847 DEBUG : BROWSER_OUTPUT: 09:24:19 INFO - 2016-02-15 09:24:19,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34573/tests/kraken/driver.html?testName=imaging-desaturate) 09:24:19 INFO - 2016-02-15 09:24:19,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 160096256 09:24:19 INFO - 2016-02-15 09:24:19,710 DEBUG : BROWSER_OUTPUT: 09:24:22 INFO - 2016-02-15 09:24:22,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34573/tests/kraken/driver.html?testName=json-parse-financial) 09:24:22 INFO - 2016-02-15 09:24:22,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 160518144 09:24:22 INFO - 2016-02-15 09:24:22,973 DEBUG : BROWSER_OUTPUT: 09:24:24 INFO - 2016-02-15 09:24:24,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34573/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:24:25 INFO - 2016-02-15 09:24:25,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 167641088 09:24:25 INFO - 2016-02-15 09:24:25,076 DEBUG : BROWSER_OUTPUT: 09:24:26 INFO - 2016-02-15 09:24:26,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34573/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:24:27 INFO - 2016-02-15 09:24:27,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 166477824 09:24:27 INFO - 2016-02-15 09:24:27,429 DEBUG : BROWSER_OUTPUT: 09:24:29 INFO - 2016-02-15 09:24:29,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34573/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:24:29 INFO - 2016-02-15 09:24:29,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 169676800 09:24:29 INFO - 2016-02-15 09:24:29,981 DEBUG : BROWSER_OUTPUT: 09:24:32 INFO - 2016-02-15 09:24:32,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34573/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:24:32 INFO - 2016-02-15 09:24:32,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 177070080 09:24:32 INFO - 2016-02-15 09:24:32,949 DEBUG : BROWSER_OUTPUT: 09:24:35 INFO - 2016-02-15 09:24:35,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34573/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:24:35 INFO - 2016-02-15 09:24:35,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 175263744 09:24:35 INFO - 2016-02-15 09:24:35,990 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34573/tests/kraken/driver.html?testName=ai-astar) 09:24:37 INFO - 2016-02-15 09:24:37,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 232599552 09:24:37 INFO - 2016-02-15 09:24:37,874 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,874 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:24:37 INFO - 2016-02-15 09:24:37,875 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:24:37 INFO - 2016-02-15 09:24:37,875 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:24:37 INFO - 2016-02-15 09:24:37,875 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:24:37 INFO - 2016-02-15 09:24:37,875 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;104;107;110;109;98;108;108;100 09:24:37 INFO - 2016-02-15 09:24:37,875 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;120;149;154;130;143;154;129;163;122 09:24:37 INFO - 2016-02-15 09:24:37,875 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;159;159;159;161;159;160;162;159;159 09:24:37 INFO - 2016-02-15 09:24:37,875 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;71;72;145;72;71;71;71;147;71 09:24:37 INFO - 2016-02-15 09:24:37,875 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;137;93;93;95;135;92;93;138 09:24:37 INFO - 2016-02-15 09:24:37,876 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;110;110;110;109;109;110 09:24:37 INFO - 2016-02-15 09:24:37,876 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;146;146;145;146;145;146;145;145 09:24:37 INFO - 2016-02-15 09:24:37,876 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;94;95;95;95;96;96 09:24:37 INFO - 2016-02-15 09:24:37,876 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;56;57;58;55;57;57;57;54;53 09:24:37 INFO - 2016-02-15 09:24:37,876 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;63;63;64;64;69;64;63;63;64 09:24:37 INFO - 2016-02-15 09:24:37,876 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;78;85;83;79;78;79;79;78;77 09:24:37 INFO - 2016-02-15 09:24:37,876 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;110;127;115;121;124;112;120;117;115;116 09:24:37 INFO - 2016-02-15 09:24:37,877 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;140;139;145;142;139;138;139;141;130 09:24:37 INFO - 2016-02-15 09:24:37,877 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;62;63;63;62;62;62;62;64;61 09:24:37 INFO - 2016-02-15 09:24:37,877 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:24:37 INFO - 2016-02-15 09:24:37,877 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:24:37 INFO - 2016-02-15 09:24:37,877 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,880 09:24:37 INFO - 2016-02-15 09:24:37,877 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:24:37 INFO - 2016-02-15 09:24:37,877 DEBUG : BROWSER_OUTPUT: __startTimestamp1455557077872__endTimestamp 09:24:37 INFO - 2016-02-15 09:24:37,877 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,880 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.10 Median:108.50 stddev:4.09 (3.8%) stddev-sans-first:4.28 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 104.0 107.0 110.0 109.0 98.0 108.0 108.0 100.0 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.10 Median:148.00 stddev:14.88 (10.1%) stddev-sans-first:15.63 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: Values: 147.0 120.0 149.0 154.0 130.0 143.0 154.0 129.0 163.0 122.0 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.60 Median:159.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: Values: 159.0 159.0 159.0 159.0 161.0 159.0 160.0 162.0 159.0 159.0 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.10 Median:71.00 stddev:31.58 (44.5%) stddev-sans-first:32.95 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 72.0 145.0 72.0 71.0 71.0 71.0 147.0 71.0 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,881 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:93.00 stddev:21.12 (22.7%) stddev-sans-first:21.78 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 137.0 93.0 93.0 95.0 135.0 92.0 93.0 138.0 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 110.0 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 96.0 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.90 Median:57.00 stddev:1.60 (2.8%) stddev-sans-first:1.66 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: Values: 55.0 56.0 57.0 58.0 55.0 57.0 57.0 57.0 54.0 53.0 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:1.91 (3.0%) stddev-sans-first:1.90 09:24:37 INFO - 2016-02-15 09:24:37,882 DEBUG : BROWSER_OUTPUT: Values: 62.0 63.0 63.0 64.0 64.0 69.0 64.0 63.0 63.0 64.0 09:24:37 INFO - 2016-02-15 09:24:37,883 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,883 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.00 stddev:2.63 (3.3%) stddev-sans-first:2.65 09:24:37 INFO - 2016-02-15 09:24:37,883 DEBUG : BROWSER_OUTPUT: Values: 77.0 78.0 85.0 83.0 79.0 78.0 79.0 79.0 78.0 77.0 09:24:37 INFO - 2016-02-15 09:24:37,883 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,883 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:118.50 stddev:5.29 (4.5%) stddev-sans-first:4.82 09:24:37 INFO - 2016-02-15 09:24:37,883 DEBUG : BROWSER_OUTPUT: Values: 110.0 127.0 115.0 121.0 124.0 112.0 120.0 117.0 115.0 116.0 09:24:37 INFO - 2016-02-15 09:24:37,883 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,883 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.30 Median:140.00 stddev:3.83 (2.7%) stddev-sans-first:4.06 09:24:37 INFO - 2016-02-15 09:24:37,883 DEBUG : BROWSER_OUTPUT: Values: 140.0 140.0 139.0 145.0 142.0 139.0 138.0 139.0 141.0 130.0 09:24:37 INFO - 2016-02-15 09:24:37,883 DEBUG : BROWSER_OUTPUT: 09:24:37 INFO - 2016-02-15 09:24:37,884 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:1.17 (1.9%) stddev-sans-first:0.87 09:24:37 INFO - 2016-02-15 09:24:37,884 DEBUG : BROWSER_OUTPUT: Values: 65.0 62.0 63.0 63.0 62.0 62.0 62.0 62.0 64.0 61.0 09:24:37 INFO - 2016-02-15 09:24:37,884 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:24:37 INFO - 2016-02-15 09:24:37,884 DEBUG : BROWSER_OUTPUT: 09:24:38 INFO - 2016-02-15 09:24:38,561 INFO : Browser exited with error code: 0 09:24:38 INFO - 2016-02-15 09:24:38,610 INFO : Completed test kraken (00:00:57) 09:24:38 INFO - 2016-02-15 09:24:38,610 INFO : Starting test v8_7 09:24:38 INFO - 2016-02-15 09:24:38,610 DEBUG : operating with platform_type : linux_ 09:24:38 INFO - 2016-02-15 09:24:38,610 INFO : Initialising browser for v8_7 test... 09:24:38 INFO - 2016-02-15 09:24:38,616 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8MK_KR/profile http://localhost:34573/getInfo.html 09:24:42 INFO - 2016-02-15 09:24:42,189 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:24:42 INFO - 2016-02-15 09:24:42,189 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:24:42 INFO - 2016-02-15 09:24:42,189 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:24:42 INFO - 2016-02-15 09:24:42,190 DEBUG : BROWSER_OUTPUT: __metrics 09:24:42 INFO - 2016-02-15 09:24:42,331 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] 09:24:43 INFO - 2016-02-15 09:24:43,221 INFO : Browser initialized. 09:24:43 INFO - 2016-02-15 09:24:43,222 INFO : Running cycle 1/1 for v8_7 test... 09:24:43 INFO - 2016-02-15 09:24:43,222 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8MK_KR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:24:54 INFO - 2016-02-15 09:24:54,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 133074944 09:24:54 INFO - 2016-02-15 09:24:54,899 DEBUG : BROWSER_OUTPUT: 09:25:16 INFO - 2016-02-15 09:25:16,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34573/tests/v8_7/run.html (next: http://localhost:34573/tests/v8_7/run.html) 09:25:16 INFO - 2016-02-15 09:25:16,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 420212736 09:25:16 INFO - 2016-02-15 09:25:16,463 DEBUG : BROWSER_OUTPUT: 09:25:16 INFO - 2016-02-15 09:25:16,464 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:25:16 INFO - 2016-02-15 09:25:16,464 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:25:16 INFO - 2016-02-15 09:25:16,464 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:25:16 INFO - 2016-02-15 09:25:16,465 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:25:16 INFO - 2016-02-15 09:25:16,465 DEBUG : BROWSER_OUTPUT: |0;Richards;164.39256945586058 09:25:16 INFO - 2016-02-15 09:25:16,465 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.42005692281936 09:25:16 INFO - 2016-02-15 09:25:16,465 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 09:25:16 INFO - 2016-02-15 09:25:16,466 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 09:25:16 INFO - 2016-02-15 09:25:16,466 DEBUG : BROWSER_OUTPUT: |4;RayTrace;962.4639076034649 09:25:16 INFO - 2016-02-15 09:25:16,466 DEBUG : BROWSER_OUTPUT: |5;Earley;551.8763796909492 09:25:16 INFO - 2016-02-15 09:25:16,466 DEBUG : BROWSER_OUTPUT: |6;Boyer;10827.956989247312 09:25:16 INFO - 2016-02-15 09:25:16,467 DEBUG : BROWSER_OUTPUT: |7;RegExp;24463.414634146342 09:25:16 INFO - 2016-02-15 09:25:16,467 DEBUG : BROWSER_OUTPUT: |8;Splay;522.1932114882507 09:25:16 INFO - 2016-02-15 09:25:16,467 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 09:25:16 INFO - 2016-02-15 09:25:16,468 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:25:16 INFO - 2016-02-15 09:25:16,468 DEBUG : BROWSER_OUTPUT: __startTimestamp1455557116463__endTimestamp 09:25:16 INFO - 2016-02-15 09:25:16,468 DEBUG : BROWSER_OUTPUT: 09:25:16 INFO - 2016-02-15 09:25:16,469 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:25:16 INFO - 2016-02-15 09:25:16,469 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:25:16 INFO - 2016-02-15 09:25:16,469 DEBUG : BROWSER_OUTPUT: 09:25:16 INFO - 2016-02-15 09:25:16,469 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.39 Median:164.39 stddev:0.00 (0.0%) 09:25:16 INFO - 2016-02-15 09:25:16,469 DEBUG : BROWSER_OUTPUT: Values: 164.4 09:25:16 INFO - 2016-02-15 09:25:16,469 DEBUG : BROWSER_OUTPUT: 09:25:16 INFO - 2016-02-15 09:25:16,469 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.42 Median:167.42 stddev:0.00 (0.0%) 09:25:16 INFO - 2016-02-15 09:25:16,470 DEBUG : BROWSER_OUTPUT: Values: 167.4 09:25:16 INFO - 2016-02-15 09:25:16,470 DEBUG : BROWSER_OUTPUT: 09:25:16 INFO - 2016-02-15 09:25:16,470 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 09:25:16 INFO - 2016-02-15 09:25:16,470 DEBUG : BROWSER_OUTPUT: Values: 279.4 09:25:16 INFO - 2016-02-15 09:25:16,470 DEBUG : BROWSER_OUTPUT: 09:25:16 INFO - 2016-02-15 09:25:16,470 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 09:25:16 INFO - 2016-02-15 09:25:16,470 DEBUG : BROWSER_OUTPUT: Values: 5138.5 09:25:16 INFO - 2016-02-15 09:25:16,471 DEBUG : BROWSER_OUTPUT: 09:25:16 INFO - 2016-02-15 09:25:16,471 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:962.46 Median:962.46 stddev:0.00 (0.0%) 09:25:16 INFO - 2016-02-15 09:25:16,471 DEBUG : BROWSER_OUTPUT: Values: 962.5 09:25:16 INFO - 2016-02-15 09:25:16,471 DEBUG : BROWSER_OUTPUT: 09:25:16 INFO - 2016-02-15 09:25:16,471 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:551.88 Median:551.88 stddev:0.00 (0.0%) 09:25:16 INFO - 2016-02-15 09:25:16,471 DEBUG : BROWSER_OUTPUT: Values: 551.9 09:25:16 INFO - 2016-02-15 09:25:16,471 DEBUG : BROWSER_OUTPUT: 09:25:16 INFO - 2016-02-15 09:25:16,472 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10827.96 Median:10827.96 stddev:0.00 (0.0%) 09:25:16 INFO - 2016-02-15 09:25:16,472 DEBUG : BROWSER_OUTPUT: Values: 10828.0 09:25:16 INFO - 2016-02-15 09:25:16,472 DEBUG : BROWSER_OUTPUT: 09:25:16 INFO - 2016-02-15 09:25:16,472 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24463.41 Median:24463.41 stddev:0.00 (0.0%) 09:25:16 INFO - 2016-02-15 09:25:16,472 DEBUG : BROWSER_OUTPUT: Values: 24463.4 09:25:16 INFO - 2016-02-15 09:25:16,472 DEBUG : BROWSER_OUTPUT: 09:25:16 INFO - 2016-02-15 09:25:16,472 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:522.19 Median:522.19 stddev:0.00 (0.0%) 09:25:16 INFO - 2016-02-15 09:25:16,472 DEBUG : BROWSER_OUTPUT: Values: 522.2 09:25:16 INFO - 2016-02-15 09:25:16,472 DEBUG : BROWSER_OUTPUT: 09:25:16 INFO - 2016-02-15 09:25:16,473 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 09:25:16 INFO - 2016-02-15 09:25:16,473 DEBUG : BROWSER_OUTPUT: Values: 4835.7 09:25:16 INFO - 2016-02-15 09:25:16,473 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:25:16 INFO - 2016-02-15 09:25:16,473 DEBUG : BROWSER_OUTPUT: 09:25:17 INFO - 2016-02-15 09:25:17,181 INFO : Browser exited with error code: 0 09:25:17 INFO - 2016-02-15 09:25:17,193 INFO : Completed test v8_7 (00:00:38) 09:25:17 INFO - 2016-02-15 09:25:17,599 INFO : Completed test suite (00:20:07) 09:25:17 INFO - 2016-02-15 09:25:17,599 DEBUG : Working with test: dromaeo_css 09:25:17 INFO - 2016-02-15 09:25:17,600 DEBUG : Generating results file: dromaeo_css 09:25:17 INFO - 2016-02-15 09:25:17,601 DEBUG : Working with test: kraken 09:25:17 INFO - 2016-02-15 09:25:17,601 DEBUG : Generating results file: kraken 09:25:17 INFO - 2016-02-15 09:25:17,601 INFO : javascript benchmark 09:25:17 INFO - 2016-02-15 09:25:17,601 DEBUG : Working with test: v8_7 09:25:17 INFO - 2016-02-15 09:25:17,601 DEBUG : Generating results file: v8_7 09:25:17 INFO - 2016-02-15 09:25:17,602 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:25:17 INFO - 2016-02-15 09:25:17,656 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 09:25:17 INFO - 2016-02-15 09:25:17,656 DEBUG : process_Request line: dromaeo_css 7312.09 graph.html#tests=[[72,53,35]] 09:25:17 INFO - 2016-02-15 09:25:17,656 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:25:17 INFO - 2016-02-15 09:25:17,774 DEBUG : process_Request line: kraken 1467.90 graph.html#tests=[[232,53,35]] 09:25:17 INFO - 2016-02-15 09:25:17,774 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:25:17 INFO - 2016-02-15 09:25:17,889 DEBUG : process_Request line: v8_7 23156.55 graph.html#tests=[[230,53,35]] 09:25:17 INFO - 2016-02-15 09:25:17,890 INFO : javascript benchmark 09:25:17 INFO - 2016-02-15 09:25:17,894 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3254.5931758530182, 3318.2865683877963, 3341.5823022122217, 3345.8327083645813, 3376.9493457598132, 5543.113101903697, 5547.278853749012, 5565.0, 5576.163575463683, 5586.190002449643, 5524.944750552493, 5544.251526043983, 5549.223108764776, 5557.972210138953, 5560.555155587554, 4983.975080124595, 5063.5949124070075, 5074.720890351029, 5105.795768169269, 5169.2504586835075, 5000.249962505617, 5057.924131138036, 5121.974390128044, 5124.92312615311, 5130.0, 5066.797328106872, 5157.58739300855, 5170.121079416489, 5171.0692075426405, 5188.558972487343, 5162.354705661793, 5240.318758561362, 5245.108331583621, 5250.0, 5269.394019687708, 4878.268259761029, 4952.207646776498, 4963.379577552806, 5147.510986456281, 5157.097507936133, 5363.731813409314, 5442.102053161224, 5459.808906688287, 5461.399246082928, 5471.644343117685, 6010.459058684695, 6015.879682406371, 6026.337102918676, 6047.183630209909, 6062.939370606326, 5798.623089499211, 5866.560007999417, 5877.52979761618, 6007.789727359565, 6084.787032453887, 5623.718814059281, 5626.606137570372, 5654.349749778746, 5656.971715141439, 5672.06410942194, 6108.602940808833, 6112.969435152885, 6114.205153330127, 6116.5718399711595, 6117.265928088658, 5649.209110724501, 5761.567882408753, 5829.912551311733, 5934.762609495572, 5967.37342579023, 6031.547633927473, 6048.939510604926, 6061.333253342129, 6063.54523410746, 6066.908996365058, 5758.3090029196765, 5984.311804142492, 6012.248468941382, 6017.69911504423, 6020.4280593343565, 5886.264216972879, 5899.46904778572, 5968.1644569760265, 5969.164316995624, 5991.221141251696, 4563.612092972068, 4617.145828021827, 4647.651426143053, 4648.442186937589, 4671.369365135663, 3968.6428221460205, 4057.006033521806, 4151.377293406013, 4152.1072969311745, 4161.188568229166, 5586.469285417878, 5658.0381335173115, 5681.715914204273, 5681.829545113653, 5699.259096317535, 6046.697665116814, 6093.421124993119, 6097.298810636745, 6098.176746139215, 6114.327423983358, 5472.26124473199, 5567.192757050286, 5702.572307076903, 5717.456841600041, 5719.170720245541, 5120.308758317579, 5179.249008893689, 5183.222516622537, 5188.325517682752, 5220.347456567929, 6119.785807496716, 6201.224846894138, 6204.689765511616, 6205.81382558524, 6213.844653883689, 5719.628224165416, 5916.171735957056, 6038.094285857156, 6069.393060693896, 6091.360407157184, 6105.473631592102, 6127.111568822406, 6130.264368275835, 6136.693165341626, 6140.960224688808, 5861.1501332307425, 5895.557833162444, 5922.230110085661, 5929.970350148222, 5952.0476723724, 5796.04365279741, 5883.529317654492, 6038.215032045981, 6047.0929360596265, 6165.383461653799, 5912.556558258234, 5914.4381283777975, 5935.139404786368, 5943.138244954544, 5973.611715238496, 5896.498797602252, 5927.762889484372, 5929.733162007634, 5935.109733540004, 5946.048632218824, 5579.525740311957, 5657.519110875622, 5689.943100568941, 5742.339630942495, 5808.941910581009, 5876.706164691834, 5907.793227237026, 5917.704114794157, 5956.97021514907, 5977.372375900468, 5561.499465048003, 5838.503727183067, 5841.766329346779, 5843.474087332161, 5844.064949608212], "unit": "ms", "name": "dojo.html", "value": 5526.360130565714}, {"lowerIsBetter": false, "replicates": [580.892534881047, 619.4765423217381, 627.0281064350256, 628.4689437425374, 642.6465444005798, 32182.517262241057, 32995.835020824925, 33016.66983330169, 33017.5047374289, 39634.0, 44505.77747111268, 44722.77638611811, 45059.77470112653, 45150.548494515126, 45282.773586132105, 8913.598888050037, 9111.635534578609, 9115.95442022789, 9120.58957346921, 9146.588403521824, 8111.878321825177, 8293.917060829404, 8296.170382961685, 8995.055519170492, 10625.73435664107, 10769.515371808247, 10851.403172825492, 10870.836937445945, 10873.83689244662, 10874.67375978718, 10697.732556686067, 10772.138228941705, 10772.73068173294, 10785.946070269638, 10804.72988175294, 10667.093297069758, 10800.891991080067, 10804.78390432187, 10805.83791243132, 10815.621453249098, 42601.14797704059, 43025.78487107576, 43051.569484305066, 43130.784346078384, 43144.56855431468, 3582.140286331288, 3608.8736894208578, 3641.617630148849, 3901.765894046338, 4214.936775948363, 32075.83962080198, 32126.839365803255, 32280.838595806872, 32367.352652947044, 32368.028959131265, 3819.866304679351, 3866.2460820140086, 3906.8632597858937, 3949.723519353646, 4101.241270364992, 294019.0, 295109.0, 296023.0, 296070.0, 389555.0522247399, 46292.537074629494, 66867.0, 68385.3161468379, 68461.0, 68810.0, 60254.397456025756, 60768.39231607716, 60871.391286087455, 60883.0, 60889.39110608926, 16261.105639189958, 16580.58548536296, 16618.50144495667, 16655.083970381744, 16655.3337866484, 12400.31798251105, 12545.749085018431, 12567.0, 12574.748505029847, 12579.11946163778, 19848.20607175697, 19958.401247962585, 19983.900080499505, 20122.094505747278, 20128.094235759425, 7774.30031297186, 7818.0, 7912.367010639135, 7915.12933577306, 8063.153368896299, 931.7344556801414, 1060.2366296266675, 1103.862017247844, 1110.6834552152598, 1119.361963680694, 29239.269018274288, 29241.415171696874, 29354.412911741645, 30352.84823575868, 30366.696333036387, 1059.0944742245424, 1077.4451157653814, 1083.6044843632176, 1084.7721978384627, 1215.3862299538853, 13432.597022089352, 14161.362738676784, 14256.144631322153, 15187.848121518864, 15957.680846383008, 262210.0, 264338.0, 265706.0, 265755.0, 266543.0, 49905.75047124814, 50449.49550504448, 50672.493275067514, 50699.49300507022, 50738.23892641613, 1351.4121357209644, 1354.2348573056388, 1465.377214683755, 1481.2149560732828, 1494.125936327239, 26111.0, 26995.460090798468, 27580.58629120605, 28371.57442638321, 28743.281417964718, 43253.56746432621, 43704.56295437132, 43775.0, 43847.78076109599, 43889.122217556105, 228627.0, 229369.0, 229878.0, 230023.0, 230694.0, 32495.375231238817, 32743.836280818443, 33059.0, 33104.50343244901, 33239.16902077467, 43055.0, 43556.56443435652, 43753.34369984389, 44054.0, 44471.0, 36520.63479365173, 37027.62972370242, 38228.235435291695, 38469.42295865508, 38480.422793658676, 35783.46324805078, 36355.45466818053, 36751.816240918626, 36951.445728313556, 37297.627023729416, 37631.62368376391, 37682.0, 38012.80993595014, 38144.0, 38604.613953861226, 29745.405091898472, 30543.2364190897, 30705.692943070284, 31788.682113178573, 31828.840855795574, 24143.51712965766, 24267.27198184057, 24283.757162428148, 24467.877660611583, 24650.63024054605], "unit": "ms", "name": "ext.html", "value": 19065.63352367156}, {"lowerIsBetter": false, "replicates": [389.5870377399954, 397.0807580451257, 400.0618549501419, 400.57539008650815, 403.3586597310276, 14292.428302867898, 17419.216135273913, 17827.910860445696, 17843.910780446113, 20127.29554465594, 17442.30230790767, 18090.0, 19535.21859125637, 19554.511137221576, 19572.11925463354, 6186.257649082117, 6337.493000559967, 6343.714532846033, 6344.429001389874, 6344.524160687944, 5329.893402131955, 5452.890942181154, 5455.8363249102595, 6284.183056202687, 6341.71462284196, 4008.719389642726, 4557.407537020183, 5429.348478182624, 5441.319835020622, 5444.265024221739, 5648.350439699446, 5673.971630141844, 5698.259226300575, 5708.800191993281, 5709.229254050691, 5420.972895135499, 5472.835814925558, 5484.862878428032, 5585.469380408896, 5608.971955140199, 13105.541306054241, 13474.797878031739, 13479.460821567125, 21101.47246318839, 21339.35981920545, 2194.133317339642, 2212.192549719357, 2234.9329520114425, 2277.8974946127464, 2405.134151705402, 9350.0, 9561.665341713007, 10157.847632285522, 11284.379359135244, 13606.251656158907, 1863.245385618813, 1877.8216069473378, 1926.0273561851316, 1928.392556344747, 1936.8353689936373, 66726.0, 67905.32094679089, 68921.31078689199, 69997.0, 70196.0, 11327.886721132683, 11374.658760237206, 11403.201775875608, 11420.257683250727, 11497.080233581293, 15023.0, 15039.624009399853, 15096.698066038618, 15137.848621513864, 15156.545303640909, 8249.505029698237, 8276.627551760184, 8279.213474720013, 8297.8340433191, 8318.0, 7908.960455197687, 7928.286454219033, 7933.761987140395, 7987.480813747088, 7999.0801057877925, 4471.0, 4498.257787465097, 4865.781039853215, 4982.078315511642, 4995.075910956485, 1732.0087822812466, 1799.3972019373657, 1933.709943508485, 1938.70919362094, 2017.9091940862697, 909.3043821476575, 950.538988590533, 1036.616451912782, 1054.483303181451, 1113.832925061231, 17347.479575612753, 17735.911320443574, 17979.73030404545, 18038.639227215383, 18148.455546333633, 964.5804075227298, 971.6356366362614, 982.3516479123887, 985.8521221816785, 1052.936823790575, 7380.446466515033, 10231.13035391985, 10298.22763292741, 10299.609552710439, 10339.327943683636, 416591.0, 417758.0, 446911.0, 558553.0, 561172.0, 84480.57759711162, 87484.5625771867, 88494.0, 88852.0, 89636.5518172418, 1172.7419967607113, 1203.9337836418906, 1211.7273613437083, 1219.3598360860442, 1221.1390969366753, 16109.355625774837, 16130.193490325672, 16177.919110404373, 16335.59161020984, 16568.83431165673, 36585.45121823228, 36755.44866826946, 37032.814835925645, 37516.81241593775, 38343.0, 53614.0, 54220.18669720036, 54328.72835635796, 56611.71694141503, 57131.71434142803, 10115.595376185165, 10254.487275636338, 10457.215708821717, 10538.525766340379, 10543.57825686964, 12363.505459781867, 12375.62873113808, 12465.750684986067, 14666.41334346657, 18839.529011774815, 15084.622884427537, 15275.236238187825, 15291.923540382228, 15501.224938752792, 15928.522144335688, 14506.34721437559, 14916.105033698013, 15034.0, 15108.169050702318, 15750.212489375715, 15785.842141578896, 15884.761728573849, 16034.839651603801, 16040.919795401414, 16067.598310042342, 10385.117265032557, 10402.687919362432, 10522.684319470429, 10683.94658026705, 10688.305260158066, 10829.783404332027, 12196.939015304866, 14912.701745965236, 15143.167125808186, 15513.45702900393], "unit": "ms", "name": "jquery.html", "value": 9364.145070551333}, {"lowerIsBetter": false, "replicates": [1561.6642421879294, 1575.1887777794432, 1781.4566557200064, 1821.8633602479813, 1852.2498388152799, 7782.105057918334, 8060.234277743612, 8063.032436107668, 8063.233992770692, 8081.757547273592, 6729.629870357128, 6818.147731533559, 7685.807854803633, 7764.262395072473, 7876.173001834811, 2293.20884294918, 2358.6344116661944, 2385.2128797496785, 2385.7017872765905, 2387.6776635154292, 2068.6586713192305, 2277.943051423711, 2306.042992158261, 2336.077249486452, 2336.754640762721, 2043.8467114966363, 2325.430269583946, 2344.906203751848, 2360.799332056777, 2371.027878569787, 2287.794098531132, 2290.4273931517123, 2296.1963312840458, 2332.090484710964, 2332.7783860533223, 2348.553774782803, 2355.564220619191, 2376.9049238030457, 2392.2823153054014, 2394.724606670238, 7981.760547183594, 8135.715249966282, 8159.428839981204, 8165.2243036911395, 8172.713955011546, 4887.120318342697, 4990.476000019982, 4997.5002499749735, 5000.199968005102, 5003.5997120230295, 3168.2396224905856, 3180.634227063871, 3184.2198661327893, 3189.2345836999184, 3256.2836176041233, 916.4867674102458, 939.196986576481, 951.286535098676, 956.3544607390054, 1036.331566139843, 11146.275492092987, 11166.274192177483, 11168.776624467546, 11179.888201118047, 11206.719832004184, 4404.11917616478, 4456.5766252205985, 4457.796394973339, 4467.709598876063, 4522.389477420572, 9422.387544809566, 9437.669681561112, 9445.858312125323, 9457.810843783085, 9474.431534107976, 4947.431045429822, 4953.43035550909, 4965.0, 4970.826021089317, 5003.424606170264, 4545.431821022372, 4561.521040290788, 4563.155816174019, 4565.429321334833, 4573.199690054227, 3833.9041523962123, 3901.7268791184347, 3908.159745654641, 3923.2938071146896, 3928.724989250782, 1136.3295655563256, 1165.7493638867516, 1205.8070708686569, 1261.9305938173304, 1273.2933222061658, 1195.3545085653823, 1199.5501686867424, 1237.7586370657816, 1475.6753514226853, 1477.0030229594981, 7501.624918754041, 7514.586697731568, 7588.886166707503, 7597.658105385271, 7601.961990190013, 1180.6812160716559, 1192.9940350298193, 1213.8725433829497, 1216.9452374643163, 1233.2477188914754, 6001.969990150109, 6073.082861554294, 6149.96925015381, 6154.815355539341, 6195.0, 9360.157585817173, 9702.563384647567, 9798.951005244928, 9831.213502919893, 9858.0, 9543.188828949616, 9617.182539484222, 9721.513924303756, 9731.172850307661, 9743.853842192373, 7365.52124111931, 7439.51643143194, 7522.849543009109, 7529.548227106501, 7535.434842386843, 7447.106347238366, 7529.962350188214, 7544.924550754642, 7548.245175482628, 7581.658825352983, 8690.478571285743, 8722.91277087221, 8768.386212965286, 8887.022427533095, 8892.59983300766, 8910.198082172636, 8931.821363572562, 9108.043655416086, 9125.908740912506, 9216.815663686555, 7335.339819416278, 7345.338919497271, 7364.968904353288, 7391.556506609621, 7412.0364352633815, 7730.884036739566, 7795.844083118419, 7820.804479888048, 7880.33017193522, 7993.080795708568, 6112.449879510866, 7008.439324853897, 7329.560226386434, 7388.667509961957, 7426.591537465275, 7236.819079523054, 7282.854342913218, 7309.086364204474, 7353.522021068614, 7393.07586551681, 6892.172939247323, 7456.627168641655, 7485.363744081814, 7508.662110204945, 7517.398608111447, 6496.707648155939, 6519.445847103049, 6523.086767852599, 6528.183977002875, 6539.607623542603, 7013.123359580052, 7029.402500787491, 7044.788656340318, 7045.365917067488, 7048.224695283618], "unit": "ms", "name": "mootools.html", "value": 4678.587815786628}, {"lowerIsBetter": false, "replicates": [362.521471657412, 363.919937613725, 364.2496457297965, 368.08347215433577, 370.52202658570445, 5968.5523585731025, 6060.757569697213, 6136.877262454759, 6154.522914500516, 6167.414095660916, 5877.0, 6042.395760423967, 6069.362716914716, 6078.908816367747, 6079.240094988127, 4720.787564559586, 4721.268203428457, 4722.527747225285, 4726.716397016182, 4727.929081063787, 4518.457785065797, 4601.7238965662, 4627.490975992638, 4724.338592597039, 4775.5463230993, 4715.92926106107, 4723.409573803275, 4724.645651576128, 4730.81076756931, 4739.952600474003, 4702.882427939312, 4713.717176969359, 4718.339432479438, 4728.172569800306, 4737.099951009297, 4167.10407262437, 4169.91660166795, 4170.270202714543, 4171.91656166875, 4191.811368488426, 5645.125005624135, 5808.97095514524, 5813.360530341659, 5831.912521312183, 5847.766089356421, 5508.862278443031, 5509.283793106911, 5514.172874068881, 5515.944840551583, 5523.28197334344, 6446.484281257488, 6454.903176452357, 6457.903131453032, 6460.870782584369, 6464.547481676284, 4518.796654150571, 4608.032313214229, 4624.7687615619425, 4631.9346550293285, 4632.351470794091, 6745.865082698368, 6747.224069232052, 6755.763548275836, 6755.797326080176, 6760.18877734675, 4730.716157030589, 4733.692309999839, 4735.384400027974, 4737.478877323491, 4742.454617718938, 4771.570558649738, 4788.04239152171, 4792.305115758196, 4794.496577859344, 4794.7362895040405, 5385.380681221632, 5473.75368108436, 5493.313335833021, 5495.505404513613, 5497.147942068986, 6492.772752953719, 6525.706343214567, 6531.216254049449, 6539.411452969255, 6545.934540654628, 1679.0, 1702.6935151672817, 1702.838230368113, 1704.1734758642049, 1704.9147542623068, 1163.784699830534, 1169.2341516306833, 1169.8888605582456, 1191.136426091077, 1198.9580364687195, 6351.96824015877, 6355.205599300088, 6364.7135878885565, 6370.490360771128, 6370.872582548323, 6515.609063456113, 6605.933940660628, 6677.332266773284, 6754.45964322853, 6769.458443324522, 6320.399562041599, 6358.491320694426, 6384.265809431975, 6391.169148010729, 6398.552101352953, 3618.5295911531334, 3651.1967367179177, 3655.250673611903, 3655.7440979131206, 3656.634336566375, 6753.358430949052, 6944.548604340702, 6949.687264073129, 6957.234704182536, 6966.79099627012, 6914.585124892523, 6916.6541672916155, 6924.826879328057, 6931.341522555349, 6968.930310696828, 6936.098307220029, 6961.547499412522, 6969.16370035599, 6971.860562788817, 6977.1278590176225, 6660.367265109807, 6781.694823732845, 6789.694463749044, 6792.150981127359, 6797.28628494001, 6684.4652427804685, 6692.899606506004, 6694.59832410057, 6697.229818570732, 6703.564268322543, 6962.547434416747, 6966.373026427443, 6968.756093536702, 6972.198197207386, 6973.6164510952385, 4562.520935301745, 4689.788959496899, 4690.953090469188, 4695.694779839299, 4701.764911754331, 6761.492888033319, 6763.154605674291, 6767.89848152288, 6773.001964420606, 6773.153355830521, 6569.441597464269, 6582.703778329891, 6585.374389432996, 6590.637514936724, 6602.3397660233595, 6427.164468619049, 6569.9343006569325, 6621.0, 6627.966860165861, 6631.834204144742, 6481.870362592627, 6512.511561632991, 6524.412802847766, 6525.771597994048, 6526.184226971629, 6655.434288085567, 6657.500687448364, 6658.334166583303, 6664.067030615621, 6665.233498147775, 6205.162303089025, 6351.96824015877, 6362.840928976812, 6486.383793539606, 6503.934960650522], "unit": "ms", "name": "prototype.html", "value": 4964.531215789829}, {"lowerIsBetter": false, "replicates": [775.1899265267795, 807.2250639386189, 828.680957831235, 829.8921140251766, 865.6970060478833, 14370.0, 14778.556643300692, 14830.406783728638, 14835.332410041547, 14848.0, 13678.931605341984, 13770.036097473181, 13810.240436775974, 13816.447342106329, 13834.23911684857, 729.438332483987, 734.636355004271, 865.7878819689154, 878.556329053827, 886.3883920095146, 889.7597648634865, 893.5264309915755, 896.2605850173633, 900.4822227219342, 903.1510380242551, 915.1854849184232, 921.7373048681127, 922.077922077922, 922.4695799915042, 922.7923717163652, 756.7691853984533, 760.646299470746, 915.890093188815, 927.091450378626, 928.1321963963716, 687.0552989639247, 687.4706476013491, 687.6492988575812, 687.6596084937988, 687.7730348984823, 13720.108192967526, 13925.164490130624, 14033.368498417494, 14034.087784293988, 14046.85953140476, 12620.495180192782, 13005.804912926315, 13120.737585248336, 13138.802917956238, 13235.0, 9601.711948641552, 9758.463284519348, 9806.0, 9843.360181588245, 9913.0, 3763.172102137525, 3763.322601931651, 3765.265773174232, 3799.430085487199, 3820.0640842993644, 47973.280400794014, 48312.516874831505, 50416.74791626018, 50555.24167137459, 50589.494105058846, 10275.126614237724, 10275.691729248134, 10346.948265258625, 10517.421541815274, 10638.255322127532, 17546.122693865254, 18024.36914707979, 18064.36774712879, 18149.183286752126, 18152.364667236583, 7635.923640763633, 7685.807854803563, 7745.264199901, 7820.374370050382, 7885.487443316166, 4793.832215872428, 4818.951810481921, 4901.164633180187, 4922.680025798311, 4944.208926571803, 3189.378071276079, 3224.1294850390263, 3225.4355487790012, 3233.078572606843, 3241.2059045533997, 555.6188316158023, 567.2427309541808, 567.6026781253057, 575.3814649252071, 580.6283978253921, 677.7187467201056, 693.1647364925253, 695.0651373902093, 731.1847290271415, 739.4010851210537, 8655.740327790176, 9008.59461324242, 9082.636694532144, 9099.590518426687, 9282.0717928208, 586.9005000074476, 691.5919607431639, 697.052009267396, 714.6891102370486, 714.8606021825798, 4301.41930839339, 4314.331278651814, 4384.583464570861, 4420.778961051935, 4471.28459446487, 64003.35996640067, 64173.0, 64413.677931610044, 64622.67688661526, 65637.67181164159, 54537.181942270894, 54985.1752223717, 55288.0, 55706.0, 55896.72051639716, 50081.24878126831, 50327.496725033016, 50630.49369506331, 50708.74645626822, 50750.74624626853, 8840.071792461698, 8929.196372326262, 9108.362414630912, 9210.078992100736, 9305.581248843682, 37399.813000934824, 37867.0, 38077.42883856689, 38139.0, 38761.80619096886, 44573.0, 50036.0, 50288.49711502838, 51762.48237517727, 51968.22047669212, 11078.05836503874, 11149.498272577592, 11191.832122518006, 11196.384198868815, 11225.214235003472, 13031.739365212832, 13479.797803033158, 13728.0, 13819.170849749047, 14321.212333321351, 11855.34795586251, 12330.445129968994, 12674.16988185445, 12721.173123746927, 12814.807777883152, 12041.819372709591, 12136.75726485483, 12299.139060266054, 12495.312757798409, 12768.425420855898, 10251.333663311862, 10306.381617102697, 11306.230216326476, 11453.312801231952, 11708.824367634663, 9482.336236463658, 9836.901630983884, 10358.5338659762, 10535.473226338805, 10936.453177340942, 9905.306628535933, 10092.848607271044, 10251.58993640246, 10354.792904141725, 10476.266661333939], "unit": "ms", "name": "yui.html", "value": 6669.008166799303}], "name": "dromaeo_css", "value": 7312.091303451074}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 104.0, 107.0, 110.0, 109.0, 98.0, 108.0, 108.0, 100.0], "unit": "ms", "name": "ai-astar", "value": 106.1}, {"lowerIsBetter": true, "replicates": [147.0, 120.0, 149.0, 154.0, 130.0, 143.0, 154.0, 129.0, 163.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.1}, {"lowerIsBetter": true, "replicates": [159.0, 159.0, 159.0, 159.0, 161.0, 159.0, 160.0, 162.0, 159.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 159.6}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 72.0, 145.0, 72.0, 71.0, 71.0, 71.0, 147.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 86.1}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 137.0, 93.0, 93.0, 95.0, 135.0, 92.0, 93.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 57.0, 58.0, 55.0, 57.0, 57.0, 57.0, 54.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 63.0, 64.0, 64.0, 69.0, 64.0, 63.0, 63.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 85.0, 83.0, 79.0, 78.0, 79.0, 79.0, 78.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.3}, {"lowerIsBetter": true, "replicates": [110.0, 127.0, 115.0, 121.0, 124.0, 112.0, 120.0, 117.0, 115.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.7}, {"lowerIsBetter": true, "replicates": [140.0, 140.0, 139.0, 145.0, 142.0, 139.0, 138.0, 139.0, 141.0, 130.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.3}, {"lowerIsBetter": true, "replicates": [65.0, 62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 64.0, 61.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 62.6}], "name": "kraken", "value": 1467.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.39256945586058], "unit": "score", "name": "Richards", "value": 214.742066}, {"lowerIsBetter": false, "replicates": [167.42005692281936], "unit": "score", "name": "DeltaBlue", "value": 394.9228140000002}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [962.4639076034649], "unit": "score", "name": "RayTrace", "value": 768.8485710000002}, {"lowerIsBetter": false, "replicates": [551.8763796909492], "unit": "score", "name": "Earley", "value": 1207.6309559999997}, {"lowerIsBetter": false, "replicates": [10827.956989247312], "unit": "score", "name": "Boyer", "value": 61.550207547169784}, {"lowerIsBetter": false, "replicates": [24463.414634146342], "unit": "score", "name": "RegExp", "value": 37.23866899302096}, {"lowerIsBetter": false, "replicates": [522.1932114882507], "unit": "score", "name": "Splay", "value": 156.055265}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23156.55421367083}]} 09:25:17 INFO - RETURN: dromaeo_css: 7312.09 09:25:17 INFO - RETURN: kraken: 1467.90 09:25:17 INFO - RETURN: v8_7: 23156.55 09:25:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23156.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1467.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7312.09"}}} 09:25:17 INFO - Return code: 0 09:25:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:25:18 INFO - # TBPL SUCCESS # 09:25:18 INFO - Running post-action listener: _resource_record_post_action 09:25:18 INFO - Running post-run listener: _resource_record_post_run 09:25:19 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 8384512; Write bytes: 410087424; Read time: 2072; Write time: 323372 09:25:19 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 13373440; Read time: 0; Write time: 6808 09:25:19 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 6623232; Write bytes: 396713984; Read time: 2032; Write time: 316564 09:25:19 INFO - Running post-run listener: _upload_blobber_files 09:25:19 INFO - Blob upload gear active. 09:25:19 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:25:19 INFO - Copying logs to upload dir... 09:25:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.613125 ========= master_lag: -0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-02-15 09:25:19.071364) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-15 09:25:19.074927) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009930 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455547221/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-15 09:25:19.126637) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 09:25:19.127070) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455555840.856831-1566637426 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 09:25:19.177377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 09:25:19.177781) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 09:25:19.178162) ========= ========= Total master_lag: -0.06 =========