builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1456408696.08 results: success (0) buildid: 20160225033628 builduid: 93217b60dab747359aad987552fa980f revision: 4a5d8ade4e3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.083891) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.084312) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.084597) ========= 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=03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006714 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.105185) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.105466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.118524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.118843) ========= 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=03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004676 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.167557) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.167891) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.168275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.168603) ========= 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=03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-25 05:58:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.8M=0s 2016-02-25 05:58:16 (84.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095458 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.276065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.276379) ========= 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=03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022169 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:16.325262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-25 05:58:16.325590) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4a5d8ade4e3e --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 4a5d8ade4e3e --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=03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-25 05:58:16,741 Setting DEBUG logging. 2016-02-25 05:58:16,741 attempt 1/10 2016-02-25 05:58:16,741 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4a5d8ade4e3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 05:58:17,887 unpacking tar archive at: mozilla-beta-4a5d8ade4e3e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.462506 ========= master_lag: 0.67 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-25 05:58:18.458232) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:18.458601) ========= echo 4a5d8ade4e3e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4a5d8ade4e3e'] 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=03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4a5d8ade4e3e program finished with exit code 0 elapsedTime=0.004747 script_repo_revision: '4a5d8ade4e3e' ========= master_lag: 0.39 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:18.854613) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:18.857956) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 05:58:18.869069) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-02-25 05:58:18.869450) ========= /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=03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:58:19 INFO - MultiFileLogger online at 20160225 05:58:19 in /builds/slave/test-pgo 05:58:19 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 05:58:19 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:58:19 INFO - {'append_to_log': False, 05:58:19 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:58:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:58:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:58:19 INFO - 'branch': 'Mozilla-Beta', 05:58:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:58:19 INFO - 'config_files': ('talos/linux_config.py',), 05:58:19 INFO - 'default_actions': ('clobber', 05:58:19 INFO - 'read-buildbot-config', 05:58:19 INFO - 'download-and-extract', 05:58:19 INFO - 'populate-webroot', 05:58:19 INFO - 'create-virtualenv', 05:58:19 INFO - 'install', 05:58:19 INFO - 'run-tests'), 05:58:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:58:19 INFO - 'download_minidump_stackwalk': True, 05:58:19 INFO - 'download_symbols': 'ondemand', 05:58:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:58:19 INFO - 'tooltool.py': '/tools/tooltool.py', 05:58:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:58:19 INFO - '/tools/misc-python/virtualenv.py')}, 05:58:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:58:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:58:19 INFO - 'installer_path': 'installer.exe', 05:58:19 INFO - 'log_level': 'info', 05:58:19 INFO - 'log_name': 'talos', 05:58:19 INFO - 'log_to_console': True, 05:58:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:58:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:58:19 INFO - 'opt_config_files': (), 05:58:19 INFO - 'pip_index': False, 05:58:19 INFO - 'sps_profile': False, 05:58:19 INFO - 'sps_profile_interval': 0, 05:58:19 INFO - 'suite': 'dromaeojs', 05:58:19 INFO - 'system_bits': '32', 05:58:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:58:19 INFO - 'title': 'talos-linux64-ix-047', 05:58:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:58:19 INFO - 'use_talos_json': True, 05:58:19 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:58:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:58:19 INFO - 'work_dir': 'build'} 05:58:19 INFO - ##### 05:58:19 INFO - ##### Running clobber step. 05:58:19 INFO - ##### 05:58:19 INFO - Running pre-action listener: _resource_record_pre_action 05:58:19 INFO - Running main action method: clobber 05:58:19 INFO - rmtree: /builds/slave/test-pgo/build 05:58:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:58:20 INFO - Running post-action listener: _resource_record_post_action 05:58:20 INFO - ##### 05:58:20 INFO - ##### Running read-buildbot-config step. 05:58:20 INFO - ##### 05:58:20 INFO - Running pre-action listener: _resource_record_pre_action 05:58:20 INFO - Running main action method: read_buildbot_config 05:58:20 INFO - Using buildbot properties: 05:58:20 INFO - { 05:58:20 INFO - "properties": { 05:58:20 INFO - "buildnumber": 135, 05:58:20 INFO - "product": "firefox", 05:58:20 INFO - "script_repo_revision": "production", 05:58:20 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:58:20 INFO - "repository": "", 05:58:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:58:20 INFO - "buildid": "20160225033628", 05:58:20 INFO - "slavename": "talos-linux64-ix-047", 05:58:20 INFO - "pgo_build": "True", 05:58:20 INFO - "basedir": "/builds/slave/test-pgo", 05:58:20 INFO - "project": "", 05:58:20 INFO - "platform": "ubuntu64_hw", 05:58:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:58:20 INFO - "slavebuilddir": "test", 05:58:20 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:58:20 INFO - "branch": "mozilla-beta", 05:58:20 INFO - "repo_path": "releases/mozilla-beta", 05:58:20 INFO - "stage_platform": "linux64-pgo", 05:58:20 INFO - "builduid": "93217b60dab747359aad987552fa980f", 05:58:20 INFO - "revision": "4a5d8ade4e3e" 05:58:20 INFO - }, 05:58:20 INFO - "sourcestamp": { 05:58:20 INFO - "repository": "", 05:58:20 INFO - "hasPatch": false, 05:58:20 INFO - "project": "", 05:58:20 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 05:58:20 INFO - "changes": [ 05:58:20 INFO - { 05:58:20 INFO - "category": null, 05:58:20 INFO - "files": [ 05:58:20 INFO - { 05:58:20 INFO - "url": null, 05:58:20 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/firefox-45.0.en-US.linux-x86_64.tar.bz2" 05:58:20 INFO - } 05:58:20 INFO - ], 05:58:20 INFO - "repository": "", 05:58:20 INFO - "rev": "4a5d8ade4e3e", 05:58:20 INFO - "who": "sendchange", 05:58:20 INFO - "when": 1456408634, 05:58:20 INFO - "number": 7652990, 05:58:20 INFO - "comments": "Bug 1242904 - Adjust calculation of ringbuffer_end_minus_copy_length in BrotliDecompressStreaming. r=mcmanus, a=sylvestre", 05:58:20 INFO - "project": "", 05:58:20 INFO - "at": "Thu 25 Feb 2016 05:57:14", 05:58:20 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 05:58:20 INFO - "revlink": "", 05:58:20 INFO - "properties": [ 05:58:20 INFO - [ 05:58:20 INFO - "buildid", 05:58:20 INFO - "20160225033628", 05:58:20 INFO - "Change" 05:58:20 INFO - ], 05:58:20 INFO - [ 05:58:20 INFO - "builduid", 05:58:20 INFO - "93217b60dab747359aad987552fa980f", 05:58:20 INFO - "Change" 05:58:20 INFO - ], 05:58:20 INFO - [ 05:58:20 INFO - "pgo_build", 05:58:20 INFO - "True", 05:58:20 INFO - "Change" 05:58:20 INFO - ] 05:58:20 INFO - ], 05:58:20 INFO - "revision": "4a5d8ade4e3e" 05:58:20 INFO - } 05:58:20 INFO - ], 05:58:20 INFO - "revision": "4a5d8ade4e3e" 05:58:20 INFO - } 05:58:20 INFO - } 05:58:20 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/firefox-45.0.en-US.linux-x86_64.tar.bz2. 05:58:20 INFO - Running post-action listener: _resource_record_post_action 05:58:20 INFO - ##### 05:58:20 INFO - ##### Running download-and-extract step. 05:58:20 INFO - ##### 05:58:20 INFO - Running pre-action listener: _resource_record_pre_action 05:58:20 INFO - Running main action method: download_and_extract 05:58:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/test_packages.json 05:58:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:58:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:58:20 INFO - Downloaded 1270 bytes. 05:58:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:58:20 INFO - Using the following test package requirements: 05:58:20 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 05:58:20 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:58:20 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:58:20 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:58:20 INFO - u'jsshell-linux-x86_64.zip'], 05:58:20 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:58:20 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:58:20 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 05:58:20 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:58:20 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 05:58:20 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:58:20 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 05:58:20 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:58:20 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:58:20 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 05:58:20 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:58:20 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:58:20 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:58:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/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 05:58:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/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 05:58:20 INFO - Downloaded 21582985 bytes. 05:58:20 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 05:58:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:58:20 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 05:58:22 INFO - Return code: 0 05:58:22 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 05:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:58:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/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 05:58:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/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 05:58:22 INFO - Downloaded 21582985 bytes. 05:58:22 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 05:58:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:58:22 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 05:58:23 INFO - Return code: 0 05:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 05:58:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/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 05:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/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 05:58:24 INFO - Downloaded 11132038 bytes. 05:58:24 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 05:58:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 05:58:24 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 05:58:24 INFO - Return code: 0 05:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:24 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/firefox-45.0.en-US.linux-x86_64.tar.bz2 05:58:24 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/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 05:58:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/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 05:58:27 INFO - Downloaded 57941236 bytes. 05:58:27 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/firefox-45.0.en-US.linux-x86_64.tar.bz2 05:58:27 INFO - mkdir: /builds/slave/test-pgo/properties 05:58:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:58:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:58:27 INFO - Contents: 05:58:27 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/firefox-45.0.en-US.linux-x86_64.tar.bz2 05:58:27 INFO - Running post-action listener: _resource_record_post_action 05:58:27 INFO - Running post-action listener: set_extra_try_arguments 05:58:27 INFO - ##### 05:58:27 INFO - ##### Running populate-webroot step. 05:58:27 INFO - ##### 05:58:27 INFO - Running pre-action listener: _resource_record_pre_action 05:58:27 INFO - Running main action method: populate_webroot 05:58:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:27 INFO - '--tppagecycles', 05:58:27 INFO - '7'], 05:58:27 INFO - 'tests': ['tsvgm']}}, 05:58:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:58:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:58:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:58:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:58:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:58:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:27 INFO - 'talos_options': ['--e10s'], 05:58:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:27 INFO - 'tests': ['damp', 'tps']}, 05:58:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:27 INFO - 'talos_options': ['--e10s'], 05:58:27 INFO - 'tests': ['damp', 'tps']}, 05:58:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:58:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:27 INFO - 'other': {'tests': ['a11yr', 05:58:27 INFO - 'ts_paint', 05:58:27 INFO - 'tpaint', 05:58:27 INFO - 'sessionrestore', 05:58:27 INFO - 'sessionrestore_no_auto_restore']}, 05:58:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:58:27 INFO - 'tests': ['a11yr', 05:58:27 INFO - 'ts_paint', 05:58:27 INFO - 'tpaint', 05:58:27 INFO - 'sessionrestore', 05:58:27 INFO - 'sessionrestore_no_auto_restore']}, 05:58:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:58:27 INFO - 'tests': ['a11yr', 05:58:27 INFO - 'ts_paint', 05:58:27 INFO - 'tpaint', 05:58:27 INFO - 'sessionrestore', 05:58:27 INFO - 'sessionrestore_no_auto_restore']}, 05:58:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:58:27 INFO - 'tests': ['a11yr', 05:58:27 INFO - 'ts_paint', 05:58:27 INFO - 'tpaint', 05:58:27 INFO - 'sessionrestore', 05:58:27 INFO - 'sessionrestore_no_auto_restore']}, 05:58:27 INFO - 'other_l64': {'tests': ['a11yr', 05:58:27 INFO - 'ts_paint', 05:58:27 INFO - 'tpaint', 05:58:27 INFO - 'sessionrestore', 05:58:27 INFO - 'sessionrestore_no_auto_restore']}, 05:58:27 INFO - 'other_nol64': {'tests': ['a11yr', 05:58:27 INFO - 'ts_paint', 05:58:27 INFO - 'tpaint', 05:58:27 INFO - 'sessionrestore', 05:58:27 INFO - 'sessionrestore_no_auto_restore']}, 05:58:27 INFO - 'svgr': {'tests': ['tsvgx', 05:58:27 INFO - 'tsvgr_opacity', 05:58:27 INFO - 'tart', 05:58:27 INFO - 'tscrollx', 05:58:27 INFO - 'cart']}, 05:58:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:58:27 INFO - 'tests': ['tsvgx', 05:58:27 INFO - 'tsvgr_opacity', 05:58:27 INFO - 'tart', 05:58:27 INFO - 'tscrollx', 05:58:27 INFO - 'cart']}, 05:58:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:27 INFO - 'tests': ['tp5o']}, 05:58:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:27 INFO - 'talos_options': ['--e10s'], 05:58:27 INFO - 'tests': ['tp5o']}, 05:58:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:27 INFO - 'talos_options': ['--xperf_path', 05:58:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:27 INFO - 'tests': ['tp5n']}, 05:58:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:27 INFO - 'talos_options': ['--e10s', 05:58:27 INFO - '--xperf_path', 05:58:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:27 INFO - 'tests': ['tp5n']}}, 05:58:27 INFO - 'talos.zip': {'path': '', 05:58:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:27 INFO - Running post-action listener: _resource_record_post_action 05:58:27 INFO - ##### 05:58:27 INFO - ##### Running create-virtualenv step. 05:58:27 INFO - ##### 05:58:27 INFO - Running pre-action listener: _resource_record_pre_action 05:58:27 INFO - Running main action method: create_virtualenv 05:58:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:58:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:58:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:58:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:27 INFO - Using real prefix '/usr' 05:58:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:58:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:29 INFO - Installing pip.................done. 05:58:29 INFO - Return code: 0 05:58:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:29 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 0x7fb8c407af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1547600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6350>, '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 0x15d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d76e0>, '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': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:58:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:58:29 INFO - Using env: {'DISPLAY': ':0', 05:58:29 INFO - 'HOME': '/home/cltbld', 05:58:29 INFO - 'LANG': 'en_US.UTF-8', 05:58:29 INFO - 'LANGUAGE': 'en_US:en', 05:58:29 INFO - 'LOGNAME': 'cltbld', 05:58:29 INFO - 'MAIL': '/var/mail/cltbld', 05:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:29 INFO - 'MOZ_NO_REMOTE': '1', 05:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:29 INFO - 'NO_EM_RESTART': '1', 05:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:58:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:58:29 INFO - 'SHELL': '/bin/bash', 05:58:29 INFO - 'SHLVL': '1', 05:58:29 INFO - 'TERM': 'linux', 05:58:29 INFO - 'TMOUT': '86400', 05:58:29 INFO - 'USER': 'cltbld', 05:58:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 05:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:29 INFO - '_': '/tools/buildbot/bin/python'} 05:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:58:29 INFO - Cleaning up... 05:58:29 INFO - Return code: 0 05:58:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:29 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 0x7fb8c407af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1547600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6350>, '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 0x15d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d76e0>, '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': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:58:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:58:29 INFO - Using env: {'DISPLAY': ':0', 05:58:29 INFO - 'HOME': '/home/cltbld', 05:58:29 INFO - 'LANG': 'en_US.UTF-8', 05:58:29 INFO - 'LANGUAGE': 'en_US:en', 05:58:29 INFO - 'LOGNAME': 'cltbld', 05:58:29 INFO - 'MAIL': '/var/mail/cltbld', 05:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:29 INFO - 'MOZ_NO_REMOTE': '1', 05:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:29 INFO - 'NO_EM_RESTART': '1', 05:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:58:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:58:29 INFO - 'SHELL': '/bin/bash', 05:58:29 INFO - 'SHLVL': '1', 05:58:29 INFO - 'TERM': 'linux', 05:58:29 INFO - 'TMOUT': '86400', 05:58:29 INFO - 'USER': 'cltbld', 05:58:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 05:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:29 INFO - '_': '/tools/buildbot/bin/python'} 05:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:30 INFO - Downloading/unpacking psutil>=0.7.1 05:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:32 INFO - Installing collected packages: psutil 05:58:32 INFO - Running setup.py install for psutil 05:58:32 INFO - building 'psutil._psutil_linux' extension 05:58:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:58:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:58:32 INFO - building 'psutil._psutil_posix' extension 05:58:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:58:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:58:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:32 INFO - Successfully installed psutil 05:58:32 INFO - Cleaning up... 05:58:32 INFO - Return code: 0 05:58:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:58: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')]} 05:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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', '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 0x7fb8c407af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1547600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6350>, '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 0x15d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d76e0>, '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': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:58: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 mozsystemmonitor==0.0.0 05:58:32 INFO - Using env: {'DISPLAY': ':0', 05:58:32 INFO - 'HOME': '/home/cltbld', 05:58:32 INFO - 'LANG': 'en_US.UTF-8', 05:58:32 INFO - 'LANGUAGE': 'en_US:en', 05:58:32 INFO - 'LOGNAME': 'cltbld', 05:58:32 INFO - 'MAIL': '/var/mail/cltbld', 05:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:32 INFO - 'MOZ_NO_REMOTE': '1', 05:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:32 INFO - 'NO_EM_RESTART': '1', 05:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:58:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:58:32 INFO - 'SHELL': '/bin/bash', 05:58:32 INFO - 'SHLVL': '1', 05:58:32 INFO - 'TERM': 'linux', 05:58:32 INFO - 'TMOUT': '86400', 05:58:32 INFO - 'USER': 'cltbld', 05:58:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 05:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:32 INFO - '_': '/tools/buildbot/bin/python'} 05:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:58:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:58:34 INFO - Installing collected packages: mozsystemmonitor 05:58:34 INFO - Running setup.py install for mozsystemmonitor 05:58:34 INFO - Successfully installed mozsystemmonitor 05:58:34 INFO - Cleaning up... 05:58:34 INFO - Return code: 0 05:58:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:34 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 0x7fb8c407af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1547600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6350>, '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 0x15d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d76e0>, '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': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:58:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:58:34 INFO - Using env: {'DISPLAY': ':0', 05:58:34 INFO - 'HOME': '/home/cltbld', 05:58:34 INFO - 'LANG': 'en_US.UTF-8', 05:58:34 INFO - 'LANGUAGE': 'en_US:en', 05:58:34 INFO - 'LOGNAME': 'cltbld', 05:58:34 INFO - 'MAIL': '/var/mail/cltbld', 05:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:34 INFO - 'MOZ_NO_REMOTE': '1', 05:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:34 INFO - 'NO_EM_RESTART': '1', 05:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:58:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:58:34 INFO - 'SHELL': '/bin/bash', 05:58:34 INFO - 'SHLVL': '1', 05:58:34 INFO - 'TERM': 'linux', 05:58:34 INFO - 'TMOUT': '86400', 05:58:34 INFO - 'USER': 'cltbld', 05:58:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 05:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:34 INFO - '_': '/tools/buildbot/bin/python'} 05:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:35 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:58:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:37 INFO - Downloading docopt-0.6.1.tar.gz 05:58:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:37 INFO - Running setup.py install for blobuploader 05:58:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:58:38 INFO - Running setup.py install for requests 05:58:38 INFO - Running setup.py install for docopt 05:58:38 INFO - Successfully installed blobuploader requests docopt 05:58:38 INFO - Cleaning up... 05:58:38 INFO - Return code: 0 05:58:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:38 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 0x7fb8c407af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1547600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6350>, '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 0x15d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d76e0>, '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': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:58:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:58:38 INFO - Using env: {'DISPLAY': ':0', 05:58:38 INFO - 'HOME': '/home/cltbld', 05:58:38 INFO - 'LANG': 'en_US.UTF-8', 05:58:38 INFO - 'LANGUAGE': 'en_US:en', 05:58:38 INFO - 'LOGNAME': 'cltbld', 05:58:38 INFO - 'MAIL': '/var/mail/cltbld', 05:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:38 INFO - 'MOZ_NO_REMOTE': '1', 05:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:38 INFO - 'NO_EM_RESTART': '1', 05:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:58:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:58:38 INFO - 'SHELL': '/bin/bash', 05:58:38 INFO - 'SHLVL': '1', 05:58:38 INFO - 'TERM': 'linux', 05:58:38 INFO - 'TMOUT': '86400', 05:58:38 INFO - 'USER': 'cltbld', 05:58:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 05:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:38 INFO - '_': '/tools/buildbot/bin/python'} 05:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:58:38 INFO - Running setup.py (path:/tmp/pip-zRwCdZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:58:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:58:38 INFO - Running setup.py (path:/tmp/pip-XGO2pC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:58:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:58:38 INFO - Running setup.py (path:/tmp/pip-UK95xb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:58:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:58:38 INFO - Running setup.py (path:/tmp/pip-_lbulb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:58:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:58:39 INFO - Running setup.py (path:/tmp/pip-qzoO9V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:58:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:58:39 INFO - Running setup.py (path:/tmp/pip-Nvwh9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:58:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:58:39 INFO - Running setup.py (path:/tmp/pip-DhJI2v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:58:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:58:39 INFO - Running setup.py (path:/tmp/pip-fG29YX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:58:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:58:39 INFO - Running setup.py (path:/tmp/pip-AzF5Jn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:58:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:58:39 INFO - Running setup.py (path:/tmp/pip-3XKuxf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:58:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:58:39 INFO - Running setup.py (path:/tmp/pip-_8SIdu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:58:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:58:39 INFO - Running setup.py (path:/tmp/pip-qXOHyq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:58:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:58:39 INFO - Running setup.py (path:/tmp/pip-K7YsHz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:58:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:58:39 INFO - Running setup.py (path:/tmp/pip-FWSHWn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:58:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:58:39 INFO - Running setup.py (path:/tmp/pip-LewaR1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:58:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:58:39 INFO - Running setup.py (path:/tmp/pip-xlyBW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:58:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:58:39 INFO - Running setup.py (path:/tmp/pip-ncgY14-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:58:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:39 INFO - Running setup.py install for manifestparser 05:58:40 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:58:40 INFO - Running setup.py install for mozcrash 05:58:40 INFO - Running setup.py install for mozdebug 05:58:40 INFO - Running setup.py install for mozdevice 05:58:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:58:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:58:40 INFO - Running setup.py install for mozfile 05:58:40 INFO - Running setup.py install for mozhttpd 05:58:40 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:58:40 INFO - Running setup.py install for mozinfo 05:58:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:58:40 INFO - Running setup.py install for mozInstall 05:58:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:58:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:58:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:58:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:58:40 INFO - Running setup.py install for mozleak 05:58:40 INFO - Running setup.py install for mozlog 05:58:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:58:40 INFO - Running setup.py install for moznetwork 05:58:41 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:58:41 INFO - Running setup.py install for mozprocess 05:58:41 INFO - Running setup.py install for mozprofile 05:58:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:58:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:58:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:58:41 INFO - Running setup.py install for mozrunner 05:58:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:58:41 INFO - Running setup.py install for mozscreenshot 05:58:41 INFO - Running setup.py install for moztest 05:58:41 INFO - Running setup.py install for mozversion 05:58:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:58:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:41 INFO - Cleaning up... 05:58:41 INFO - Return code: 0 05:58:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:58: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')]} 05:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:41 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 0x7fb8c407af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1547600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6350>, '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 0x15d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d76e0>, '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': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:58:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:58:41 INFO - Using env: {'DISPLAY': ':0', 05:58:41 INFO - 'HOME': '/home/cltbld', 05:58:41 INFO - 'LANG': 'en_US.UTF-8', 05:58:41 INFO - 'LANGUAGE': 'en_US:en', 05:58:41 INFO - 'LOGNAME': 'cltbld', 05:58:41 INFO - 'MAIL': '/var/mail/cltbld', 05:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:41 INFO - 'MOZ_NO_REMOTE': '1', 05:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:41 INFO - 'NO_EM_RESTART': '1', 05:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:58:41 INFO - 'PWD': '/builds/slave/test-pgo', 05:58:41 INFO - 'SHELL': '/bin/bash', 05:58:41 INFO - 'SHLVL': '1', 05:58:41 INFO - 'TERM': 'linux', 05:58:41 INFO - 'TMOUT': '86400', 05:58:41 INFO - 'USER': 'cltbld', 05:58:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 05:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:41 INFO - '_': '/tools/buildbot/bin/python'} 05:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:58:41 INFO - Running setup.py (path:/tmp/pip-_wST3D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:58:42 INFO - Running setup.py (path:/tmp/pip-FnLhjz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:58:42 INFO - Running setup.py (path:/tmp/pip-oO3B_m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:58:42 INFO - Running setup.py (path:/tmp/pip-MdloNa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:58:42 INFO - Running setup.py (path:/tmp/pip-rgfQFz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:58:42 INFO - Running setup.py (path:/tmp/pip-YIsXub-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:58:42 INFO - Running setup.py (path:/tmp/pip-1Tusf0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:58:42 INFO - Running setup.py (path:/tmp/pip-7zOOie-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:58:42 INFO - Running setup.py (path:/tmp/pip-ihsMRg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:58:42 INFO - Running setup.py (path:/tmp/pip-K_bGDh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:58:42 INFO - Running setup.py (path:/tmp/pip-WJjNXz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:58:42 INFO - Running setup.py (path:/tmp/pip-6MG1mY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:58:42 INFO - Running setup.py (path:/tmp/pip-zl7RhO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:58:42 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)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:58:42 INFO - Running setup.py (path:/tmp/pip-o7GDm9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:58:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:58:42 INFO - Running setup.py (path:/tmp/pip-poRG8M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:58:43 INFO - Running setup.py (path:/tmp/pip-SEiM5o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:58:43 INFO - Running setup.py (path:/tmp/pip-NXNPlr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:58:43 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)) 05:58:43 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)) 05:58:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:44 INFO - Downloading blessings-1.6.tar.gz 05:58:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:45 INFO - Installing collected packages: blessings 05:58:45 INFO - Running setup.py install for blessings 05:58:45 INFO - Successfully installed blessings 05:58:45 INFO - Cleaning up... 05:58:45 INFO - Return code: 0 05:58:45 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:58:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:58:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:58:45 INFO - Reading from file tmpfile_stdout 05:58:45 INFO - Current package versions: 05:58:45 INFO - argparse == 1.2.1 05:58:45 INFO - blessings == 1.6 05:58:45 INFO - blobuploader == 1.2.4 05:58:45 INFO - docopt == 0.6.1 05:58:45 INFO - manifestparser == 1.1 05:58:45 INFO - mozInstall == 1.12 05:58:45 INFO - mozcrash == 0.16 05:58:45 INFO - mozdebug == 0.1 05:58:45 INFO - mozdevice == 0.47 05:58:45 INFO - mozfile == 1.2 05:58:45 INFO - mozhttpd == 0.7 05:58:45 INFO - mozinfo == 0.9 05:58:45 INFO - mozleak == 0.1 05:58:45 INFO - mozlog == 3.1 05:58:45 INFO - moznetwork == 0.27 05:58:45 INFO - mozprocess == 0.22 05:58:45 INFO - mozprofile == 0.27 05:58:45 INFO - mozrunner == 6.11 05:58:45 INFO - mozscreenshot == 0.1 05:58:45 INFO - mozsystemmonitor == 0.0 05:58:45 INFO - moztest == 0.7 05:58:45 INFO - mozversion == 1.4 05:58:45 INFO - psutil == 3.1.1 05:58:45 INFO - requests == 1.2.3 05:58:45 INFO - wsgiref == 0.1.2 05:58:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:45 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 0x7fb8c407af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1547600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6350>, '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 0x15d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d76e0>, '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': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:58:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:58:45 INFO - Using env: {'DISPLAY': ':0', 05:58:45 INFO - 'HOME': '/home/cltbld', 05:58:45 INFO - 'LANG': 'en_US.UTF-8', 05:58:45 INFO - 'LANGUAGE': 'en_US:en', 05:58:45 INFO - 'LOGNAME': 'cltbld', 05:58:45 INFO - 'MAIL': '/var/mail/cltbld', 05:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:45 INFO - 'MOZ_NO_REMOTE': '1', 05:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:45 INFO - 'NO_EM_RESTART': '1', 05:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:58:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:58:45 INFO - 'SHELL': '/bin/bash', 05:58:45 INFO - 'SHLVL': '1', 05:58:45 INFO - 'TERM': 'linux', 05:58:45 INFO - 'TMOUT': '86400', 05:58:45 INFO - 'USER': 'cltbld', 05:58:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 05:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:45 INFO - '_': '/tools/buildbot/bin/python'} 05:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:45 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)) 05:58:45 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)) 05:58:45 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)) 05:58:45 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)) 05:58:45 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)) 05:58:45 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)) 05:58:45 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)) 05:58:45 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)) 05:58: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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:58: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:58:45 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)) 05:58:45 INFO - Cleaning up... 05:58:45 INFO - Return code: 0 05:58:45 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:45 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 0x7fb8c407af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1547600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6350>, '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 0x15d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d76e0>, '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': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:58:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:58:45 INFO - Using env: {'DISPLAY': ':0', 05:58:45 INFO - 'HOME': '/home/cltbld', 05:58:45 INFO - 'LANG': 'en_US.UTF-8', 05:58:45 INFO - 'LANGUAGE': 'en_US:en', 05:58:45 INFO - 'LOGNAME': 'cltbld', 05:58:45 INFO - 'MAIL': '/var/mail/cltbld', 05:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:45 INFO - 'MOZ_NO_REMOTE': '1', 05:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:45 INFO - 'NO_EM_RESTART': '1', 05:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:58:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:58:45 INFO - 'SHELL': '/bin/bash', 05:58:45 INFO - 'SHLVL': '1', 05:58:45 INFO - 'TERM': 'linux', 05:58:45 INFO - 'TMOUT': '86400', 05:58:45 INFO - 'USER': 'cltbld', 05:58:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 05:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:45 INFO - '_': '/tools/buildbot/bin/python'} 05:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:45 INFO - Downloading/unpacking jsonschema 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:47 INFO - Downloading/unpacking functools32 (from jsonschema) 05:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:47 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:47 INFO - warning: no files found matching '*.txt' 05:58:47 INFO - no previously-included directories found matching 'build' 05:58:47 INFO - no previously-included directories found matching 'dist' 05:58:47 INFO - no previously-included directories found matching '.git*' 05:58:48 INFO - Installing collected packages: jsonschema, functools32 05:58:48 INFO - Running setup.py install for functools32 05:58:48 INFO - warning: no files found matching '*.txt' 05:58:48 INFO - no previously-included directories found matching 'build' 05:58:48 INFO - no previously-included directories found matching 'dist' 05:58:48 INFO - no previously-included directories found matching '.git*' 05:58:48 INFO - Successfully installed jsonschema functools32 05:58:48 INFO - Cleaning up... 05:58:48 INFO - Return code: 0 05:58:48 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:58: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')]} 05:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8c407af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1547600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6350>, '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 0x15d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d76e0>, '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': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58: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', 'flake8'] in /builds/slave/test-pgo/build 05:58: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 flake8 05:58:48 INFO - Using env: {'DISPLAY': ':0', 05:58:48 INFO - 'HOME': '/home/cltbld', 05:58:48 INFO - 'LANG': 'en_US.UTF-8', 05:58:48 INFO - 'LANGUAGE': 'en_US:en', 05:58:48 INFO - 'LOGNAME': 'cltbld', 05:58:48 INFO - 'MAIL': '/var/mail/cltbld', 05:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:48 INFO - 'MOZ_NO_REMOTE': '1', 05:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:48 INFO - 'NO_EM_RESTART': '1', 05:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:58:48 INFO - 'PWD': '/builds/slave/test-pgo', 05:58:48 INFO - 'SHELL': '/bin/bash', 05:58:48 INFO - 'SHLVL': '1', 05:58:48 INFO - 'TERM': 'linux', 05:58:48 INFO - 'TMOUT': '86400', 05:58:48 INFO - 'USER': 'cltbld', 05:58:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 05:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:48 INFO - '_': '/tools/buildbot/bin/python'} 05:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:48 INFO - Downloading/unpacking flake8 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:58:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:58:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:58:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:50 INFO - no previously-included directories found matching 'docs/_build' 05:58:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:58:50 INFO - Running setup.py install for pep8 05:58:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:58:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:58:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:58:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:58:51 INFO - no previously-included directories found matching 'docs/_build' 05:58:51 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:58:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:58:51 INFO - Cleaning up... 05:58:51 INFO - Return code: 0 05:58:51 INFO - Running post-action listener: _resource_record_post_action 05:58:51 INFO - Running post-action listener: _start_resource_monitoring 05:58:51 INFO - Starting resource monitoring. 05:58:51 INFO - ##### 05:58:51 INFO - ##### Running install step. 05:58:51 INFO - ##### 05:58:51 INFO - Running pre-action listener: _resource_record_pre_action 05:58:51 INFO - Running main action method: install 05:58:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:58:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:58:51 INFO - Reading from file tmpfile_stdout 05:58:51 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:58:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:58:51 INFO - Reading from file tmpfile_stdout 05:58:51 INFO - Output received: 05:58:51 INFO - Usage: mozinstall [options] installer 05:58:51 INFO - Options: 05:58:51 INFO - -h, --help show this help message and exit 05:58:51 INFO - -d DEST, --destination=DEST 05:58:51 INFO - Directory to install application into. [default: 05:58:51 INFO - "/builds/slave/test-pgo"] 05:58:51 INFO - --app=APP Application being installed. [default: firefox] 05:58:51 INFO - mkdir: /builds/slave/test-pgo/build/application 05:58:51 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'] 05:58:51 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 05:59:06 INFO - Reading from file tmpfile_stdout 05:59:06 INFO - Output received: 05:59:06 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:59:06 INFO - Running post-action listener: _resource_record_post_action 05:59:06 INFO - ##### 05:59:06 INFO - ##### Running run-tests step. 05:59:06 INFO - ##### 05:59:06 INFO - Running pre-action listener: _resource_record_pre_action 05:59:06 INFO - Running main action method: run_tests 05:59:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:59:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:59:06 INFO - Python 2.7.3 05:59:06 INFO - Return code: 0 05:59:06 INFO - grabbing minidump binary from tooltool 05:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:06 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 0x15d6350>, '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 0x15d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d76e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:59:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:59:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:59:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:06 INFO - Return code: 0 05:59:06 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:59:06 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:59:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:59:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:59:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:59:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:59:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:59:07 INFO - Return code: 0 05:59:07 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/1456400188/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:59:07 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/1456400188/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 05:59:07 INFO - Using env: {'DISPLAY': ':0', 05:59:07 INFO - 'HOME': '/home/cltbld', 05:59:07 INFO - 'LANG': 'en_US.UTF-8', 05:59:07 INFO - 'LANGUAGE': 'en_US:en', 05:59:07 INFO - 'LOGNAME': 'cltbld', 05:59:07 INFO - 'MAIL': '/var/mail/cltbld', 05:59:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:59:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:07 INFO - 'MOZ_NO_REMOTE': '1', 05:59:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:07 INFO - 'NO_EM_RESTART': '1', 05:59:07 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:59:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:59:07 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:59:07 INFO - 'SHELL': '/bin/bash', 05:59:07 INFO - 'SHLVL': '1', 05:59:07 INFO - 'TERM': 'linux', 05:59:07 INFO - 'TMOUT': '86400', 05:59:07 INFO - 'USER': 'cltbld', 05:59:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208', 05:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:07 INFO - '_': '/tools/buildbot/bin/python'} 05:59:07 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/1456400188/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 05:59:07 INFO - mozversion INFO | application_buildid: 20160225033628 05:59:07 INFO - mozversion INFO | application_changeset: 4a5d8ade4e3ebfa28287430ec8bb139efa570695 05:59:07 INFO - mozversion INFO | application_display_name: Nightly 05:59:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:07 INFO - mozversion INFO | application_name: Firefox 05:59:07 INFO - mozversion INFO | application_remotingname: firefox 05:59:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:59:07 INFO - mozversion INFO | application_vendor: Mozilla 05:59:07 INFO - mozversion INFO | application_version: 45.0 05:59:07 INFO - mozversion INFO | platform_buildid: 20160225033628 05:59:07 INFO - mozversion INFO | platform_changeset: 4a5d8ade4e3ebfa28287430ec8bb139efa570695 05:59:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:59:07 INFO - mozversion INFO | platform_version: 45.0 05:59:07 INFO - 2016-02-25 05:59:07,367 DEBUG : using testdate: 1456408747 05:59:07 INFO - 2016-02-25 05:59:07,367 DEBUG : actual date: 1456408747 05:59:07 INFO - 2016-02-25 05:59:07,375 INFO : starting webserver on 'localhost:59976' 05:59:07 INFO - 2016-02-25 05:59:07,376 INFO : Starting test suite talos-linux64-ix-047 05:59:07 INFO - 2016-02-25 05:59:07,377 INFO : Starting test dromaeo_css 05:59:07 INFO - 2016-02-25 05:59:07,377 DEBUG : operating with platform_type : linux_ 05:59:07 INFO - 2016-02-25 05:59:07,377 INFO : Initialising browser for dromaeo_css test... 05:59:07 INFO - 2016-02-25 05:59:07,394 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7qIbk9/profile http://localhost:59976/getInfo.html 05:59:11 INFO - 2016-02-25 05:59:11,149 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:59:11 INFO - 2016-02-25 05:59:11,149 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:59:11 INFO - 2016-02-25 05:59:11,149 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:59:11 INFO - 2016-02-25 05:59:11,149 DEBUG : BROWSER_OUTPUT: __metrics 05:59:11 INFO - 2016-02-25 05:59:11,375 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] 05:59:12 INFO - 2016-02-25 05:59:12,330 INFO : Browser initialized. 05:59:12 INFO - 2016-02-25 05:59:12,330 INFO : Running cycle 1/1 for dromaeo_css test... 05:59:12 INFO - 2016-02-25 05:59:12,330 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7qIbk9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:59:24 INFO - 2016-02-25 05:59:24,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 134213632 05:59:24 INFO - 2016-02-25 05:59:24,032 DEBUG : BROWSER_OUTPUT: 06:00:14 INFO - 2016-02-25 06:00:14,824 DEBUG : BROWSER_OUTPUT: 1456408814817 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] 06:02:22 INFO - 2016-02-25 06:02:22,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59976/tests/dromaeo/cssquery-ext.html) 06:02:24 INFO - 2016-02-25 06:02:24,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 311091200 06:02:24 INFO - 2016-02-25 06:02:24,314 DEBUG : BROWSER_OUTPUT: 06:05:26 INFO - 2016-02-25 06:05:26,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/dromaeo/cssquery-ext.html (next: http://localhost:59976/tests/dromaeo/cssquery-jquery.html) 06:05:27 INFO - 2016-02-25 06:05:27,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 221904896 06:05:27 INFO - 2016-02-25 06:05:27,032 DEBUG : BROWSER_OUTPUT: 06:08:28 INFO - 2016-02-25 06:08:28,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59976/tests/dromaeo/cssquery-mootools.html) 06:08:29 INFO - 2016-02-25 06:08:29,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 220082176 06:08:29 INFO - 2016-02-25 06:08:29,380 DEBUG : BROWSER_OUTPUT: 06:11:31 INFO - 2016-02-25 06:11:31,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59976/tests/dromaeo/cssquery-prototype.html) 06:11:31 INFO - 2016-02-25 06:11:31,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 203915264 06:11:31 INFO - 2016-02-25 06:11:31,689 DEBUG : BROWSER_OUTPUT: 06:14:34 INFO - 2016-02-25 06:14:34,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59976/tests/dromaeo/cssquery-yui.html) 06:14:34 INFO - 2016-02-25 06:14:34,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 200196096 06:14:34 INFO - 2016-02-25 06:14:34,678 DEBUG : BROWSER_OUTPUT: 06:17:36 INFO - 2016-02-25 06:17:36,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/dromaeo/cssquery-yui.html (next: http://localhost:59976/tests/dromaeo/cssquery-dojo.html) 06:17:37 INFO - 2016-02-25 06:17:37,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 240742400 06:17:37 INFO - 2016-02-25 06:17:37,023 DEBUG : BROWSER_OUTPUT: 06:17:37 INFO - 2016-02-25 06:17:37,024 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:17:37 INFO - 2016-02-25 06:17:37,024 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:17:37 INFO - 2016-02-25 06:17:37,025 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:17:37 INFO - 2016-02-25 06:17:37,025 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:17:37 INFO - 2016-02-25 06:17:37,026 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3325.9833700831496;3386.796792192467;3406.6593340665922;3410.0792785947797;3444.569428821397;5534.031544479715;5563.638363506369;5572.857564199339;5587.7485513151905;5588.944110558893;5560.2493663355435;5591.832245032645;5592.105263157896;5595.160725891118;5607.130894711316;4883.584895283905;5044.545990860822;5076.238564215379;5095.363079615029;5148.948510514903;5030.773615187307;5091.516305950947;5092.032513822381;5099.4900509949075;5099.541041306282;5067.493250674921;5072.112380333445;5135.409427915782;5146.485351464861;5169.715665638389;5067.619928505358;5149.922751158717;5158.148905430637;5160.045391602565;5160.071187186305;5073.416557095944;5143.434222235588;5195.480451954774;5205.349331333583;5213.504717051912;5197.220416937452;5234.790608375661;5282.366116066059;5411.242426060355;5457.863553411196;5908.113782932552;6055.212822333068;6056.21269235001;6059.121427393047;6071.332153463116;5954.255718035246;6060.060690592965;6078.452939235446;6078.908816367758;6082.665453400061;5331.920021199685;5445;5522.696251706155;5598.944010559923;5625.353084395306;6074.51403887688;6110.083487476825;6113.052476866093;6117.755289788448;6118.1434599156155;5689.886202276014;5932.940670593325;5933.703314834327;5937.673427961504;5947.464728174485;5898.026825573818;5980.671063091485;6101.023836186189;6104.175936248638;6137.631742095488;6004.729787159588;6045.274567051982;6057.091436284592;6057.182280392179;6057.515398768176;5815.680137592473;5876.764929402776;6031.547633927473;6038.909416358758;6042.788502402483;4533.229351010336;4539.251023581072;4539.75031373271;4540.636749060067;4543.909121817545;4066.776327302027;4131.132462182915;4141.151064031867;4160.334346504545;4160.667146628262;5728.398518155617;5756.1653560233535;5758.280214973129;5768.509676677446;5769.134629805562;6016.458518733335;6020.127081573235;6026.276846778327;6029.3669164737075;6034.155218269446;5513.807016754395;5597.6641401516035;5645.407232240637;5763.625364351304;5839.591228614041;5240.371155461369;5248.239005344204;5251.52736253739;5254.527092561688;5255.159174532057;5846.239988801513;6283.937160628427;6287.056941458818;6289.55973081889;6294.968525157345;5932.584719069624;5988.251468566429;6079.665618390854;6098.390160983866;6110.052941794029;6124.081387791867;6193.588236466165;6210.720517576629;6226.968865155826;6255.937440625536;5816.796412125555;5879.735411906389;5883.499902508163;5890.440408161217;5923.259592550931;5834.562407819346;5898.705064746659;5900.675462849585;5916.3492015877355;5919.970400147971;5784.797532086357;5792.681402522901;5795.884082318415;5799.797007104899;5803.100519419497;5769.394213607511;5787.913181302368;5791.681457519709;5864.67744274052;5866.442687944638;5779.566532509994;5806.274215723035;5857.121431785266;5861.0915308127305;5864.208331875142;5929.822105336847;5964.045752679551;5966.015607424726;5978.850528736816;5988.311344195473;5523.447655234444;5636;5701.287339082614;5804.796832110856;5842.298924129132 06:17:37 INFO - 2016-02-25 06:17:37,029 DEBUG : BROWSER_OUTPUT: |1;ext.html;570.6062816656507;644.0886146103264;657.2737125476349;658.9703463344152;664.2195420381054;31636.209094772643;32313.67686323136;32422.513662295027;32450.67549324509;32456.675433245662;43878.561214387846;44292.114157716904;44340.11319773603;44593;44688.77655611718;9175.311851611139;9355.859662105075;9355.906440935572;9357.532123393838;9357.766055848624;8202.753917382459;8381.329493640495;8392.664293428255;9090.86363704545;9133.817323653522;10798.946005269963;10921.563137474492;10996.23026388153;11016.06363459107;11018.063464605519;10792.51433685486;10807.351558906452;10846.566137354497;10889.292196007313;10921.617743379024;10716;10826.079783218436;10850.891491085067;10868.728281792939;10872.347659140476;43559;43882.341764873556;43984.560154398365;43995.78002109969;44041.11917761659;3557.4308110702423;3600.71194304455;3945.506811648544;4162.375643653476;4358.498772641124;32795;33093;33204.1698957528;34214.48678269828;34237.82881085604;4198.223328684173;4218.303979843322;4277.358396240557;4290.2706539888295;4311.741295522279;307892;308647;309019;309500.99999999773;310944;60292.095618565756;61633;63303.68348158322;63931;68580.28549286208;62393;62430;62750.686246568475;62837;62839;17865.553361165814;17956.730649040273;18063;18065;18078.728819067725;13930.721385572231;13982.230977296143;14050.648733781738;14055.367508462145;14071.648208794657;20177.092030858646;20416.183352666023;20423.387298381072;20438.89780551088;20547;8497.915020849836;8619.103797164613;8710.12898710124;8764;8788.384813063152;1057.5769692123213;1088.9727756806144;1094.7482079121687;1130.7342774447998;1152.2280072351546;30842.228944276572;31249.8437507811;31325.530117047805;31966.200844979063;33112.3377532448;1160.3965937712512;1182.6156499137815;1207.390267914715;1219.3049961522024;1274.5411651805343;13258.73482530344;15044;15328.770068448983;15450.150241736812;16365.181740912907;281906;282358;283698;285327;285748;50624;50833.49166508362;50943.49056509462;51061.48938510568;51309.743451282506;1363.4478036395276;1377.2149874571398;1499.8800095992076;1513.1828812441158;1564.749640057608;28275;29349;29423.85288073546;29822.552661710524;30064.398712026075;44710.55289447064;45092.32361514514;45104.774476128725;45131.77434112808;45179.09641807211;248498;250302;250567;250833.22083726982;251297;34550.82724586361;34739.478907816905;34914.65085349114;35319.29361412809;35377;45550.77224613856;45923;46248.075038499715;46453;46695.533044669115;37324.62675373212;37509.81245093757;38102.618973809906;38196.236075278895;38590.8422747318;37635.62364376431;37690.623093769806;38289.23421531498;38627.80686096552;38669.41995870008;38204.42693359546;38485.615143848205;38930.80534597309;39369.80315098406;39610.80194599008;29777.85111074431;32925.83537082299;33541.66458335386;33630.831845840614;33848.7998280111;26311.868440657676;26842.463150737265;27101.59347609748;27222.863885681236;27474.450510990067 06:17:37 INFO - 2016-02-25 06:17:37,031 DEBUG : BROWSER_OUTPUT: |2;jquery.html;380.28506407953046;382.4187235402187;386.9825857836397;387.808035022664;390.80024325321256;14235.145891246533;16723.33106675733;16918.830811691878;18130.54673633158;18140.546486337847;17327.133643317848;17495.5626109347;17498.387556435526;17899.821001789976;18105.185266663;5087.79648814047;5787.826365209029;5787.971060144714;5792;5792.884142317151;4282.892927676818;4354.17270718564;5721.342045664739;6192.87614247717;6384.170057892467;6140.355262697397;6268.749250029993;6296.055591661265;6296.181496405461;6324.241091069078;6184.721687524072;6212;6212.627242365473;6230.314665386803;6245.437910588046;5557.749901254453;5625.09998400254;5631.436856314377;5641.830745077655;5642.322921249435;21677.783222167734;21929.780702192933;22081;22165.55668886613;22259.888700556556;2390.916317928864;2453.570625140593;2489.800815934721;2507.962380564293;2545.478176973716;13899.513517026855;13936.790948135786;14183.78724319136;14353.85646143546;14410.423583056665;1888.424030670645;1904.7619047619048;1924.538110853399;1949.7855235924037;1976.3082920977686;63303.683481582295;64332;64872.35127648758;65316;66467.66766166186;10299.17606591471;10637.574497020032;10759.731006724738;10782;10846.78306433867;14053.78919316211;14141.787873181911;14178.220197889008;14182.574522764333;14202.431902723776;8200.794980125545;8269;8274.29668478174;8423.368247381472;8444.493330400195;8102.230288122619;8119.47223430487;8132.837343253102;8170.959145204355;8188.222118898695;6339.366063393623;6378.712957916812;6416.903746443807;6427;6438.903416448757;1759.6392739488374;1786.7319902014801;1815.0924537731134;1839.5350230690938;1929.4112949913151;984.7685793838442;1000.6297669862198;1043.5043354406596;1048.8741351037925;1153.423288355822;15784;18370.540736481697;18875.81124188768;19292.32476863303;19336.613267734847;981.2003217377815;1046.7435478307711;1053.2416660004785;1075.4945175767377;1104.3263609198382;10310.793784124426;10388.948055259676;10524.894751052545;10540.525676344583;10711.83932241017;501316;504536;648476;684586;691553;87887.56056219678;93858.53070734603;94067.52966235125;94561.52719236497;95814.52092739491;1194.5401020606955;1196.1447564991074;1236.2335352081766;1250.3998080921026;1268.0869773762877;15962.281697323417;16081.517554473385;16177.272022758769;16217.918910405373;16298.67402651964;34781.65218347784;35173;35507.822460888565;35593;36572.26855462929;41501;45387.09225815531;46732.06535869196;46924;49262.50737492579;10171.7457063574;10547.630832920811;10576.312539684895;10609.787804244026;10611.2041596879;12196.085293603193;14220.502282420066;18649.067546622344;18836.152373143515;18886.905565472633;15468.5359439217;15705.293261803017;15736.291866866248;15809.841901581298;16039.518814435585;12285.078619103424;14008.859911400756;14048;14424.783628245794;14605.415783368546;13297.26865022433;14483.927580362031;14680.853191468375;15112.848871511143;15939.920300398424;10224.079832815083;10444.63443779464;10450.843237351293;10539.473026348805;10560.10239129652;14309.856901431269;14407.42370305176;14704.77942830837;14969.550913472613;15103.169325687193 06:17:37 INFO - 2016-02-25 06:17:37,032 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1482.2959094430148;1539.8922075454718;1595.3538816779194;1725.215027162641;1871.9532011699705;7511.849763004743;7908.4464087513825;7912.723054693087;7921.207879212076;7921.564313962745;6843.555168914029;6959.5476294040855;7681.270279323469;7925.722599709012;8028.317593004587;2335.2410466598294;2344.8358614896965;2368.3723813189517;2373.596488596943;2374.4776149247223;2058.6191554562456;2360.2683168217823;2378.7264464586533;2396.6524853896176;2401.9519609607796;2028.6754119340908;2331.079223706635;2370.502194539149;2370.798482129021;2371.4782747795457;2293.461036656376;2339.076064954342;2344.3318654183563;2344.4607740219676;2346.589346864292;2352.752960939094;2372.810175185981;2384.4158181245534;2409.8795060246916;2410.6263529152834;7978.321842643382;8058.234467725557;8063.1130575636635;8070;8071.596420179027;4882.780274887603;5001.574866136383;5005;5005.674631148963;5007.974960125212;3203.167176534095;3230.8869189578254;3238.3037646906027;3245.513173024042;3284.687954644305;1006.1598565198068;1027;1027.2295778166376;1044.8850626431085;1052.7420781908404;11144.442777861075;11161.776764464828;11162.553497860075;11165.441727913572;11176.776464470666;4453.19842428366;4453.844115456009;4553.704009239389;4605.838795642137;4607.792649330788;9493.525323733786;9508.429494230368;9513.476758778334;9521.761955951157;9522.90477095234;5031.698098114125;5036;5037.5214354636255;5040.092783298968;5046.571041461443;4603.8849028773875;4604.286335617984;4604.631629469634;4605.194091034055;4613.792379342937;3836.3478208704587;3868.806559672061;3876.282887665791;3879.2047630235734;3909.237698648736;1089.232091375594;1131.6661584832493;1230.0958795285458;1234.1237721217856;1247.2454165229906;1197.0005045786866;1200.4237965776476;1206.2943178240828;1448.5147475595793;1470.2795630141368;7762.340201082971;7818.530888146729;7874.763757087297;7878.172791856887;7888.7633370998965;1171.5255321594768;1186.7270527778487;1189.4587962477053;1190.8630507491575;1195.014113356467;6172.8765424691255;6228.968855155786;6248.437640612276;6249.437550620466;6259.530535209787;8309.750707478785;8384.119667434832;8398.244158025807;8526.488410695378;8545.957270213734;9328.95335523318;9545.90454095464;9662.420254784736;9670.419774813534;9673.661421850202;7658.2341765824085;7750.4574679773;7840;7841.059072911287;7843.490173138728;7578.772636820904;7720.961395192988;7771.33943614799;7781.883271751041;7782.416318776001;8629.956850215709;8696.304295656206;8868.556572171494;8988.775280618036;8993.055729148346;8734.84119822688;8836.337274704552;8875.423097498642;8883.511406872683;9007.954960225157;7221.458390620619;7281.271872812888;7317.524360916524;7330.743423980135;7339.59632220233;7805.141434442094;7835.177306382748;7922.0889597694695;7941.602919853869;7956.681732730626;6390.329015453311;7040.718371265297;7343.7062517500835;7437.181909989788;7500.512466689866;6996.090508233897;7332.96333518329;7391.371733402506;7407.2592740725495;7415.406767458699;7364.079490063742;7398.556086634819;7399.112106547249;7420.925790742023;7421.628918553943;6818.318168183142;6828.385445309747;6868.725250989904;6868.828279292858;6883.449324054164;6714.832129196614;6762.391384775394;6793.830154245986;6814.1482314710665;6838.931610684029 06:17:37 INFO - 2016-02-25 06:17:37,033 DEBUG : BROWSER_OUTPUT: |4;prototype.html;369.3775987461127;371.5949614919737;372.5510759534761;374.73768362146507;376.42031271841347;6007;6087.360827113144;6094.481969032632;6109.389061093889;6156.938430615693;6026.8794624107495;6032.879342413149;6036.577439579231;6040.456358927696;6042.909356359647;4669.229577119771;4716.245400735883;4746.5490778376;4758.881027974294;4767.237242041274;4721.268203428457;4736.739479328636;4745.21703918853;4747.264174053027;4747.5964543013715;4461.486929003174;4540.091981603676;4681.438227412716;4696.64775141864;4697.4832768395445;4560.817567297321;4693.084848454553;4706.317583950342;4706.599939005188;4714.363560919266;4173.624373806341;4180.853670121562;4182.163567286555;4192.979035104835;4199.307114326132;5521.061419558685;5626.887462250773;5655.264815573949;5719.885602287973;5735.053716136874;5442.782288708447;5462.481064298885;5471.097268950618;5471.835844924619;5480;6404.935950640527;6405.5516113872045;6418.486521078303;6423.710933008026;6424.421802037839;4549.31760235964;4627.421572303462;4641.141388843041;4641.512641172662;4643.767811609439;6606.174228221473;6609.867802643968;6610.504212184105;6611.834704132387;6613.305602911673;4779.044191161782;4779.569838714463;4781.617470602343;4785.066911952136;4790.5448982346625;4846.345743324606;4849.369581954324;4849.75751212438;4850;4850.95149048512;5267.578593712494;5403.243545903577;5423;5442.564594832404;5445.618806683494;6448.3874031967825;6463.579867308704;6468.676566171766;6469.482441404771;6472.061551075068;1660.3939562060002;1677.3123019562165;1679.7312430011139;1679.8320167983104;1680.2438902493682;1135.6649788312468;1139.0773473486502;1140.1050175612104;1161.651504548632;1163.3892206591438;6288.339724328879;6294.370562943761;6294.559380843297;6297.4962003039645;6299.716512756845;6654.134962454947;6659.067730517731;6660.333966603398;6672.96663516689;6681.1314529110905;6183.84540386485;6287.559870809091;6293.559450838489;6294.118823364733;6299.811005669837;3584.4264917613577;3611.638836116367;3612.9638703613155;3615.29501747162;3626.0753507855857;6653.733850646016;6966.407855332353;6968.268331825187;6970.302969703091;6976.093107895941;6722;6726.3609957054005;6886.449084073262;6887.311268873073;6889.414399775975;6939.826504337432;6955.061066756024;6957.65211739411;6957.79126626202;6960.895586566206;6559.114519539992;6711.563748356341;6712.597244165366;6724.7646332378135;6742.089817874524;6628.27089020217;6628.304028076983;6637.103990961352;6637.734490620514;6639.170103737033;6917.584944903322;6935.445164386938;6945.930540694529;6952.200496942916;6956.617386043817;4663;4666.393368862026;4676.6492513060975;4700.106979673851;4791.065742180242;6634.800955971328;6656.633885136364;6657.40083392497;6658.0345849852465;6658.600483970978;6480.7731729391135;6488.772892948724;6489.935100648933;6492.0261960706275;6493.837654058686;6358.300586935341;6474.223093228654;6474.935250647433;6478.093066970722;6488.6755662215755;6344.968275158594;6359;6359.268684101387;6360.363963603602;6363.5545511813725;6484;6495.253045899782;6498.447631951148;6503.349665033459;6503.382178693017;6252.752527376837;6289.622622642656;6333.524985626004;6341.619502829845;6344.302126766144 06:17:37 INFO - 2016-02-25 06:17:37,035 DEBUG : BROWSER_OUTPUT: |5;yui.html;870.3907264914561;919.6597259014166;926.5922993882696;929.9581518831652;939.234523863052;14023.859761402384;14215.644608884782;14222.928885355559;14231.928840355784;14237.857621423782;13475.595732128028;13485.797713034312;13547.322633868316;13552.39014244359;13585.116967397136;698.6681326369971;699.6851416862406;699.7620808924964;862.2196911794836;883.0374891368407;858.5192292316292;872.720729366603;878.7012415778634;880.3221519430035;880.6873559886212;924.1359329027347;931.417863835103;932.8320902237629;933.705882646964;933.9486328251943;731.6853752886257;742.6509540515949;916.8258030974093;934.2152591822901;934.8878134623889;688.2463702246033;690.9136357955256;691.9827004324882;692.3353580562666;693.6358411833777;13146.21122732639;13238.205707657571;13283.468661253635;13290.3354832258;13297.86702132976;11370;12170.878291217152;12371.896777547838;12448.688782780413;12877.162984405984;10180.949095254551;10191.643292484801;10412.583496660125;10435.113015393701;10498.895011049868;3687.3915803892323;3724.0689827543115;3724.2365315110337;3729.9440508392395;3730.9440358394645;46501.667055894846;46924.296135558;48945;49014.50985490135;49448;10110.646127385506;10168.796624067478;10187.235957303232;10828.133749300037;10898.07366373867;17869;17884.55288617769;17912.641747165246;17928.462146135636;17952;7531.359834414026;7650.693972241048;7677.117131529834;7729.536227826348;7783.9610801946765;4611.054733779567;4699.694519856198;4702.95297047032;4773.498782627844;4776.546228108394;3252.9349413012083;3276.2955964467756;3277.9836100819343;3284.540164376989;3287.2439338952177;574.873527823878;578.4533615733092;582.1558739827267;583.0496291045569;584.1704779213527;560.907450270709;572.5705720709468;640.6220330005226;678.6233640329566;697.2615375459993;8654.87017694735;8680.175383338572;8742.606582703793;8830.911690883137;9006.414583052081;668.979930602073;687.9105716256854;690.9516333856582;694.3230350408312;730.7698075106324;4263.5096963849555;4294.484661840599;4309.67277670061;4343.804528796211;4345.804438800262;58540.414595853494;59114;59185.40814591885;59290;61927.38072619306;54154.729226353615;54190.45809541933;54323.18515222275;54535.727321363935;54942.72528637411;47733;48276.5172348272;48402.75798620984;48459.27311090336;49869.75065124651;8777.648894044167;8943;8983.91016089857;9063.351024708165;9152.679656212267;35847;36267.81866090652;36529.452058218616;37076.258474830895;37476.62523374731;42678.359824602034;42890.57109428866;46092.30861537012;47365.52634473749;47769.28346074881;11106.61126860556;11288.379139147426;11327.433628318386;11464.140189485988;11686.123540734308;12723.109382343147;12737.74524509486;12824.294663793207;12898.48406063747;13266.137701049402;11396.886031139582;11465.197436179387;11476.368799716096;11533.82699259495;11534.59628912984;11659.650210493699;11850.644480665595;11944.880551194725;12002.279863208236;12012.099092567918;10106;10421.374717516974;11429.085673145963;11691.356975366436;11914.40427978615;9482.857757133786;9552.85670714926;9650.469224192737;9700.27247956392;9742.366746161477;9381.577828997575;10069.190190833373;10128.442935638315;10393.740156496147;10527.368357898551 06:17:37 INFO - 2016-02-25 06:17:37,035 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:17:37 INFO - 2016-02-25 06:17:37,035 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:17:37 INFO - 2016-02-25 06:17:37,035 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1263 06:17:37 INFO - 2016-02-25 06:17:37,035 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:17:37 INFO - 2016-02-25 06:17:37,035 DEBUG : BROWSER_OUTPUT: __startTimestamp1456409857024__endTimestamp 06:17:37 INFO - 2016-02-25 06:17:37,035 DEBUG : BROWSER_OUTPUT: 06:17:37 INFO - 2016-02-25 06:17:37,036 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:17:37 INFO - 2016-02-25 06:17:37,036 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:17:37 INFO - 2016-02-25 06:17:37,036 DEBUG : BROWSER_OUTPUT: 06:17:37 INFO - 2016-02-25 06:17:37,036 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5568.50 Median:5791.68 stddev:617.32 (10.7%) stddev-sans-first:593.62 06:17:37 INFO - 2016-02-25 06:17:37,036 DEBUG : BROWSER_OUTPUT: Values: 3326.0 3386.8 3406.7 3410.1 3444.6 5534.0 5563.6 5572.9 5587.7 5588.9 5560.2 5591.8 5592.1 5595.2 5607.1 4883.6 5044.5 5076.2 5095.4 5148.9 5030.8 5091.5 5092.0 5099.5 5099.5 5067.5 5072.1 5135.4 5146.5 5169.7 5067.6 5149.9 5158.1 5160.0 5160.1 5073.4 5143.4 5195.5 5205.3 5213.5 5197.2 5234.8 5282.4 5411.2 5457.9 5908.1 6055.2 6056.2 6059.1 6071.3 5954.3 6060.1 6078.5 6078.9 6082.7 5331.9 5445.0 5522.7 5598.9 5625.4 6074.5 6110.1 6113.1 6117.8 6118.1 5689.9 5932.9 5933.7 5937.7 5947.5 5898.0 5980.7 6101.0 6104.2 6137.6 6004.7 6045.3 6057.1 6057.2 6057.5 5815.7 5876.8 6031.5 6038.9 6042.8 4533.2 4539.3 4539.8 4540.6 4543.9 4066.8 4131.1 4141.2 4160.3 4160.7 5728.4 5756.2 5758.3 5768.5 5769.1 6016.5 6020.1 6026.3 6029.4 6034.2 5513.8 5597.7 5645.4 5763.6 5839.6 5240.4 5248.2 5251.5 5254.5 5255.2 5846.2 6283.9 6287.1 6289.6 6295.0 5932.6 5988.3 6079.7 6098.4 6110.1 6124.1 6193.6 6210.7 6227.0 6255.9 5816.8 5879.7 5883.5 5890.4 5923.3 5834.6 5898.7 5900.7 5916.3 5920.0 5784.8 5792.7 5795.9 5799.8 5803.1 5769.4 5787.9 5791.7 5864.7 5866.4 5779.6 5806.3 5857.1 5861.1 5864.2 5929.8 5964.0 5966.0 5978.9 5988.3 5523.4 5636.0 5701.3 5804.8 5842.3 06:17:37 INFO - 2016-02-25 06:17:37,036 DEBUG : BROWSER_OUTPUT: 06:17:37 INFO - 2016-02-25 06:17:37,036 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46553.41 Median:33586.25 stddev:73362.73 (218.4%) stddev-sans-first:73487.29 06:17:37 INFO - 2016-02-25 06:17:37,037 DEBUG : BROWSER_OUTPUT: Values: 570.6 644.1 657.3 659.0 664.2 31636.2 32313.7 32422.5 32450.7 32456.7 43878.6 44292.1 44340.1 44593.0 44688.8 9175.3 9355.9 9355.9 9357.5 9357.8 8202.8 8381.3 8392.7 9090.9 9133.8 10798.9 10921.6 10996.2 11016.1 11018.1 10792.5 10807.4 10846.6 10889.3 10921.6 10716.0 10826.1 10850.9 10868.7 10872.3 43559.0 43882.3 43984.6 43995.8 44041.1 3557.4 3600.7 3945.5 4162.4 4358.5 32795.0 33093.0 33204.2 34214.5 34237.8 4198.2 4218.3 4277.4 4290.3 4311.7 307892.0 308647.0 309019.0 309501.0 310944.0 60292.1 61633.0 63303.7 63931.0 68580.3 62393.0 62430.0 62750.7 62837.0 62839.0 17865.6 17956.7 18063.0 18065.0 18078.7 13930.7 13982.2 14050.6 14055.4 14071.6 20177.1 20416.2 20423.4 20438.9 20547.0 8497.9 8619.1 8710.1 8764.0 8788.4 1057.6 1089.0 1094.7 1130.7 1152.2 30842.2 31249.8 31325.5 31966.2 33112.3 1160.4 1182.6 1207.4 1219.3 1274.5 13258.7 15044.0 15328.8 15450.2 16365.2 281906.0 282358.0 283698.0 285327.0 285748.0 50624.0 50833.5 50943.5 51061.5 51309.7 1363.4 1377.2 1499.9 1513.2 1564.7 28275.0 29349.0 29423.9 29822.6 30064.4 44710.6 45092.3 45104.8 45131.8 45179.1 248498.0 250302.0 250567.0 250833.2 251297.0 34550.8 34739.5 34914.7 35319.3 35377.0 45550.8 45923.0 46248.1 46453.0 46695.5 37324.6 37509.8 38102.6 38196.2 38590.8 37635.6 37690.6 38289.2 38627.8 38669.4 38204.4 38485.6 38930.8 39369.8 39610.8 29777.9 32925.8 33541.7 33630.8 33848.8 26311.9 26842.5 27101.6 27222.9 27474.5 06:17:37 INFO - 2016-02-25 06:17:37,038 DEBUG : BROWSER_OUTPUT: 06:17:37 INFO - 2016-02-25 06:17:37,038 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31795.15 Median:10395.83 stddev:100084.16 (962.7%) stddev-sans-first:100337.12 06:17:37 INFO - 2016-02-25 06:17:37,038 DEBUG : BROWSER_OUTPUT: Values: 380.3 382.4 387.0 387.8 390.8 14235.1 16723.3 16918.8 18130.5 18140.5 17327.1 17495.6 17498.4 17899.8 18105.2 5087.8 5787.8 5788.0 5792.0 5792.9 4282.9 4354.2 5721.3 6192.9 6384.2 6140.4 6268.7 6296.1 6296.2 6324.2 6184.7 6212.0 6212.6 6230.3 6245.4 5557.7 5625.1 5631.4 5641.8 5642.3 21677.8 21929.8 22081.0 22165.6 22259.9 2390.9 2453.6 2489.8 2508.0 2545.5 13899.5 13936.8 14183.8 14353.9 14410.4 1888.4 1904.8 1924.5 1949.8 1976.3 63303.7 64332.0 64872.4 65316.0 66467.7 10299.2 10637.6 10759.7 10782.0 10846.8 14053.8 14141.8 14178.2 14182.6 14202.4 8200.8 8269.0 8274.3 8423.4 8444.5 8102.2 8119.5 8132.8 8171.0 8188.2 6339.4 6378.7 6416.9 6427.0 6438.9 1759.6 1786.7 1815.1 1839.5 1929.4 984.8 1000.6 1043.5 1048.9 1153.4 15784.0 18370.5 18875.8 19292.3 19336.6 981.2 1046.7 1053.2 1075.5 1104.3 10310.8 10388.9 10524.9 10540.5 10711.8 501316.0 504536.0 648476.0 684586.0 691553.0 87887.6 93858.5 94067.5 94561.5 95814.5 1194.5 1196.1 1236.2 1250.4 1268.1 15962.3 16081.5 16177.3 16217.9 16298.7 34781.7 35173.0 35507.8 35593.0 36572.3 41501.0 45387.1 46732.1 46924.0 49262.5 10171.7 10547.6 10576.3 10609.8 10611.2 12196.1 14220.5 18649.1 18836.2 18886.9 15468.5 15705.3 15736.3 15809.8 16039.5 12285.1 14008.9 14048.0 14424.8 14605.4 13297.3 14483.9 14680.9 15112.8 15939.9 10224.1 10444.6 10450.8 10539.5 10560.1 14309.9 14407.4 14704.8 14969.6 15103.2 06:17:37 INFO - 2016-02-25 06:17:37,038 DEBUG : BROWSER_OUTPUT: 06:17:37 INFO - 2016-02-25 06:17:37,038 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5676.33 Median:6552.58 stddev:2890.38 (44.1%) stddev-sans-first:2881.29 06:17:37 INFO - 2016-02-25 06:17:37,039 DEBUG : BROWSER_OUTPUT: Values: 1482.3 1539.9 1595.4 1725.2 1872.0 7511.8 7908.4 7912.7 7921.2 7921.6 6843.6 6959.5 7681.3 7925.7 8028.3 2335.2 2344.8 2368.4 2373.6 2374.5 2058.6 2360.3 2378.7 2396.7 2402.0 2028.7 2331.1 2370.5 2370.8 2371.5 2293.5 2339.1 2344.3 2344.5 2346.6 2352.8 2372.8 2384.4 2409.9 2410.6 7978.3 8058.2 8063.1 8070.0 8071.6 4882.8 5001.6 5005.0 5005.7 5008.0 3203.2 3230.9 3238.3 3245.5 3284.7 1006.2 1027.0 1027.2 1044.9 1052.7 11144.4 11161.8 11162.6 11165.4 11176.8 4453.2 4453.8 4553.7 4605.8 4607.8 9493.5 9508.4 9513.5 9521.8 9522.9 5031.7 5036.0 5037.5 5040.1 5046.6 4603.9 4604.3 4604.6 4605.2 4613.8 3836.3 3868.8 3876.3 3879.2 3909.2 1089.2 1131.7 1230.1 1234.1 1247.2 1197.0 1200.4 1206.3 1448.5 1470.3 7762.3 7818.5 7874.8 7878.2 7888.8 1171.5 1186.7 1189.5 1190.9 1195.0 6172.9 6229.0 6248.4 6249.4 6259.5 8309.8 8384.1 8398.2 8526.5 8546.0 9329.0 9545.9 9662.4 9670.4 9673.7 7658.2 7750.5 7840.0 7841.1 7843.5 7578.8 7721.0 7771.3 7781.9 7782.4 8630.0 8696.3 8868.6 8988.8 8993.1 8734.8 8836.3 8875.4 8883.5 9008.0 7221.5 7281.3 7317.5 7330.7 7339.6 7805.1 7835.2 7922.1 7941.6 7956.7 6390.3 7040.7 7343.7 7437.2 7500.5 6996.1 7333.0 7391.4 7407.3 7415.4 7364.1 7398.6 7399.1 7420.9 7421.6 6818.3 6828.4 6868.7 6868.8 6883.4 6714.8 6762.4 6793.8 6814.1 6838.9 06:17:37 INFO - 2016-02-25 06:17:37,039 DEBUG : BROWSER_OUTPUT: 06:17:37 INFO - 2016-02-25 06:17:37,039 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5438.44 Median:6218.30 stddev:1607.87 (25.9%) stddev-sans-first:1566.72 06:17:37 INFO - 2016-02-25 06:17:37,040 DEBUG : BROWSER_OUTPUT: Values: 369.4 371.6 372.6 374.7 376.4 6007.0 6087.4 6094.5 6109.4 6156.9 6026.9 6032.9 6036.6 6040.5 6042.9 4669.2 4716.2 4746.5 4758.9 4767.2 4721.3 4736.7 4745.2 4747.3 4747.6 4461.5 4540.1 4681.4 4696.6 4697.5 4560.8 4693.1 4706.3 4706.6 4714.4 4173.6 4180.9 4182.2 4193.0 4199.3 5521.1 5626.9 5655.3 5719.9 5735.1 5442.8 5462.5 5471.1 5471.8 5480.0 6404.9 6405.6 6418.5 6423.7 6424.4 4549.3 4627.4 4641.1 4641.5 4643.8 6606.2 6609.9 6610.5 6611.8 6613.3 4779.0 4779.6 4781.6 4785.1 4790.5 4846.3 4849.4 4849.8 4850.0 4851.0 5267.6 5403.2 5423.0 5442.6 5445.6 6448.4 6463.6 6468.7 6469.5 6472.1 1660.4 1677.3 1679.7 1679.8 1680.2 1135.7 1139.1 1140.1 1161.7 1163.4 6288.3 6294.4 6294.6 6297.5 6299.7 6654.1 6659.1 6660.3 6673.0 6681.1 6183.8 6287.6 6293.6 6294.1 6299.8 3584.4 3611.6 3613.0 3615.3 3626.1 6653.7 6966.4 6968.3 6970.3 6976.1 6722.0 6726.4 6886.4 6887.3 6889.4 6939.8 6955.1 6957.7 6957.8 6960.9 6559.1 6711.6 6712.6 6724.8 6742.1 6628.3 6628.3 6637.1 6637.7 6639.2 6917.6 6935.4 6945.9 6952.2 6956.6 4663.0 4666.4 4676.6 4700.1 4791.1 6634.8 6656.6 6657.4 6658.0 6658.6 6480.8 6488.8 6489.9 6492.0 6493.8 6358.3 6474.2 6474.9 6478.1 6488.7 6345.0 6359.0 6359.3 6360.4 6363.6 6484.0 6495.3 6498.4 6503.3 6503.4 6252.8 6289.6 6333.5 6341.6 6344.3 06:17:37 INFO - 2016-02-25 06:17:37,040 DEBUG : BROWSER_OUTPUT: 06:17:37 INFO - 2016-02-25 06:17:37,040 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14209.43 Median:4701.32 stddev:16507.31 (351.1%) stddev-sans-first:16523.22 06:17:37 INFO - 2016-02-25 06:17:37,040 DEBUG : BROWSER_OUTPUT: Values: 870.4 919.7 926.6 930.0 939.2 14023.9 14215.6 14222.9 14231.9 14237.9 13475.6 13485.8 13547.3 13552.4 13585.1 698.7 699.7 699.8 862.2 883.0 858.5 872.7 878.7 880.3 880.7 924.1 931.4 932.8 933.7 933.9 731.7 742.7 916.8 934.2 934.9 688.2 690.9 692.0 692.3 693.6 13146.2 13238.2 13283.5 13290.3 13297.9 11370.0 12170.9 12371.9 12448.7 12877.2 10180.9 10191.6 10412.6 10435.1 10498.9 3687.4 3724.1 3724.2 3729.9 3730.9 46501.7 46924.3 48945.0 49014.5 49448.0 10110.6 10168.8 10187.2 10828.1 10898.1 17869.0 17884.6 17912.6 17928.5 17952.0 7531.4 7650.7 7677.1 7729.5 7784.0 4611.1 4699.7 4703.0 4773.5 4776.5 3252.9 3276.3 3278.0 3284.5 3287.2 574.9 578.5 582.2 583.0 584.2 560.9 572.6 640.6 678.6 697.3 8654.9 8680.2 8742.6 8830.9 9006.4 669.0 687.9 691.0 694.3 730.8 4263.5 4294.5 4309.7 4343.8 4345.8 58540.4 59114.0 59185.4 59290.0 61927.4 54154.7 54190.5 54323.2 54535.7 54942.7 47733.0 48276.5 48402.8 48459.3 49869.8 8777.6 8943.0 8983.9 9063.4 9152.7 35847.0 36267.8 36529.5 37076.3 37476.6 42678.4 42890.6 46092.3 47365.5 47769.3 11106.6 11288.4 11327.4 11464.1 11686.1 12723.1 12737.7 12824.3 12898.5 13266.1 11396.9 11465.2 11476.4 11533.8 11534.6 11659.7 11850.6 11944.9 12002.3 12012.1 10106.0 10421.4 11429.1 11691.4 11914.4 9482.9 9552.9 9650.5 9700.3 9742.4 9381.6 10069.2 10128.4 10393.7 10527.4 06:17:37 INFO - 2016-02-25 06:17:37,040 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:17:37 INFO - 2016-02-25 06:17:37,040 DEBUG : BROWSER_OUTPUT: 06:17:37 INFO - 2016-02-25 06:17:37,590 INFO : Browser exited with error code: 0 06:17:37 INFO - 2016-02-25 06:17:37,605 INFO : Completed test dromaeo_css (00:18:30) 06:17:37 INFO - 2016-02-25 06:17:37,606 INFO : Starting test kraken 06:17:37 INFO - 2016-02-25 06:17:37,606 DEBUG : operating with platform_type : linux_ 06:17:37 INFO - 2016-02-25 06:17:37,606 INFO : Initialising browser for kraken test... 06:17:37 INFO - 2016-02-25 06:17:37,612 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuhIAH0/profile http://localhost:59976/getInfo.html 06:17:41 INFO - 2016-02-25 06:17:41,643 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:17:41 INFO - 2016-02-25 06:17:41,643 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:17:41 INFO - 2016-02-25 06:17:41,643 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:17:41 INFO - 2016-02-25 06:17:41,643 DEBUG : BROWSER_OUTPUT: __metrics 06:17:41 INFO - 2016-02-25 06:17:41,791 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] 06:17:42 INFO - 2016-02-25 06:17:42,617 INFO : Browser initialized. 06:17:42 INFO - 2016-02-25 06:17:42,618 INFO : Running cycle 1/1 for kraken test... 06:17:42 INFO - 2016-02-25 06:17:42,619 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuhIAH0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:17:54 INFO - 2016-02-25 06:17:54,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 132304896 06:17:54 INFO - 2016-02-25 06:17:54,222 DEBUG : BROWSER_OUTPUT: 06:17:56 INFO - 2016-02-25 06:17:56,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59976/tests/kraken/driver.html?testName=audio-beat-detection) 06:17:57 INFO - 2016-02-25 06:17:57,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 165998592 06:17:57 INFO - 2016-02-25 06:17:57,247 DEBUG : BROWSER_OUTPUT: 06:17:59 INFO - 2016-02-25 06:17:59,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59976/tests/kraken/driver.html?testName=audio-dft) 06:18:00 INFO - 2016-02-25 06:18:00,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 163487744 06:18:00 INFO - 2016-02-25 06:18:00,396 DEBUG : BROWSER_OUTPUT: 06:18:03 INFO - 2016-02-25 06:18:03,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59976/tests/kraken/driver.html?testName=audio-fft) 06:18:03 INFO - 2016-02-25 06:18:03,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 161992704 06:18:03 INFO - 2016-02-25 06:18:03,761 DEBUG : BROWSER_OUTPUT: 06:18:05 INFO - 2016-02-25 06:18:05,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59976/tests/kraken/driver.html?testName=audio-oscillator) 06:18:06 INFO - 2016-02-25 06:18:06,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 162488320 06:18:06 INFO - 2016-02-25 06:18:06,292 DEBUG : BROWSER_OUTPUT: 06:18:08 INFO - 2016-02-25 06:18:08,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:09 INFO - 2016-02-25 06:18:09,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 160550912 06:18:09 INFO - 2016-02-25 06:18:09,005 DEBUG : BROWSER_OUTPUT: 06:18:11 INFO - 2016-02-25 06:18:11,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59976/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:12 INFO - 2016-02-25 06:18:12,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 160079872 06:18:12 INFO - 2016-02-25 06:18:12,441 DEBUG : BROWSER_OUTPUT: 06:18:15 INFO - 2016-02-25 06:18:15,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59976/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:16 INFO - 2016-02-25 06:18:16,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 159502336 06:18:16 INFO - 2016-02-25 06:18:16,342 DEBUG : BROWSER_OUTPUT: 06:18:19 INFO - 2016-02-25 06:18:19,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59976/tests/kraken/driver.html?testName=json-parse-financial) 06:18:19 INFO - 2016-02-25 06:18:19,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 161345536 06:18:19 INFO - 2016-02-25 06:18:19,667 DEBUG : BROWSER_OUTPUT: 06:18:21 INFO - 2016-02-25 06:18:21,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:21 INFO - 2016-02-25 06:18:21,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 165818368 06:18:21 INFO - 2016-02-25 06:18:21,810 DEBUG : BROWSER_OUTPUT: 06:18:23 INFO - 2016-02-25 06:18:23,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:24 INFO - 2016-02-25 06:18:24,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 165474304 06:18:24 INFO - 2016-02-25 06:18:24,173 DEBUG : BROWSER_OUTPUT: 06:18:26 INFO - 2016-02-25 06:18:26,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:26 INFO - 2016-02-25 06:18:26,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 171466752 06:18:26 INFO - 2016-02-25 06:18:26,718 DEBUG : BROWSER_OUTPUT: 06:18:29 INFO - 2016-02-25 06:18:29,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:29 INFO - 2016-02-25 06:18:29,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 177635328 06:18:29 INFO - 2016-02-25 06:18:29,686 DEBUG : BROWSER_OUTPUT: 06:18:32 INFO - 2016-02-25 06:18:32,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:32 INFO - 2016-02-25 06:18:32,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 173686784 06:18:32 INFO - 2016-02-25 06:18:32,715 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59976/tests/kraken/driver.html?testName=ai-astar) 06:18:34 INFO - 2016-02-25 06:18:34,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 232529920 06:18:34 INFO - 2016-02-25 06:18:34,615 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,616 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:18:34 INFO - 2016-02-25 06:18:34,617 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:18:34 INFO - 2016-02-25 06:18:34,617 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:18:34 INFO - 2016-02-25 06:18:34,617 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:18:34 INFO - 2016-02-25 06:18:34,617 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;104;109;111;109;98;109;110;110 06:18:34 INFO - 2016-02-25 06:18:34,618 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;128;152;158;124;151;150;122;166;121 06:18:34 INFO - 2016-02-25 06:18:34,618 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;162;159;161;161;161;160;161 06:18:34 INFO - 2016-02-25 06:18:34,618 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;76;71;159;71;72;71;72;154;71 06:18:34 INFO - 2016-02-25 06:18:34,618 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;141;91;92;92;136;93;92;132 06:18:34 INFO - 2016-02-25 06:18:34,619 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;110;109;109;109;109;110 06:18:34 INFO - 2016-02-25 06:18:34,619 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;147;145;146;146;146;146;145;146 06:18:34 INFO - 2016-02-25 06:18:34,619 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;95;96;96;95;97;96 06:18:34 INFO - 2016-02-25 06:18:34,619 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;61;58;59;61;62;57;58;57;57 06:18:34 INFO - 2016-02-25 06:18:34,619 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;64;65;66;65;65;64;64;65 06:18:34 INFO - 2016-02-25 06:18:34,619 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;79;78;77;78;77;77;78;77 06:18:34 INFO - 2016-02-25 06:18:34,619 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;125;116;119;111;127;119;123;121;111 06:18:34 INFO - 2016-02-25 06:18:34,619 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;131;142;140;139;142;143;143;140;132;133 06:18:34 INFO - 2016-02-25 06:18:34,620 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;64;65;65;63;63;61;64;66 06:18:34 INFO - 2016-02-25 06:18:34,620 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:18:34 INFO - 2016-02-25 06:18:34,620 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:18:34 INFO - 2016-02-25 06:18:34,620 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,902 06:18:34 INFO - 2016-02-25 06:18:34,620 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:18:34 INFO - 2016-02-25 06:18:34,620 DEBUG : BROWSER_OUTPUT: __startTimestamp1456409914615__endTimestamp 06:18:34 INFO - 2016-02-25 06:18:34,620 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,622 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:18:34 INFO - 2016-02-25 06:18:34,622 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:18:34 INFO - 2016-02-25 06:18:34,622 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,622 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.90 Median:110.00 stddev:4.01 (3.6%) stddev-sans-first:4.26 06:18:34 INFO - 2016-02-25 06:18:34,622 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 104.0 109.0 111.0 109.0 98.0 109.0 110.0 110.0 06:18:34 INFO - 2016-02-25 06:18:34,622 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,622 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.50 Median:151.50 stddev:16.85 (11.1%) stddev-sans-first:17.44 06:18:34 INFO - 2016-02-25 06:18:34,622 DEBUG : BROWSER_OUTPUT: Values: 153.0 128.0 152.0 158.0 124.0 151.0 150.0 122.0 166.0 121.0 06:18:34 INFO - 2016-02-25 06:18:34,622 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,623 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 06:18:34 INFO - 2016-02-25 06:18:34,624 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 162.0 159.0 161.0 161.0 161.0 160.0 161.0 06:18:34 INFO - 2016-02-25 06:18:34,624 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,624 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.80 Median:71.00 stddev:35.73 (50.3%) stddev-sans-first:37.32 06:18:34 INFO - 2016-02-25 06:18:34,624 DEBUG : BROWSER_OUTPUT: Values: 71.0 76.0 71.0 159.0 71.0 72.0 71.0 72.0 154.0 71.0 06:18:34 INFO - 2016-02-25 06:18:34,624 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,624 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:92.00 stddev:21.46 (23.3%) stddev-sans-first:22.21 06:18:34 INFO - 2016-02-25 06:18:34,624 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 141.0 91.0 92.0 92.0 136.0 93.0 92.0 132.0 06:18:34 INFO - 2016-02-25 06:18:34,624 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 109.0 110.0 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 147.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 97.0 96.0 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:1.85 (3.1%) stddev-sans-first:1.96 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: Values: 59.0 61.0 58.0 59.0 61.0 62.0 57.0 58.0 57.0 57.0 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 65.0 66.0 65.0 65.0 64.0 64.0 65.0 06:18:34 INFO - 2016-02-25 06:18:34,625 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,626 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.50 stddev:0.71 (0.9%) stddev-sans-first:0.73 06:18:34 INFO - 2016-02-25 06:18:34,626 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 79.0 78.0 77.0 78.0 77.0 77.0 78.0 77.0 06:18:34 INFO - 2016-02-25 06:18:34,626 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,626 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:120.00 stddev:5.38 (4.5%) stddev-sans-first:5.67 06:18:34 INFO - 2016-02-25 06:18:34,626 DEBUG : BROWSER_OUTPUT: Values: 117.0 125.0 116.0 119.0 111.0 127.0 119.0 123.0 121.0 111.0 06:18:34 INFO - 2016-02-25 06:18:34,626 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,626 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.50 Median:141.00 stddev:4.70 (3.3%) stddev-sans-first:4.12 06:18:34 INFO - 2016-02-25 06:18:34,626 DEBUG : BROWSER_OUTPUT: Values: 131.0 142.0 140.0 139.0 142.0 143.0 143.0 140.0 132.0 133.0 06:18:34 INFO - 2016-02-25 06:18:34,626 DEBUG : BROWSER_OUTPUT: 06:18:34 INFO - 2016-02-25 06:18:34,626 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:65.00 stddev:1.55 (2.4%) stddev-sans-first:1.62 06:18:34 INFO - 2016-02-25 06:18:34,626 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 64.0 65.0 65.0 63.0 63.0 61.0 64.0 66.0 06:18:34 INFO - 2016-02-25 06:18:34,626 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:18:34 INFO - 2016-02-25 06:18:34,626 DEBUG : BROWSER_OUTPUT: 06:18:35 INFO - 2016-02-25 06:18:35,258 INFO : Browser exited with error code: 0 06:18:35 INFO - 2016-02-25 06:18:35,309 INFO : Completed test kraken (00:00:57) 06:18:35 INFO - 2016-02-25 06:18:35,309 INFO : Starting test v8_7 06:18:35 INFO - 2016-02-25 06:18:35,309 DEBUG : operating with platform_type : linux_ 06:18:35 INFO - 2016-02-25 06:18:35,309 INFO : Initialising browser for v8_7 test... 06:18:35 INFO - 2016-02-25 06:18:35,315 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb2CL7f/profile http://localhost:59976/getInfo.html 06:18:39 INFO - 2016-02-25 06:18:39,293 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:18:39 INFO - 2016-02-25 06:18:39,293 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:18:39 INFO - 2016-02-25 06:18:39,293 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:18:39 INFO - 2016-02-25 06:18:39,293 DEBUG : BROWSER_OUTPUT: __metrics 06:18:39 INFO - 2016-02-25 06:18:39,450 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] 06:18:40 INFO - 2016-02-25 06:18:40,245 INFO : Browser initialized. 06:18:40 INFO - 2016-02-25 06:18:40,246 INFO : Running cycle 1/1 for v8_7 test... 06:18:40 INFO - 2016-02-25 06:18:40,246 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb2CL7f/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:18:51 INFO - 2016-02-25 06:18:51,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 134545408 06:18:51 INFO - 2016-02-25 06:18:51,970 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-02-25 06:19:13,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59976/tests/v8_7/run.html (next: http://localhost:59976/tests/v8_7/run.html) 06:19:13 INFO - 2016-02-25 06:19:13,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 424992768 06:19:13 INFO - 2016-02-25 06:19:13,549 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-02-25 06:19:13,550 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:19:13 INFO - 2016-02-25 06:19:13,550 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:19:13 INFO - 2016-02-25 06:19:13,550 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:19:13 INFO - 2016-02-25 06:19:13,550 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:19:13 INFO - 2016-02-25 06:19:13,550 DEBUG : BROWSER_OUTPUT: |0;Richards;164.9620587264929 06:19:13 INFO - 2016-02-25 06:19:13,550 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.50074025333114 06:19:13 INFO - 2016-02-25 06:19:13,550 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.9321845469705 06:19:13 INFO - 2016-02-25 06:19:13,551 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 06:19:13 INFO - 2016-02-25 06:19:13,551 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1071.8113612004288 06:19:13 INFO - 2016-02-25 06:19:13,551 DEBUG : BROWSER_OUTPUT: |5;Earley;546.7468562055768 06:19:13 INFO - 2016-02-25 06:19:13,551 DEBUG : BROWSER_OUTPUT: |6;Boyer;10500 06:19:13 INFO - 2016-02-25 06:19:13,551 DEBUG : BROWSER_OUTPUT: |7;RegExp;23880.95238095238 06:19:13 INFO - 2016-02-25 06:19:13,551 DEBUG : BROWSER_OUTPUT: |8;Splay;527.1481286241434 06:19:13 INFO - 2016-02-25 06:19:13,551 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 06:19:13 INFO - 2016-02-25 06:19:13,552 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:19:13 INFO - 2016-02-25 06:19:13,552 DEBUG : BROWSER_OUTPUT: __startTimestamp1456409953549__endTimestamp 06:19:13 INFO - 2016-02-25 06:19:13,552 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-02-25 06:19:13,552 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:19:13 INFO - 2016-02-25 06:19:13,552 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:19:13 INFO - 2016-02-25 06:19:13,553 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-02-25 06:19:13,554 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.96 Median:164.96 stddev:0.00 (0.0%) 06:19:13 INFO - 2016-02-25 06:19:13,554 DEBUG : BROWSER_OUTPUT: Values: 165.0 06:19:13 INFO - 2016-02-25 06:19:13,554 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-02-25 06:19:13,555 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.50 Median:164.50 stddev:0.00 (0.0%) 06:19:13 INFO - 2016-02-25 06:19:13,555 DEBUG : BROWSER_OUTPUT: Values: 164.5 06:19:13 INFO - 2016-02-25 06:19:13,555 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-02-25 06:19:13,555 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 06:19:13 INFO - 2016-02-25 06:19:13,555 DEBUG : BROWSER_OUTPUT: Values: 277.9 06:19:13 INFO - 2016-02-25 06:19:13,556 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-02-25 06:19:13,556 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 06:19:13 INFO - 2016-02-25 06:19:13,556 DEBUG : BROWSER_OUTPUT: Values: 5148.7 06:19:13 INFO - 2016-02-25 06:19:13,556 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-02-25 06:19:13,556 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 06:19:13 INFO - 2016-02-25 06:19:13,557 DEBUG : BROWSER_OUTPUT: Values: 1071.8 06:19:13 INFO - 2016-02-25 06:19:13,557 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-02-25 06:19:13,557 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:546.75 Median:546.75 stddev:0.00 (0.0%) 06:19:13 INFO - 2016-02-25 06:19:13,557 DEBUG : BROWSER_OUTPUT: Values: 546.7 06:19:13 INFO - 2016-02-25 06:19:13,557 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-02-25 06:19:13,557 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10500.00 Median:10500.00 stddev:0.00 (0.0%) 06:19:13 INFO - 2016-02-25 06:19:13,557 DEBUG : BROWSER_OUTPUT: Values: 10500.0 06:19:13 INFO - 2016-02-25 06:19:13,558 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-02-25 06:19:13,558 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23880.95 Median:23880.95 stddev:0.00 (0.0%) 06:19:13 INFO - 2016-02-25 06:19:13,558 DEBUG : BROWSER_OUTPUT: Values: 23881.0 06:19:13 INFO - 2016-02-25 06:19:13,558 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-02-25 06:19:13,558 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:527.15 Median:527.15 stddev:0.00 (0.0%) 06:19:13 INFO - 2016-02-25 06:19:13,558 DEBUG : BROWSER_OUTPUT: Values: 527.1 06:19:13 INFO - 2016-02-25 06:19:13,559 DEBUG : BROWSER_OUTPUT: 06:19:13 INFO - 2016-02-25 06:19:13,559 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 06:19:13 INFO - 2016-02-25 06:19:13,559 DEBUG : BROWSER_OUTPUT: Values: 4840.6 06:19:13 INFO - 2016-02-25 06:19:13,559 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:19:13 INFO - 2016-02-25 06:19:13,559 DEBUG : BROWSER_OUTPUT: 06:19:14 INFO - 2016-02-25 06:19:14,242 INFO : Browser exited with error code: 0 06:19:14 INFO - 2016-02-25 06:19:14,258 INFO : Completed test v8_7 (00:00:38) 06:19:14 INFO - 2016-02-25 06:19:14,628 INFO : Completed test suite (00:20:07) 06:19:14 INFO - 2016-02-25 06:19:14,628 DEBUG : Working with test: dromaeo_css 06:19:14 INFO - 2016-02-25 06:19:14,629 DEBUG : Generating results file: dromaeo_css 06:19:14 INFO - 2016-02-25 06:19:14,630 DEBUG : Working with test: kraken 06:19:14 INFO - 2016-02-25 06:19:14,631 DEBUG : Generating results file: kraken 06:19:14 INFO - 2016-02-25 06:19:14,631 INFO : javascript benchmark 06:19:14 INFO - 2016-02-25 06:19:14,631 DEBUG : Working with test: v8_7 06:19:14 INFO - 2016-02-25 06:19:14,631 DEBUG : Generating results file: v8_7 06:19:14 INFO - 2016-02-25 06:19:14,632 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:19:14 INFO - 2016-02-25 06:19:14,782 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 06:19:14 INFO - 2016-02-25 06:19:14,782 DEBUG : process_Request line: dromaeo_css 7362.56 graph.html#tests=[[72,53,35]] 06:19:14 INFO - 2016-02-25 06:19:14,782 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:19:14 INFO - 2016-02-25 06:19:14,837 DEBUG : process_Request line: kraken 1478.70 graph.html#tests=[[232,53,35]] 06:19:14 INFO - 2016-02-25 06:19:14,838 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:19:14 INFO - 2016-02-25 06:19:14,863 DEBUG : process_Request line: v8_7 23069.91 graph.html#tests=[[230,53,35]] 06:19:14 INFO - 2016-02-25 06:19:14,865 INFO : javascript benchmark 06:19:14 INFO - 2016-02-25 06:19:14,868 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3325.9833700831496, 3386.796792192467, 3406.6593340665922, 3410.0792785947797, 3444.569428821397, 5534.031544479715, 5563.638363506369, 5572.857564199339, 5587.7485513151905, 5588.944110558893, 5560.2493663355435, 5591.832245032645, 5592.105263157896, 5595.160725891118, 5607.130894711316, 4883.584895283905, 5044.545990860822, 5076.238564215379, 5095.363079615029, 5148.948510514903, 5030.773615187307, 5091.516305950947, 5092.032513822381, 5099.4900509949075, 5099.541041306282, 5067.493250674921, 5072.112380333445, 5135.409427915782, 5146.485351464861, 5169.715665638389, 5067.619928505358, 5149.922751158717, 5158.148905430637, 5160.045391602565, 5160.071187186305, 5073.416557095944, 5143.434222235588, 5195.480451954774, 5205.349331333583, 5213.504717051912, 5197.220416937452, 5234.790608375661, 5282.366116066059, 5411.242426060355, 5457.863553411196, 5908.113782932552, 6055.212822333068, 6056.21269235001, 6059.121427393047, 6071.332153463116, 5954.255718035246, 6060.060690592965, 6078.452939235446, 6078.908816367758, 6082.665453400061, 5331.920021199685, 5445.0, 5522.696251706155, 5598.944010559923, 5625.353084395306, 6074.51403887688, 6110.083487476825, 6113.052476866093, 6117.755289788448, 6118.1434599156155, 5689.886202276014, 5932.940670593325, 5933.703314834327, 5937.673427961504, 5947.464728174485, 5898.026825573818, 5980.671063091485, 6101.023836186189, 6104.175936248638, 6137.631742095488, 6004.729787159588, 6045.274567051982, 6057.091436284592, 6057.182280392179, 6057.515398768176, 5815.680137592473, 5876.764929402776, 6031.547633927473, 6038.909416358758, 6042.788502402483, 4533.229351010336, 4539.251023581072, 4539.75031373271, 4540.636749060067, 4543.909121817545, 4066.776327302027, 4131.132462182915, 4141.151064031867, 4160.334346504545, 4160.667146628262, 5728.398518155617, 5756.1653560233535, 5758.280214973129, 5768.509676677446, 5769.134629805562, 6016.458518733335, 6020.127081573235, 6026.276846778327, 6029.3669164737075, 6034.155218269446, 5513.807016754395, 5597.6641401516035, 5645.407232240637, 5763.625364351304, 5839.591228614041, 5240.371155461369, 5248.239005344204, 5251.52736253739, 5254.527092561688, 5255.159174532057, 5846.239988801513, 6283.937160628427, 6287.056941458818, 6289.55973081889, 6294.968525157345, 5932.584719069624, 5988.251468566429, 6079.665618390854, 6098.390160983866, 6110.052941794029, 6124.081387791867, 6193.588236466165, 6210.720517576629, 6226.968865155826, 6255.937440625536, 5816.796412125555, 5879.735411906389, 5883.499902508163, 5890.440408161217, 5923.259592550931, 5834.562407819346, 5898.705064746659, 5900.675462849585, 5916.3492015877355, 5919.970400147971, 5784.797532086357, 5792.681402522901, 5795.884082318415, 5799.797007104899, 5803.100519419497, 5769.394213607511, 5787.913181302368, 5791.681457519709, 5864.67744274052, 5866.442687944638, 5779.566532509994, 5806.274215723035, 5857.121431785266, 5861.0915308127305, 5864.208331875142, 5929.822105336847, 5964.045752679551, 5966.015607424726, 5978.850528736816, 5988.311344195473, 5523.447655234444, 5636.0, 5701.287339082614, 5804.796832110856, 5842.298924129132], "unit": "ms", "name": "dojo.html", "value": 5528.930485023616}, {"lowerIsBetter": false, "replicates": [570.6062816656507, 644.0886146103264, 657.2737125476349, 658.9703463344152, 664.2195420381054, 31636.209094772643, 32313.67686323136, 32422.513662295027, 32450.67549324509, 32456.675433245662, 43878.561214387846, 44292.114157716904, 44340.11319773603, 44593.0, 44688.77655611718, 9175.311851611139, 9355.859662105075, 9355.906440935572, 9357.532123393838, 9357.766055848624, 8202.753917382459, 8381.329493640495, 8392.664293428255, 9090.86363704545, 9133.817323653522, 10798.946005269963, 10921.563137474492, 10996.23026388153, 11016.06363459107, 11018.063464605519, 10792.51433685486, 10807.351558906452, 10846.566137354497, 10889.292196007313, 10921.617743379024, 10716.0, 10826.079783218436, 10850.891491085067, 10868.728281792939, 10872.347659140476, 43559.0, 43882.341764873556, 43984.560154398365, 43995.78002109969, 44041.11917761659, 3557.4308110702423, 3600.71194304455, 3945.506811648544, 4162.375643653476, 4358.498772641124, 32795.0, 33093.0, 33204.1698957528, 34214.48678269828, 34237.82881085604, 4198.223328684173, 4218.303979843322, 4277.358396240557, 4290.2706539888295, 4311.741295522279, 307892.0, 308647.0, 309019.0, 309500.99999999773, 310944.0, 60292.095618565756, 61633.0, 63303.68348158322, 63931.0, 68580.28549286208, 62393.0, 62430.0, 62750.686246568475, 62837.0, 62839.0, 17865.553361165814, 17956.730649040273, 18063.0, 18065.0, 18078.728819067725, 13930.721385572231, 13982.230977296143, 14050.648733781738, 14055.367508462145, 14071.648208794657, 20177.092030858646, 20416.183352666023, 20423.387298381072, 20438.89780551088, 20547.0, 8497.915020849836, 8619.103797164613, 8710.12898710124, 8764.0, 8788.384813063152, 1057.5769692123213, 1088.9727756806144, 1094.7482079121687, 1130.7342774447998, 1152.2280072351546, 30842.228944276572, 31249.8437507811, 31325.530117047805, 31966.200844979063, 33112.3377532448, 1160.3965937712512, 1182.6156499137815, 1207.390267914715, 1219.3049961522024, 1274.5411651805343, 13258.73482530344, 15044.0, 15328.770068448983, 15450.150241736812, 16365.181740912907, 281906.0, 282358.0, 283698.0, 285327.0, 285748.0, 50624.0, 50833.49166508362, 50943.49056509462, 51061.48938510568, 51309.743451282506, 1363.4478036395276, 1377.2149874571398, 1499.8800095992076, 1513.1828812441158, 1564.749640057608, 28275.0, 29349.0, 29423.85288073546, 29822.552661710524, 30064.398712026075, 44710.55289447064, 45092.32361514514, 45104.774476128725, 45131.77434112808, 45179.09641807211, 248498.0, 250302.0, 250567.0, 250833.22083726982, 251297.0, 34550.82724586361, 34739.478907816905, 34914.65085349114, 35319.29361412809, 35377.0, 45550.77224613856, 45923.0, 46248.075038499715, 46453.0, 46695.533044669115, 37324.62675373212, 37509.81245093757, 38102.618973809906, 38196.236075278895, 38590.8422747318, 37635.62364376431, 37690.623093769806, 38289.23421531498, 38627.80686096552, 38669.41995870008, 38204.42693359546, 38485.615143848205, 38930.80534597309, 39369.80315098406, 39610.80194599008, 29777.85111074431, 32925.83537082299, 33541.66458335386, 33630.831845840614, 33848.7998280111, 26311.868440657676, 26842.463150737265, 27101.59347609748, 27222.863885681236, 27474.450510990067], "unit": "ms", "name": "ext.html", "value": 19782.731227847707}, {"lowerIsBetter": false, "replicates": [380.28506407953046, 382.4187235402187, 386.9825857836397, 387.808035022664, 390.80024325321256, 14235.145891246533, 16723.33106675733, 16918.830811691878, 18130.54673633158, 18140.546486337847, 17327.133643317848, 17495.5626109347, 17498.387556435526, 17899.821001789976, 18105.185266663, 5087.79648814047, 5787.826365209029, 5787.971060144714, 5792.0, 5792.884142317151, 4282.892927676818, 4354.17270718564, 5721.342045664739, 6192.87614247717, 6384.170057892467, 6140.355262697397, 6268.749250029993, 6296.055591661265, 6296.181496405461, 6324.241091069078, 6184.721687524072, 6212.0, 6212.627242365473, 6230.314665386803, 6245.437910588046, 5557.749901254453, 5625.09998400254, 5631.436856314377, 5641.830745077655, 5642.322921249435, 21677.783222167734, 21929.780702192933, 22081.0, 22165.55668886613, 22259.888700556556, 2390.916317928864, 2453.570625140593, 2489.800815934721, 2507.962380564293, 2545.478176973716, 13899.513517026855, 13936.790948135786, 14183.78724319136, 14353.85646143546, 14410.423583056665, 1888.424030670645, 1904.7619047619048, 1924.538110853399, 1949.7855235924037, 1976.3082920977686, 63303.683481582295, 64332.0, 64872.35127648758, 65316.0, 66467.66766166186, 10299.17606591471, 10637.574497020032, 10759.731006724738, 10782.0, 10846.78306433867, 14053.78919316211, 14141.787873181911, 14178.220197889008, 14182.574522764333, 14202.431902723776, 8200.794980125545, 8269.0, 8274.29668478174, 8423.368247381472, 8444.493330400195, 8102.230288122619, 8119.47223430487, 8132.837343253102, 8170.959145204355, 8188.222118898695, 6339.366063393623, 6378.712957916812, 6416.903746443807, 6427.0, 6438.903416448757, 1759.6392739488374, 1786.7319902014801, 1815.0924537731134, 1839.5350230690938, 1929.4112949913151, 984.7685793838442, 1000.6297669862198, 1043.5043354406596, 1048.8741351037925, 1153.423288355822, 15784.0, 18370.540736481697, 18875.81124188768, 19292.32476863303, 19336.613267734847, 981.2003217377815, 1046.7435478307711, 1053.2416660004785, 1075.4945175767377, 1104.3263609198382, 10310.793784124426, 10388.948055259676, 10524.894751052545, 10540.525676344583, 10711.83932241017, 501316.0, 504536.0, 648476.0, 684586.0, 691553.0, 87887.56056219678, 93858.53070734603, 94067.52966235125, 94561.52719236497, 95814.52092739491, 1194.5401020606955, 1196.1447564991074, 1236.2335352081766, 1250.3998080921026, 1268.0869773762877, 15962.281697323417, 16081.517554473385, 16177.272022758769, 16217.918910405373, 16298.67402651964, 34781.65218347784, 35173.0, 35507.822460888565, 35593.0, 36572.26855462929, 41501.0, 45387.09225815531, 46732.06535869196, 46924.0, 49262.50737492579, 10171.7457063574, 10547.630832920811, 10576.312539684895, 10609.787804244026, 10611.2041596879, 12196.085293603193, 14220.502282420066, 18649.067546622344, 18836.152373143515, 18886.905565472633, 15468.5359439217, 15705.293261803017, 15736.291866866248, 15809.841901581298, 16039.518814435585, 12285.078619103424, 14008.859911400756, 14048.0, 14424.783628245794, 14605.415783368546, 13297.26865022433, 14483.927580362031, 14680.853191468375, 15112.848871511143, 15939.920300398424, 10224.079832815083, 10444.63443779464, 10450.843237351293, 10539.473026348805, 10560.10239129652, 14309.856901431269, 14407.42370305176, 14704.77942830837, 14969.550913472613, 15103.169325687193], "unit": "ms", "name": "jquery.html", "value": 9666.767661979515}, {"lowerIsBetter": false, "replicates": [1482.2959094430148, 1539.8922075454718, 1595.3538816779194, 1725.215027162641, 1871.9532011699705, 7511.849763004743, 7908.4464087513825, 7912.723054693087, 7921.207879212076, 7921.564313962745, 6843.555168914029, 6959.5476294040855, 7681.270279323469, 7925.722599709012, 8028.317593004587, 2335.2410466598294, 2344.8358614896965, 2368.3723813189517, 2373.596488596943, 2374.4776149247223, 2058.6191554562456, 2360.2683168217823, 2378.7264464586533, 2396.6524853896176, 2401.9519609607796, 2028.6754119340908, 2331.079223706635, 2370.502194539149, 2370.798482129021, 2371.4782747795457, 2293.461036656376, 2339.076064954342, 2344.3318654183563, 2344.4607740219676, 2346.589346864292, 2352.752960939094, 2372.810175185981, 2384.4158181245534, 2409.8795060246916, 2410.6263529152834, 7978.321842643382, 8058.234467725557, 8063.1130575636635, 8070.0, 8071.596420179027, 4882.780274887603, 5001.574866136383, 5005.0, 5005.674631148963, 5007.974960125212, 3203.167176534095, 3230.8869189578254, 3238.3037646906027, 3245.513173024042, 3284.687954644305, 1006.1598565198068, 1027.0, 1027.2295778166376, 1044.8850626431085, 1052.7420781908404, 11144.442777861075, 11161.776764464828, 11162.553497860075, 11165.441727913572, 11176.776464470666, 4453.19842428366, 4453.844115456009, 4553.704009239389, 4605.838795642137, 4607.792649330788, 9493.525323733786, 9508.429494230368, 9513.476758778334, 9521.761955951157, 9522.90477095234, 5031.698098114125, 5036.0, 5037.5214354636255, 5040.092783298968, 5046.571041461443, 4603.8849028773875, 4604.286335617984, 4604.631629469634, 4605.194091034055, 4613.792379342937, 3836.3478208704587, 3868.806559672061, 3876.282887665791, 3879.2047630235734, 3909.237698648736, 1089.232091375594, 1131.6661584832493, 1230.0958795285458, 1234.1237721217856, 1247.2454165229906, 1197.0005045786866, 1200.4237965776476, 1206.2943178240828, 1448.5147475595793, 1470.2795630141368, 7762.340201082971, 7818.530888146729, 7874.763757087297, 7878.172791856887, 7888.7633370998965, 1171.5255321594768, 1186.7270527778487, 1189.4587962477053, 1190.8630507491575, 1195.014113356467, 6172.8765424691255, 6228.968855155786, 6248.437640612276, 6249.437550620466, 6259.530535209787, 8309.750707478785, 8384.119667434832, 8398.244158025807, 8526.488410695378, 8545.957270213734, 9328.95335523318, 9545.90454095464, 9662.420254784736, 9670.419774813534, 9673.661421850202, 7658.2341765824085, 7750.4574679773, 7840.0, 7841.059072911287, 7843.490173138728, 7578.772636820904, 7720.961395192988, 7771.33943614799, 7781.883271751041, 7782.416318776001, 8629.956850215709, 8696.304295656206, 8868.556572171494, 8988.775280618036, 8993.055729148346, 8734.84119822688, 8836.337274704552, 8875.423097498642, 8883.511406872683, 9007.954960225157, 7221.458390620619, 7281.271872812888, 7317.524360916524, 7330.743423980135, 7339.59632220233, 7805.141434442094, 7835.177306382748, 7922.0889597694695, 7941.602919853869, 7956.681732730626, 6390.329015453311, 7040.718371265297, 7343.7062517500835, 7437.181909989788, 7500.512466689866, 6996.090508233897, 7332.96333518329, 7391.371733402506, 7407.2592740725495, 7415.406767458699, 7364.079490063742, 7398.556086634819, 7399.112106547249, 7420.925790742023, 7421.628918553943, 6818.318168183142, 6828.385445309747, 6868.725250989904, 6868.828279292858, 6883.449324054164, 6714.832129196614, 6762.391384775394, 6793.830154245986, 6814.1482314710665, 6838.931610684029], "unit": "ms", "name": "mootools.html", "value": 4683.858336327199}, {"lowerIsBetter": false, "replicates": [369.3775987461127, 371.5949614919737, 372.5510759534761, 374.73768362146507, 376.42031271841347, 6007.0, 6087.360827113144, 6094.481969032632, 6109.389061093889, 6156.938430615693, 6026.8794624107495, 6032.879342413149, 6036.577439579231, 6040.456358927696, 6042.909356359647, 4669.229577119771, 4716.245400735883, 4746.5490778376, 4758.881027974294, 4767.237242041274, 4721.268203428457, 4736.739479328636, 4745.21703918853, 4747.264174053027, 4747.5964543013715, 4461.486929003174, 4540.091981603676, 4681.438227412716, 4696.64775141864, 4697.4832768395445, 4560.817567297321, 4693.084848454553, 4706.317583950342, 4706.599939005188, 4714.363560919266, 4173.624373806341, 4180.853670121562, 4182.163567286555, 4192.979035104835, 4199.307114326132, 5521.061419558685, 5626.887462250773, 5655.264815573949, 5719.885602287973, 5735.053716136874, 5442.782288708447, 5462.481064298885, 5471.097268950618, 5471.835844924619, 5480.0, 6404.935950640527, 6405.5516113872045, 6418.486521078303, 6423.710933008026, 6424.421802037839, 4549.31760235964, 4627.421572303462, 4641.141388843041, 4641.512641172662, 4643.767811609439, 6606.174228221473, 6609.867802643968, 6610.504212184105, 6611.834704132387, 6613.305602911673, 4779.044191161782, 4779.569838714463, 4781.617470602343, 4785.066911952136, 4790.5448982346625, 4846.345743324606, 4849.369581954324, 4849.75751212438, 4850.0, 4850.95149048512, 5267.578593712494, 5403.243545903577, 5423.0, 5442.564594832404, 5445.618806683494, 6448.3874031967825, 6463.579867308704, 6468.676566171766, 6469.482441404771, 6472.061551075068, 1660.3939562060002, 1677.3123019562165, 1679.7312430011139, 1679.8320167983104, 1680.2438902493682, 1135.6649788312468, 1139.0773473486502, 1140.1050175612104, 1161.651504548632, 1163.3892206591438, 6288.339724328879, 6294.370562943761, 6294.559380843297, 6297.4962003039645, 6299.716512756845, 6654.134962454947, 6659.067730517731, 6660.333966603398, 6672.96663516689, 6681.1314529110905, 6183.84540386485, 6287.559870809091, 6293.559450838489, 6294.118823364733, 6299.811005669837, 3584.4264917613577, 3611.638836116367, 3612.9638703613155, 3615.29501747162, 3626.0753507855857, 6653.733850646016, 6966.407855332353, 6968.268331825187, 6970.302969703091, 6976.093107895941, 6722.0, 6726.3609957054005, 6886.449084073262, 6887.311268873073, 6889.414399775975, 6939.826504337432, 6955.061066756024, 6957.65211739411, 6957.79126626202, 6960.895586566206, 6559.114519539992, 6711.563748356341, 6712.597244165366, 6724.7646332378135, 6742.089817874524, 6628.27089020217, 6628.304028076983, 6637.103990961352, 6637.734490620514, 6639.170103737033, 6917.584944903322, 6935.445164386938, 6945.930540694529, 6952.200496942916, 6956.617386043817, 4663.0, 4666.393368862026, 4676.6492513060975, 4700.106979673851, 4791.065742180242, 6634.800955971328, 6656.633885136364, 6657.40083392497, 6658.0345849852465, 6658.600483970978, 6480.7731729391135, 6488.772892948724, 6489.935100648933, 6492.0261960706275, 6493.837654058686, 6358.300586935341, 6474.223093228654, 6474.935250647433, 6478.093066970722, 6488.6755662215755, 6344.968275158594, 6359.0, 6359.268684101387, 6360.363963603602, 6363.5545511813725, 6484.0, 6495.253045899782, 6498.447631951148, 6503.349665033459, 6503.382178693017, 6252.752527376837, 6289.622622642656, 6333.524985626004, 6341.619502829845, 6344.302126766144], "unit": "ms", "name": "prototype.html", "value": 4927.362925059467}, {"lowerIsBetter": false, "replicates": [870.3907264914561, 919.6597259014166, 926.5922993882696, 929.9581518831652, 939.234523863052, 14023.859761402384, 14215.644608884782, 14222.928885355559, 14231.928840355784, 14237.857621423782, 13475.595732128028, 13485.797713034312, 13547.322633868316, 13552.39014244359, 13585.116967397136, 698.6681326369971, 699.6851416862406, 699.7620808924964, 862.2196911794836, 883.0374891368407, 858.5192292316292, 872.720729366603, 878.7012415778634, 880.3221519430035, 880.6873559886212, 924.1359329027347, 931.417863835103, 932.8320902237629, 933.705882646964, 933.9486328251943, 731.6853752886257, 742.6509540515949, 916.8258030974093, 934.2152591822901, 934.8878134623889, 688.2463702246033, 690.9136357955256, 691.9827004324882, 692.3353580562666, 693.6358411833777, 13146.21122732639, 13238.205707657571, 13283.468661253635, 13290.3354832258, 13297.86702132976, 11370.0, 12170.878291217152, 12371.896777547838, 12448.688782780413, 12877.162984405984, 10180.949095254551, 10191.643292484801, 10412.583496660125, 10435.113015393701, 10498.895011049868, 3687.3915803892323, 3724.0689827543115, 3724.2365315110337, 3729.9440508392395, 3730.9440358394645, 46501.667055894846, 46924.296135558, 48945.0, 49014.50985490135, 49448.0, 10110.646127385506, 10168.796624067478, 10187.235957303232, 10828.133749300037, 10898.07366373867, 17869.0, 17884.55288617769, 17912.641747165246, 17928.462146135636, 17952.0, 7531.359834414026, 7650.693972241048, 7677.117131529834, 7729.536227826348, 7783.9610801946765, 4611.054733779567, 4699.694519856198, 4702.95297047032, 4773.498782627844, 4776.546228108394, 3252.9349413012083, 3276.2955964467756, 3277.9836100819343, 3284.540164376989, 3287.2439338952177, 574.873527823878, 578.4533615733092, 582.1558739827267, 583.0496291045569, 584.1704779213527, 560.907450270709, 572.5705720709468, 640.6220330005226, 678.6233640329566, 697.2615375459993, 8654.87017694735, 8680.175383338572, 8742.606582703793, 8830.911690883137, 9006.414583052081, 668.979930602073, 687.9105716256854, 690.9516333856582, 694.3230350408312, 730.7698075106324, 4263.5096963849555, 4294.484661840599, 4309.67277670061, 4343.804528796211, 4345.804438800262, 58540.414595853494, 59114.0, 59185.40814591885, 59290.0, 61927.38072619306, 54154.729226353615, 54190.45809541933, 54323.18515222275, 54535.727321363935, 54942.72528637411, 47733.0, 48276.5172348272, 48402.75798620984, 48459.27311090336, 49869.75065124651, 8777.648894044167, 8943.0, 8983.91016089857, 9063.351024708165, 9152.679656212267, 35847.0, 36267.81866090652, 36529.452058218616, 37076.258474830895, 37476.62523374731, 42678.359824602034, 42890.57109428866, 46092.30861537012, 47365.52634473749, 47769.28346074881, 11106.61126860556, 11288.379139147426, 11327.433628318386, 11464.140189485988, 11686.123540734308, 12723.109382343147, 12737.74524509486, 12824.294663793207, 12898.48406063747, 13266.137701049402, 11396.886031139582, 11465.197436179387, 11476.368799716096, 11533.82699259495, 11534.59628912984, 11659.650210493699, 11850.644480665595, 11944.880551194725, 12002.279863208236, 12012.099092567918, 10106.0, 10421.374717516974, 11429.085673145963, 11691.356975366436, 11914.40427978615, 9482.857757133786, 9552.85670714926, 9650.469224192737, 9700.27247956392, 9742.366746161477, 9381.577828997575, 10069.190190833373, 10128.442935638315, 10393.740156496147, 10527.368357898551], "unit": "ms", "name": "yui.html", "value": 6526.878149602028}], "name": "dromaeo_css", "value": 7362.555152522751}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 104.0, 109.0, 111.0, 109.0, 98.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [153.0, 128.0, 152.0, 158.0, 124.0, 151.0, 150.0, 122.0, 166.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 162.0, 159.0, 161.0, 161.0, 161.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [71.0, 76.0, 71.0, 159.0, 71.0, 72.0, 71.0, 72.0, 154.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 88.8}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 141.0, 91.0, 92.0, 92.0, 136.0, 93.0, 92.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [59.0, 61.0, 58.0, 59.0, 61.0, 62.0, 57.0, 58.0, 57.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 66.0, 65.0, 65.0, 64.0, 64.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 79.0, 78.0, 77.0, 78.0, 77.0, 77.0, 78.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.5}, {"lowerIsBetter": true, "replicates": [117.0, 125.0, 116.0, 119.0, 111.0, 127.0, 119.0, 123.0, 121.0, 111.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.9}, {"lowerIsBetter": true, "replicates": [131.0, 142.0, 140.0, 139.0, 142.0, 143.0, 143.0, 140.0, 132.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.5}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 64.0, 65.0, 65.0, 63.0, 63.0, 61.0, 64.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.2}], "name": "kraken", "value": 1478.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.9620587264929], "unit": "score", "name": "Richards", "value": 214.00072399999993}, {"lowerIsBetter": false, "replicates": [164.50074025333114], "unit": "score", "name": "DeltaBlue", "value": 401.93132199999985}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [546.7468562055768], "unit": "score", "name": "Earley", "value": 1218.960827}, {"lowerIsBetter": false, "replicates": [10500.0], "unit": "score", "name": "Boyer", "value": 63.47266666666663}, {"lowerIsBetter": false, "replicates": [23880.95238095238], "unit": "score", "name": "RegExp", "value": 38.146929212362885}, {"lowerIsBetter": false, "replicates": [527.1481286241434], "unit": "score", "name": "Splay", "value": 154.588427}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23069.910049352056}]} 06:19:14 INFO - RETURN: dromaeo_css: 7362.56 06:19:14 INFO - RETURN: kraken: 1478.70 06:19:14 INFO - RETURN: v8_7: 23069.91 06:19:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23069.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1478.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7362.56"}}} 06:19:14 INFO - Return code: 0 06:19:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:19:14 INFO - # TBPL SUCCESS # 06:19:14 INFO - Running post-action listener: _resource_record_post_action 06:19:14 INFO - Running post-run listener: _resource_record_post_run 06:19:16 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 319488; Write bytes: 502824960; Read time: 104; Write time: 452516 06:19:16 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 239775744; Read time: 0; Write time: 299908 06:19:16 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 319488; Write bytes: 263049216; Read time: 104; Write time: 152608 06:19:16 INFO - Running post-run listener: _upload_blobber_files 06:19:16 INFO - Blob upload gear active. 06:19:16 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:19:16 INFO - Copying logs to upload dir... 06:19:16 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.849048 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-02-25 06:19:15.749308) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-25 06:19:15.753343) ========= 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=03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008866 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456400188/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-25 06:19:15.805647) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 06:19:15.806029) ========= 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=03627c79f6bb3d1578c4a402000001ba-1456408561.509913-1535047208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 06:19:15.857362) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 06:19:15.857790) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 06:19:15.858158) ========= ========= Total master_lag: 1.28 =========