builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1455431232.04 results: success (0) buildid: 20160213193337 builduid: b7fb0b8fe6294e95a322dbefbe898940 revision: e355cacefc881ba360d412853b57e8e060e966f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.045089) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.045508) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.045821) ========= 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=82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006369 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.089904) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.090254) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.117133) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.117448) ========= 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=82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.178251) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.178568) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.178933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.179234) ========= 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=82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-13 22:27:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.4M=0s 2016-02-13 22:27:12 (84.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179165 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.383748) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.384062) ========= 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=82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014360 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:12.440222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-13 22:27:12.443655) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e355cacefc881ba360d412853b57e8e060e966f4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e355cacefc881ba360d412853b57e8e060e966f4 --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=82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-13 22:27:12,770 truncating revision to first 12 chars 2016-02-13 22:27:12,770 Setting DEBUG logging. 2016-02-13 22:27:12,770 attempt 1/10 2016-02-13 22:27:12,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e355cacefc88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-13 22:27:13,729 unpacking tar archive at: mozilla-central-e355cacefc88/testing/mozharness/ program finished with exit code 0 elapsedTime=1.286930 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-13 22:27:13.745647) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:13.746462) ========= echo e355cacefc881ba360d412853b57e8e060e966f4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e355cacefc881ba360d412853b57e8e060e966f4'] 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=82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e355cacefc881ba360d412853b57e8e060e966f4 program finished with exit code 0 elapsedTime=0.004684 script_repo_revision: 'e355cacefc881ba360d412853b57e8e060e966f4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:13.801378) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:13.802083) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-13 22:27:13.812902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-13 22:27:13.813231) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:27:14 INFO - MultiFileLogger online at 20160213 22:27:14 in /builds/slave/test-pgo 22:27:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:27:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:27:14 INFO - {'append_to_log': False, 22:27:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:27:14 INFO - 'blob_upload_branch': 'Firefox', 22:27:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:27:14 INFO - 'branch': 'Firefox', 22:27:14 INFO - 'buildbot_json_path': 'buildprops.json', 22:27:14 INFO - 'config_files': ('talos/linux_config.py',), 22:27:14 INFO - 'default_actions': ('clobber', 22:27:14 INFO - 'read-buildbot-config', 22:27:14 INFO - 'download-and-extract', 22:27:14 INFO - 'populate-webroot', 22:27:14 INFO - 'create-virtualenv', 22:27:14 INFO - 'install', 22:27:14 INFO - 'run-tests'), 22:27:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:27:14 INFO - 'download_minidump_stackwalk': True, 22:27:14 INFO - 'download_symbols': 'ondemand', 22:27:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:27:14 INFO - 'tooltool.py': '/tools/tooltool.py', 22:27:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:27:14 INFO - '/tools/misc-python/virtualenv.py')}, 22:27:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:27:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:27:14 INFO - 'installer_path': 'installer.exe', 22:27:14 INFO - 'log_level': 'info', 22:27:14 INFO - 'log_name': 'talos', 22:27:14 INFO - 'log_to_console': True, 22:27:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:27:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:27:14 INFO - 'opt_config_files': (), 22:27:14 INFO - 'pip_index': False, 22:27:14 INFO - 'sps_profile': False, 22:27:14 INFO - 'sps_profile_interval': 0, 22:27:14 INFO - 'suite': 'dromaeojs', 22:27:14 INFO - 'system_bits': '32', 22:27:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:27:14 INFO - 'title': 'talos-linux64-ix-055', 22:27:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:27:14 INFO - 'use_talos_json': True, 22:27:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:27:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:27:14 INFO - 'work_dir': 'build'} 22:27:14 INFO - ##### 22:27:14 INFO - ##### Running clobber step. 22:27:14 INFO - ##### 22:27:14 INFO - Running pre-action listener: _resource_record_pre_action 22:27:14 INFO - Running main action method: clobber 22:27:14 INFO - rmtree: /builds/slave/test-pgo/build 22:27:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:27:15 INFO - Running post-action listener: _resource_record_post_action 22:27:15 INFO - ##### 22:27:15 INFO - ##### Running read-buildbot-config step. 22:27:15 INFO - ##### 22:27:15 INFO - Running pre-action listener: _resource_record_pre_action 22:27:15 INFO - Running main action method: read_buildbot_config 22:27:15 INFO - Using buildbot properties: 22:27:15 INFO - { 22:27:15 INFO - "project": "", 22:27:15 INFO - "product": "firefox", 22:27:15 INFO - "script_repo_revision": "production", 22:27:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:27:15 INFO - "repository": "", 22:27:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:27:15 INFO - "buildid": "20160213193337", 22:27:15 INFO - "pgo_build": "True", 22:27:15 INFO - "basedir": "/builds/slave/test-pgo", 22:27:15 INFO - "buildnumber": 671, 22:27:15 INFO - "slavename": "talos-linux64-ix-055", 22:27:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:27:15 INFO - "platform": "ubuntu64_hw", 22:27:15 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:27:15 INFO - "branch": "mozilla-central", 22:27:15 INFO - "repo_path": "mozilla-central", 22:27:15 INFO - "revision": "e355cacefc881ba360d412853b57e8e060e966f4", 22:27:15 INFO - "stage_platform": "linux64-pgo", 22:27:15 INFO - "builduid": "b7fb0b8fe6294e95a322dbefbe898940", 22:27:15 INFO - "slavebuilddir": "test" 22:27:15 INFO - } 22:27:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:27:15 INFO - Running post-action listener: _resource_record_post_action 22:27:15 INFO - ##### 22:27:15 INFO - ##### Running download-and-extract step. 22:27:15 INFO - ##### 22:27:15 INFO - Running pre-action listener: _resource_record_pre_action 22:27:15 INFO - Running main action method: download_and_extract 22:27:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:27:15 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')]} 22:27:15 INFO - https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:27:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/test_packages.json 22:27:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/test_packages.json 22:27:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:27:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:27:15 INFO - Downloaded 1448 bytes. 22:27:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:27:15 INFO - Using the following test package requirements: 22:27:15 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:27:15 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:27:15 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:27:15 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:15 INFO - u'jsshell-linux-x86_64.zip'], 22:27:15 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:27:15 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:27:15 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:27:15 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:27:15 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:27:15 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:27:15 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:27:15 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:27:15 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')]} 22:27:15 INFO - https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:27:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:27:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:27:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:27:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:27:16 INFO - Downloaded 23296245 bytes. 22:27:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:27:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:27:18 INFO - Return code: 0 22:27:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:27:18 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')]} 22:27:18 INFO - https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:27:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:27:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:27:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:27:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:27:23 INFO - Downloaded 23296245 bytes. 22:27:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:27:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:27:25 INFO - Return code: 0 22:27:25 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')]} 22:27:25 INFO - https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:27:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:27:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:27:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:27:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:27:26 INFO - Downloaded 10707070 bytes. 22:27:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:27:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:27:26 INFO - Return code: 0 22:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:26 INFO - https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:27:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:27:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:27:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:27:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:27:28 INFO - Downloaded 56509585 bytes. 22:27:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:27:28 INFO - mkdir: /builds/slave/test-pgo/properties 22:27:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:27:28 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:27:28 INFO - Contents: 22:27:28 INFO - build_url:https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:27:29 INFO - Running post-action listener: _resource_record_post_action 22:27:29 INFO - Running post-action listener: set_extra_try_arguments 22:27:29 INFO - ##### 22:27:29 INFO - ##### Running populate-webroot step. 22:27:29 INFO - ##### 22:27:29 INFO - Running pre-action listener: _resource_record_pre_action 22:27:29 INFO - Running main action method: populate_webroot 22:27:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:27:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:27:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:27:29 INFO - '--tppagecycles', 22:27:29 INFO - '7'], 22:27:29 INFO - 'tests': ['tsvgm']}}, 22:27:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:27:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:27:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:27:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:27:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:27:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:27:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:27:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:29 INFO - 'talos_options': ['--e10s'], 22:27:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:27:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:29 INFO - 'tests': ['damp', 'tps']}, 22:27:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:29 INFO - 'talos_options': ['--e10s'], 22:27:29 INFO - 'tests': ['damp', 'tps']}, 22:27:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:27:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:27:29 INFO - 'other': {'tests': ['a11yr', 22:27:29 INFO - 'ts_paint', 22:27:29 INFO - 'tpaint', 22:27:29 INFO - 'sessionrestore', 22:27:29 INFO - 'sessionrestore_no_auto_restore']}, 22:27:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:27:29 INFO - 'tests': ['a11yr', 22:27:29 INFO - 'ts_paint', 22:27:29 INFO - 'tpaint', 22:27:29 INFO - 'sessionrestore', 22:27:29 INFO - 'sessionrestore_no_auto_restore']}, 22:27:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:27:29 INFO - 'tests': ['a11yr', 22:27:29 INFO - 'ts_paint', 22:27:29 INFO - 'tpaint', 22:27:29 INFO - 'sessionrestore', 22:27:29 INFO - 'sessionrestore_no_auto_restore']}, 22:27:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:27:29 INFO - 'tests': ['a11yr', 22:27:29 INFO - 'ts_paint', 22:27:29 INFO - 'tpaint', 22:27:29 INFO - 'sessionrestore', 22:27:29 INFO - 'sessionrestore_no_auto_restore']}, 22:27:29 INFO - 'other_l64': {'tests': ['a11yr', 22:27:29 INFO - 'ts_paint', 22:27:29 INFO - 'tpaint', 22:27:29 INFO - 'sessionrestore', 22:27:29 INFO - 'sessionrestore_no_auto_restore']}, 22:27:29 INFO - 'other_nol64': {'tests': ['a11yr', 22:27:29 INFO - 'ts_paint', 22:27:29 INFO - 'tpaint', 22:27:29 INFO - 'sessionrestore', 22:27:29 INFO - 'sessionrestore_no_auto_restore']}, 22:27:29 INFO - 'svgr': {'tests': ['tsvgx', 22:27:29 INFO - 'tsvgr_opacity', 22:27:29 INFO - 'tart', 22:27:29 INFO - 'tscrollx', 22:27:29 INFO - 'cart']}, 22:27:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:27:29 INFO - 'tests': ['tsvgx', 22:27:29 INFO - 'tsvgr_opacity', 22:27:29 INFO - 'tart', 22:27:29 INFO - 'tscrollx', 22:27:29 INFO - 'cart']}, 22:27:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:29 INFO - 'tests': ['tp5o']}, 22:27:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:29 INFO - 'talos_options': ['--e10s'], 22:27:29 INFO - 'tests': ['tp5o']}, 22:27:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:29 INFO - 'talos_options': ['--xperf_path', 22:27:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:27:29 INFO - 'tests': ['tp5n']}, 22:27:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:29 INFO - 'talos_options': ['--e10s', 22:27:29 INFO - '--xperf_path', 22:27:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:27:29 INFO - 'tests': ['tp5n']}}, 22:27:29 INFO - 'talos.zip': {'path': '', 22:27:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:27:29 INFO - Running post-action listener: _resource_record_post_action 22:27:29 INFO - ##### 22:27:29 INFO - ##### Running create-virtualenv step. 22:27:29 INFO - ##### 22:27:29 INFO - Running pre-action listener: _resource_record_pre_action 22:27:29 INFO - Running main action method: create_virtualenv 22:27:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:27:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:27:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:27:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:27:29 INFO - Using real prefix '/usr' 22:27:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:27:29 INFO - Installing distribute.............................................................................................................................................................................................done. 22:27:31 INFO - Installing pip.................done. 22:27:31 INFO - Return code: 0 22:27:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff215cf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e33670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec28c0>, '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 0x1ec37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3c50>, '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': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', '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 22:27:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:27:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:27:31 INFO - Using env: {'DISPLAY': ':0', 22:27:31 INFO - 'HOME': '/home/cltbld', 22:27:31 INFO - 'LANG': 'en_US.UTF-8', 22:27:31 INFO - 'LANGUAGE': 'en_US:en', 22:27:31 INFO - 'LOGNAME': 'cltbld', 22:27:31 INFO - 'MAIL': '/var/mail/cltbld', 22:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:31 INFO - 'MOZ_NO_REMOTE': '1', 22:27:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:31 INFO - 'NO_EM_RESTART': '1', 22:27:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:31 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:31 INFO - 'SHELL': '/bin/bash', 22:27:31 INFO - 'SHLVL': '1', 22:27:31 INFO - 'TERM': 'linux', 22:27:31 INFO - 'TMOUT': '86400', 22:27:31 INFO - 'USER': 'cltbld', 22:27:31 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', 22:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:31 INFO - '_': '/tools/buildbot/bin/python'} 22:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:31 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 22:27:31 INFO - Cleaning up... 22:27:31 INFO - Return code: 0 22:27:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff215cf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e33670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec28c0>, '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 0x1ec37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3c50>, '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': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', '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 22:27:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:27:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:27:31 INFO - Using env: {'DISPLAY': ':0', 22:27:31 INFO - 'HOME': '/home/cltbld', 22:27:31 INFO - 'LANG': 'en_US.UTF-8', 22:27:31 INFO - 'LANGUAGE': 'en_US:en', 22:27:31 INFO - 'LOGNAME': 'cltbld', 22:27:31 INFO - 'MAIL': '/var/mail/cltbld', 22:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:31 INFO - 'MOZ_NO_REMOTE': '1', 22:27:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:31 INFO - 'NO_EM_RESTART': '1', 22:27:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:31 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:31 INFO - 'SHELL': '/bin/bash', 22:27:31 INFO - 'SHLVL': '1', 22:27:31 INFO - 'TERM': 'linux', 22:27:31 INFO - 'TMOUT': '86400', 22:27:31 INFO - 'USER': 'cltbld', 22:27:31 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', 22:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:31 INFO - '_': '/tools/buildbot/bin/python'} 22:27:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:32 INFO - Downloading/unpacking psutil>=0.7.1 22:27: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 22:27: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 22:27: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 22:27: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 22:27: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 22:27: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 22:27:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:27:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:34 INFO - Installing collected packages: psutil 22:27:34 INFO - Running setup.py install for psutil 22:27:34 INFO - building 'psutil._psutil_linux' extension 22:27:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:27:34 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 22:27:34 INFO - building 'psutil._psutil_posix' extension 22:27:34 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 22:27:34 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 22:27:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:34 INFO - Successfully installed psutil 22:27:34 INFO - Cleaning up... 22:27:34 INFO - Return code: 0 22:27:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:27: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')]} 22:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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')]} 22:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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', '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 0x7ff215cf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e33670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec28c0>, '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 0x1ec37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3c50>, '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': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', '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 22:27: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:27: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 mozsystemmonitor==0.0.0 22:27:34 INFO - Using env: {'DISPLAY': ':0', 22:27:34 INFO - 'HOME': '/home/cltbld', 22:27:34 INFO - 'LANG': 'en_US.UTF-8', 22:27:34 INFO - 'LANGUAGE': 'en_US:en', 22:27:34 INFO - 'LOGNAME': 'cltbld', 22:27:34 INFO - 'MAIL': '/var/mail/cltbld', 22:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:34 INFO - 'MOZ_NO_REMOTE': '1', 22:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:34 INFO - 'NO_EM_RESTART': '1', 22:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:34 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:34 INFO - 'SHELL': '/bin/bash', 22:27:34 INFO - 'SHLVL': '1', 22:27:34 INFO - 'TERM': 'linux', 22:27:34 INFO - 'TMOUT': '86400', 22:27:34 INFO - 'USER': 'cltbld', 22:27:34 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', 22:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:34 INFO - '_': '/tools/buildbot/bin/python'} 22:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:27:34 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 22:27:34 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 22:27:34 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 22:27:34 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 22:27:34 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 22:27:34 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 22:27:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:27:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:27:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:27:36 INFO - Installing collected packages: mozsystemmonitor 22:27:36 INFO - Running setup.py install for mozsystemmonitor 22:27:36 INFO - Successfully installed mozsystemmonitor 22:27:36 INFO - Cleaning up... 22:27:36 INFO - Return code: 0 22:27:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff215cf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e33670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec28c0>, '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 0x1ec37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3c50>, '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': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', '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 22:27:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:27:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:27:36 INFO - Using env: {'DISPLAY': ':0', 22:27:36 INFO - 'HOME': '/home/cltbld', 22:27:36 INFO - 'LANG': 'en_US.UTF-8', 22:27:36 INFO - 'LANGUAGE': 'en_US:en', 22:27:36 INFO - 'LOGNAME': 'cltbld', 22:27:36 INFO - 'MAIL': '/var/mail/cltbld', 22:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:36 INFO - 'MOZ_NO_REMOTE': '1', 22:27:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:36 INFO - 'NO_EM_RESTART': '1', 22:27:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:36 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:36 INFO - 'SHELL': '/bin/bash', 22:27:36 INFO - 'SHLVL': '1', 22:27:36 INFO - 'TERM': 'linux', 22:27:36 INFO - 'TMOUT': '86400', 22:27:36 INFO - 'USER': 'cltbld', 22:27:36 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', 22:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:36 INFO - '_': '/tools/buildbot/bin/python'} 22:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:36 INFO - Downloading/unpacking blobuploader==1.2.4 22:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:38 INFO - Downloading blobuploader-1.2.4.tar.gz 22:27:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:27:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:27:38 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 22:27:38 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 22:27:38 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 22:27:38 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 22:27:38 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 22:27:38 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 22:27:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:27:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:39 INFO - Downloading docopt-0.6.1.tar.gz 22:27:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:27:39 INFO - Installing collected packages: blobuploader, requests, docopt 22:27:39 INFO - Running setup.py install for blobuploader 22:27:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:27:39 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:27:39 INFO - Running setup.py install for requests 22:27:39 INFO - Running setup.py install for docopt 22:27:40 INFO - Successfully installed blobuploader requests docopt 22:27:40 INFO - Cleaning up... 22:27:40 INFO - Return code: 0 22:27:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:40 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 0x7ff215cf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e33670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec28c0>, '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 0x1ec37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3c50>, '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': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', '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 22:27:40 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 22:27:40 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 22:27:40 INFO - Using env: {'DISPLAY': ':0', 22:27:40 INFO - 'HOME': '/home/cltbld', 22:27:40 INFO - 'LANG': 'en_US.UTF-8', 22:27:40 INFO - 'LANGUAGE': 'en_US:en', 22:27:40 INFO - 'LOGNAME': 'cltbld', 22:27:40 INFO - 'MAIL': '/var/mail/cltbld', 22:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:40 INFO - 'MOZ_NO_REMOTE': '1', 22:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:40 INFO - 'NO_EM_RESTART': '1', 22:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:40 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:40 INFO - 'SHELL': '/bin/bash', 22:27:40 INFO - 'SHLVL': '1', 22:27:40 INFO - 'TERM': 'linux', 22:27:40 INFO - 'TMOUT': '86400', 22:27:40 INFO - 'USER': 'cltbld', 22:27:40 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', 22:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:40 INFO - '_': '/tools/buildbot/bin/python'} 22:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:27:40 INFO - Running setup.py (path:/tmp/pip-cR62Jo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:27:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:27:40 INFO - Running setup.py (path:/tmp/pip-XDIXLh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:27:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:27:40 INFO - Running setup.py (path:/tmp/pip-Rs61op-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:27:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:27:40 INFO - Running setup.py (path:/tmp/pip-iojLVc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:27:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:27:40 INFO - Running setup.py (path:/tmp/pip-koGbVP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:27:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:27:40 INFO - Running setup.py (path:/tmp/pip-bcwYax-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:27:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:27:40 INFO - Running setup.py (path:/tmp/pip-33zWPk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:27:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:27:40 INFO - Running setup.py (path:/tmp/pip-rTfOuv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:27:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:27:40 INFO - Running setup.py (path:/tmp/pip-CleXTd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:27:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:27:40 INFO - Running setup.py (path:/tmp/pip-S8I3Hi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:27:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:27:40 INFO - Running setup.py (path:/tmp/pip-r_9zFe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:27:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:27:41 INFO - Running setup.py (path:/tmp/pip-gm96dr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:27:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:27:41 INFO - Running setup.py (path:/tmp/pip-k4Wvb5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:27:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:27:41 INFO - Running setup.py (path:/tmp/pip-GjWZbN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:27:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:27:41 INFO - Running setup.py (path:/tmp/pip-Sfnx6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:27:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:27:41 INFO - Running setup.py (path:/tmp/pip-Lwlzgh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:27:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:27:41 INFO - Running setup.py (path:/tmp/pip-2rGunU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:27:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:27:41 INFO - Running setup.py install for manifestparser 22:27:41 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:27:41 INFO - Running setup.py install for mozcrash 22:27:41 INFO - Running setup.py install for mozdebug 22:27:41 INFO - Running setup.py install for mozdevice 22:27:41 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:27:41 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:27:41 INFO - Running setup.py install for mozfile 22:27:42 INFO - Running setup.py install for mozhttpd 22:27:42 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:27:42 INFO - Running setup.py install for mozinfo 22:27:42 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:27:42 INFO - Running setup.py install for mozInstall 22:27:42 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:27:42 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:27:42 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:27:42 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:27:42 INFO - Running setup.py install for mozleak 22:27:42 INFO - Running setup.py install for mozlog 22:27:42 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:27:42 INFO - Running setup.py install for moznetwork 22:27:42 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:27:42 INFO - Running setup.py install for mozprocess 22:27:42 INFO - Running setup.py install for mozprofile 22:27:42 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:27:42 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:27:42 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:27:42 INFO - Running setup.py install for mozrunner 22:27:42 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:27:42 INFO - Running setup.py install for mozscreenshot 22:27:43 INFO - Running setup.py install for moztest 22:27:43 INFO - Running setup.py install for mozversion 22:27:43 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:27:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:27:43 INFO - Cleaning up... 22:27:43 INFO - Return code: 0 22:27:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:43 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 0x7ff215cf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e33670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec28c0>, '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 0x1ec37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3c50>, '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': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', '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 22:27:43 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 22:27:43 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 22:27:43 INFO - Using env: {'DISPLAY': ':0', 22:27:43 INFO - 'HOME': '/home/cltbld', 22:27:43 INFO - 'LANG': 'en_US.UTF-8', 22:27:43 INFO - 'LANGUAGE': 'en_US:en', 22:27:43 INFO - 'LOGNAME': 'cltbld', 22:27:43 INFO - 'MAIL': '/var/mail/cltbld', 22:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:43 INFO - 'MOZ_NO_REMOTE': '1', 22:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:43 INFO - 'NO_EM_RESTART': '1', 22:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:43 INFO - 'SHELL': '/bin/bash', 22:27:43 INFO - 'SHLVL': '1', 22:27:43 INFO - 'TERM': 'linux', 22:27:43 INFO - 'TMOUT': '86400', 22:27:43 INFO - 'USER': 'cltbld', 22:27:43 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', 22:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:43 INFO - '_': '/tools/buildbot/bin/python'} 22:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:27:43 INFO - Running setup.py (path:/tmp/pip-7szmYZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:27:43 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)) 22:27:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:27:43 INFO - Running setup.py (path:/tmp/pip-3oVZCQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:27:43 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)) 22:27:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:27:43 INFO - Running setup.py (path:/tmp/pip-WM5aYF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:27:43 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)) 22:27:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:27:43 INFO - Running setup.py (path:/tmp/pip-TgNeZn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:27:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:27:43 INFO - Running setup.py (path:/tmp/pip-xsxnU4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:27:43 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)) 22:27:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:27:43 INFO - Running setup.py (path:/tmp/pip-YnZVXN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:27:43 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)) 22:27:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:27:43 INFO - Running setup.py (path:/tmp/pip-dYuKXQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:27:43 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)) 22:27:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:27:43 INFO - Running setup.py (path:/tmp/pip-KZPBoI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:27:44 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)) 22:27:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:27:44 INFO - Running setup.py (path:/tmp/pip-cj4aEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:27:44 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)) 22:27:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:27:44 INFO - Running setup.py (path:/tmp/pip-JhTx_z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:27:44 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)) 22:27:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:27:44 INFO - Running setup.py (path:/tmp/pip-IjWqTV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:27:44 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)) 22:27:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:27:44 INFO - Running setup.py (path:/tmp/pip-qllsvR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:27:44 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)) 22:27:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:27:44 INFO - Running setup.py (path:/tmp/pip-nvVfgN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:27:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:27:44 INFO - Running setup.py (path:/tmp/pip-PHXJFN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:27:44 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)) 22:27:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:27:44 INFO - Running setup.py (path:/tmp/pip-5Rx3Qn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:27:44 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)) 22:27:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:27:44 INFO - Running setup.py (path:/tmp/pip-4qLisq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:27:44 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)) 22:27:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:27:44 INFO - Running setup.py (path:/tmp/pip-tKiIiJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:27:44 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)) 22:27:44 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)) 22:27:44 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)) 22:27:44 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)) 22:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:27:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:27:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:27:44 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 22:27:44 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 22:27:44 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 22:27:44 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 22:27:44 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 22:27:44 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 22:27:46 INFO - Downloading blessings-1.6.tar.gz 22:27:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:27:46 INFO - Installing collected packages: blessings 22:27:46 INFO - Running setup.py install for blessings 22:27:46 INFO - Successfully installed blessings 22:27:46 INFO - Cleaning up... 22:27:46 INFO - Return code: 0 22:27:46 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:27:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:27:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:27:46 INFO - Reading from file tmpfile_stdout 22:27:46 INFO - Current package versions: 22:27:46 INFO - argparse == 1.2.1 22:27:46 INFO - blessings == 1.6 22:27:46 INFO - blobuploader == 1.2.4 22:27:46 INFO - docopt == 0.6.1 22:27:46 INFO - manifestparser == 1.1 22:27:46 INFO - mozInstall == 1.12 22:27:46 INFO - mozcrash == 0.16 22:27:46 INFO - mozdebug == 0.1 22:27:46 INFO - mozdevice == 0.48 22:27:46 INFO - mozfile == 1.2 22:27:46 INFO - mozhttpd == 0.7 22:27:46 INFO - mozinfo == 0.9 22:27:46 INFO - mozleak == 0.1 22:27:46 INFO - mozlog == 3.1 22:27:46 INFO - moznetwork == 0.27 22:27:46 INFO - mozprocess == 0.22 22:27:46 INFO - mozprofile == 0.28 22:27:46 INFO - mozrunner == 6.11 22:27:46 INFO - mozscreenshot == 0.1 22:27:46 INFO - mozsystemmonitor == 0.0 22:27:46 INFO - moztest == 0.7 22:27:46 INFO - mozversion == 1.4 22:27:46 INFO - psutil == 3.1.1 22:27:46 INFO - requests == 1.2.3 22:27:46 INFO - wsgiref == 0.1.2 22:27:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:27:46 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')]} 22:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:46 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')]} 22:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:46 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 0x7ff215cf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e33670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec28c0>, '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 0x1ec37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3c50>, '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': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', '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 22:27:46 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 22:27:46 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 22:27:46 INFO - Using env: {'DISPLAY': ':0', 22:27:46 INFO - 'HOME': '/home/cltbld', 22:27:46 INFO - 'LANG': 'en_US.UTF-8', 22:27:46 INFO - 'LANGUAGE': 'en_US:en', 22:27:46 INFO - 'LOGNAME': 'cltbld', 22:27:46 INFO - 'MAIL': '/var/mail/cltbld', 22:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:46 INFO - 'MOZ_NO_REMOTE': '1', 22:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:46 INFO - 'NO_EM_RESTART': '1', 22:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:46 INFO - 'SHELL': '/bin/bash', 22:27:46 INFO - 'SHLVL': '1', 22:27:46 INFO - 'TERM': 'linux', 22:27:46 INFO - 'TMOUT': '86400', 22:27:46 INFO - 'USER': 'cltbld', 22:27:46 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', 22:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:46 INFO - '_': '/tools/buildbot/bin/python'} 22:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:27:47 INFO - Cleaning up... 22:27:47 INFO - Return code: 0 22:27:47 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff215cf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e33670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec28c0>, '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 0x1ec37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3c50>, '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': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', '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 22:27:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:27:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:27:47 INFO - Using env: {'DISPLAY': ':0', 22:27:47 INFO - 'HOME': '/home/cltbld', 22:27:47 INFO - 'LANG': 'en_US.UTF-8', 22:27:47 INFO - 'LANGUAGE': 'en_US:en', 22:27:47 INFO - 'LOGNAME': 'cltbld', 22:27:47 INFO - 'MAIL': '/var/mail/cltbld', 22:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:47 INFO - 'MOZ_NO_REMOTE': '1', 22:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:47 INFO - 'NO_EM_RESTART': '1', 22:27:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:47 INFO - 'SHELL': '/bin/bash', 22:27:47 INFO - 'SHLVL': '1', 22:27:47 INFO - 'TERM': 'linux', 22:27:47 INFO - 'TMOUT': '86400', 22:27:47 INFO - 'USER': 'cltbld', 22:27:47 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', 22:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:47 INFO - '_': '/tools/buildbot/bin/python'} 22:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:47 INFO - Downloading/unpacking jsonschema 22:27: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 22:27: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 22:27: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 22:27: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 22:27: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 22:27: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 22:27:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:27:49 INFO - Downloading/unpacking functools32 (from jsonschema) 22:27:49 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 22:27:49 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 22:27:49 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 22:27:49 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 22:27:49 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 22:27:49 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 22:27:49 INFO - Downloading functools32-3.2.3-2.tar.gz 22:27:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:27:49 INFO - warning: no files found matching '*.txt' 22:27:49 INFO - no previously-included directories found matching 'build' 22:27:49 INFO - no previously-included directories found matching 'dist' 22:27:49 INFO - no previously-included directories found matching '.git*' 22:27:49 INFO - Installing collected packages: jsonschema, functools32 22:27:49 INFO - Running setup.py install for functools32 22:27:49 INFO - warning: no files found matching '*.txt' 22:27:49 INFO - no previously-included directories found matching 'build' 22:27:49 INFO - no previously-included directories found matching 'dist' 22:27:49 INFO - no previously-included directories found matching '.git*' 22:27:49 INFO - Successfully installed jsonschema functools32 22:27:49 INFO - Cleaning up... 22:27:49 INFO - Return code: 0 22:27:49 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff215cf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e33670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec28c0>, '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 0x1ec37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3c50>, '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': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', '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 22:27:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:27:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:27:49 INFO - Using env: {'DISPLAY': ':0', 22:27:49 INFO - 'HOME': '/home/cltbld', 22:27:49 INFO - 'LANG': 'en_US.UTF-8', 22:27:49 INFO - 'LANGUAGE': 'en_US:en', 22:27:49 INFO - 'LOGNAME': 'cltbld', 22:27:49 INFO - 'MAIL': '/var/mail/cltbld', 22:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:49 INFO - 'MOZ_NO_REMOTE': '1', 22:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:49 INFO - 'NO_EM_RESTART': '1', 22:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:27:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:27:49 INFO - 'SHELL': '/bin/bash', 22:27:49 INFO - 'SHLVL': '1', 22:27:49 INFO - 'TERM': 'linux', 22:27:49 INFO - 'TMOUT': '86400', 22:27:49 INFO - 'USER': 'cltbld', 22:27:49 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', 22:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:49 INFO - '_': '/tools/buildbot/bin/python'} 22:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:49 INFO - Downloading/unpacking flake8 22:27:49 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 22:27:49 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 22:27:49 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 22:27:49 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 22:27:49 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 22:27:49 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 22:27:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:27:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:27:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:27:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:27:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:27:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:27:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:27:52 INFO - no previously-included directories found matching 'docs/_build' 22:27:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:27:52 INFO - Running setup.py install for pep8 22:27:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:27:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:27:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:27:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:27:52 INFO - no previously-included directories found matching 'docs/_build' 22:27:52 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:27:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:27:52 INFO - Cleaning up... 22:27:52 INFO - Return code: 0 22:27:52 INFO - Running post-action listener: _resource_record_post_action 22:27:52 INFO - Running post-action listener: _start_resource_monitoring 22:27:52 INFO - Starting resource monitoring. 22:27:52 INFO - ##### 22:27:52 INFO - ##### Running install step. 22:27:52 INFO - ##### 22:27:52 INFO - Running pre-action listener: _resource_record_pre_action 22:27:52 INFO - Running main action method: install 22:27:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:27:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:27:52 INFO - Reading from file tmpfile_stdout 22:27:52 INFO - Detecting whether we're running mozinstall >=1.0... 22:27:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:27:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:27:52 INFO - Reading from file tmpfile_stdout 22:27:52 INFO - Output received: 22:27:52 INFO - Usage: mozinstall [options] installer 22:27:52 INFO - Options: 22:27:52 INFO - -h, --help show this help message and exit 22:27:52 INFO - -d DEST, --destination=DEST 22:27:52 INFO - Directory to install application into. [default: 22:27:52 INFO - "/builds/slave/test-pgo"] 22:27:52 INFO - --app=APP Application being installed. [default: firefox] 22:27:52 INFO - mkdir: /builds/slave/test-pgo/build/application 22:27:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:27:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:28:09 INFO - Reading from file tmpfile_stdout 22:28:09 INFO - Output received: 22:28:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:28:09 INFO - Running post-action listener: _resource_record_post_action 22:28:09 INFO - ##### 22:28:09 INFO - ##### Running run-tests step. 22:28:09 INFO - ##### 22:28:09 INFO - Running pre-action listener: _resource_record_pre_action 22:28:09 INFO - Running main action method: run_tests 22:28:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:28:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:28:09 INFO - Python 2.7.3 22:28:09 INFO - Return code: 0 22:28:09 INFO - grabbing minidump binary from tooltool 22:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:09 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 0x1ec28c0>, '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 0x1ec37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:28:09 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 22:28:09 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 22:28:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:28:09 INFO - Return code: 0 22:28:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:28:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:28:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:28:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:28:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:28:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:28:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:28:10 INFO - Return code: 0 22:28:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:28:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:28:10 INFO - Using env: {'DISPLAY': ':0', 22:28:10 INFO - 'HOME': '/home/cltbld', 22:28:10 INFO - 'LANG': 'en_US.UTF-8', 22:28:10 INFO - 'LANGUAGE': 'en_US:en', 22:28:10 INFO - 'LOGNAME': 'cltbld', 22:28:10 INFO - 'MAIL': '/var/mail/cltbld', 22:28:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:28:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:10 INFO - 'MOZ_NO_REMOTE': '1', 22:28:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:10 INFO - 'NO_EM_RESTART': '1', 22:28:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:28:10 INFO - 'PWD': '/builds/slave/test-pgo', 22:28:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:28:10 INFO - 'SHELL': '/bin/bash', 22:28:10 INFO - 'SHLVL': '1', 22:28:10 INFO - 'TERM': 'linux', 22:28:10 INFO - 'TMOUT': '86400', 22:28:10 INFO - 'USER': 'cltbld', 22:28:10 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181', 22:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:10 INFO - '_': '/tools/buildbot/bin/python'} 22:28:10 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:28:10 INFO - mozversion application_buildid: 20160213193337 22:28:10 INFO - mozversion application_changeset: e355cacefc881ba360d412853b57e8e060e966f4 22:28:10 INFO - mozversion application_display_name: Nightly 22:28:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:28:10 INFO - mozversion application_name: Firefox 22:28:10 INFO - mozversion application_remotingname: firefox 22:28:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:28:10 INFO - mozversion application_vendor: Mozilla 22:28:10 INFO - mozversion application_version: 47.0a1 22:28:10 INFO - mozversion platform_buildid: 20160213193337 22:28:10 INFO - mozversion platform_changeset: e355cacefc881ba360d412853b57e8e060e966f4 22:28:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:28:10 INFO - mozversion platform_version: 47.0a1 22:28:10 INFO - using testdate: 1455431290 22:28:10 INFO - actual date: 1455431290 22:28:10 INFO - starting webserver on 'localhost:42294' 22:28:10 INFO - SUITE-START | Running 2 tests 22:28:10 INFO - TEST-START | dromaeo_css 22:28:10 INFO - operating with platform_type : linux_ 22:28:10 INFO - Initialising browser for dromaeo_css test... 22:28:10 INFO - TEST-INFO | started process 23077 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUgWpAE/profile http://localhost:42294/getInfo.html) 22:28:14 INFO - PROCESS | 23077 | __metrics Screen width/height:1600/1200 22:28:14 INFO - PROCESS | 23077 | colorDepth:24 22:28:14 INFO - PROCESS | 23077 | Browser inner width/height: 1024/697 22:28:14 INFO - PROCESS | 23077 | __metrics 22:28:15 INFO - PROCESS | 23077 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:28:16 INFO - TEST-INFO | 23077: exit 0 22:28:16 INFO - Browser initialized. 22:28:16 INFO - Running cycle 1/1 for dromaeo_css test... 22:28:16 INFO - TEST-INFO | started process 23172 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUgWpAE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:28:28 INFO - PROCESS | 23172 | RSS: Main: 150044672 22:28:28 INFO - PROCESS | 23172 | 22:29:19 INFO - PROCESS | 23172 | 1455431359418 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] 22:31:27 INFO - PROCESS | 23172 | Cycle 1(1): loaded http://localhost:42294/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42294/tests/dromaeo/cssquery-ext.html) 22:31:28 INFO - PROCESS | 23172 | RSS: Main: 260624384 22:31:28 INFO - PROCESS | 23172 | 22:34:30 INFO - PROCESS | 23172 | Cycle 1(1): loaded http://localhost:42294/tests/dromaeo/cssquery-ext.html (next: http://localhost:42294/tests/dromaeo/cssquery-jquery.html) 22:34:31 INFO - PROCESS | 23172 | RSS: Main: 236429312 22:34:31 INFO - PROCESS | 23172 | 22:37:33 INFO - PROCESS | 23172 | Cycle 1(1): loaded http://localhost:42294/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42294/tests/dromaeo/cssquery-mootools.html) 22:37:34 INFO - PROCESS | 23172 | RSS: Main: 245624832 22:37:34 INFO - PROCESS | 23172 | 22:40:36 INFO - PROCESS | 23172 | Cycle 1(1): loaded http://localhost:42294/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42294/tests/dromaeo/cssquery-prototype.html) 22:40:36 INFO - PROCESS | 23172 | RSS: Main: 221134848 22:40:36 INFO - PROCESS | 23172 | 22:43:39 INFO - PROCESS | 23172 | Cycle 1(1): loaded http://localhost:42294/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42294/tests/dromaeo/cssquery-yui.html) 22:43:39 INFO - PROCESS | 23172 | RSS: Main: 222371840 22:43:39 INFO - PROCESS | 23172 | 22:46:42 INFO - PROCESS | 23172 | Cycle 1(1): loaded http://localhost:42294/tests/dromaeo/cssquery-yui.html (next: http://localhost:42294/tests/dromaeo/cssquery-dojo.html) 22:46:42 INFO - PROCESS | 23172 | RSS: Main: 290246656 22:46:42 INFO - PROCESS | 23172 | 22:46:42 INFO - PROCESS | 23172 | __start_tp_report 22:46:42 INFO - PROCESS | 23172 | _x_x_mozilla_page_load 22:46:42 INFO - PROCESS | 23172 | _x_x_mozilla_page_load_details 22:46:42 INFO - PROCESS | 23172 | |i|pagename|runs| 22:46:42 INFO - PROCESS | 23172 | |0;dojo.html;3134.1537784798106;3192.8882489112884;3237.3039796443773;3238.2390138317505;3261.8532166052523;5053.36832895888;5130.615203859711;5147.665401748884;5220.791168353266;5250.264962905197;5147.81982630608;5157.4842515748405;5177.378714554259;5187.403448603412;5197.168453047513;4654.813807447698;4690.179218636734;4772.832950846721;4774.092922344744;4792.568668819806;4623.976880115595;4700.905981880361;4738.265568836819;4738.952610473885;4857.73282469464;4644.210484217691;4650.046740418223;4658.673892827504;4703.553162449562;4711.057788442291;4669.976650116728;4677.345171675968;4688.29675548667;4688.953110468886;4708.4820669726305;4636.188666983298;4672.415948006499;4704.247320428749;4740.620750339965;4777.116233496814;4969.577585905203;4974.8756281093265;4992.575631071363;4998.8250411235795;5042.067217564762;5313.495217954288;5469.644473109275;5476.835694929158;5489.780408783644;5492.038893193675;5489.204065410533;5522.199281104257;5525.723713814293;5530.446955304477;5570.053090974504;5176.8964620707375;5194.506521880416;5195.064888320101;5195.376554813409;5199.870003249911;5355.785768569213;5468.972655136698;5619.494245517923;5634.295713035871;5647.322321321468;5366.731663416814;5392.5416339611575;5406.459354064641;5407.297051383295;5455.645383050089;5458.4814442627885;5502.477264659851;5503.229547863302;5503.504684578407;5504.2018907258225;5377.7580008899695;5447.918281225785;5487.204355368449;5493.121100623881;5515.393306736256;5407.188921661782;5420.4850539198715;5424.7016414096815;5427.240186373911;5459.317585301837;4244.0663054128045;4256.489221293465;4265.104328091135;4297.548757380492;4299.204647140226;3763.8118094095184;3825.445310429972;3830.7318487705593;3872.6901847852105;3897.922041559153;4997.875053123701;5028.5977121830165;5034.974825125851;5037.042961837239;5037.874053148701;5224.477552244821;5446.074167391553;5446.91829622556;5465.508104270635;5467.261919640798;4980.153373926369;5016.372953380827;5020.899582008339;5032.547070763576;5055.69665820052;4719.622430205644;4731.157199392954;4742.881427964259;4747.121782470254;4791.688540244873;5589.133684278943;5670.886582268414;5728.198052272685;5746.051901436216;5752.223449834302;5491.258680078138;5524.66851988882;5525.392206857162;5533;5564.77740890376;5607.355154157324;5615;5615.7192140392;5622.156676498558;5626.212330273846;5351.438098999549;5381.461853814587;5384.488473595002;5386.084365657926;5392.218128371443;5308.336457942757;5540.307461567304;5560.443955604407;5589.385167631476;5635.859103522281;5285.418603953639;5301.734913254399;5307.150855863043;5308.071087559739;5315.681059136464;5219.739013049257;5252.737363131904;5293.708846013352;5306.575473961997;5370.516653501048;5283.947160528345;5299.231611416246;5310.734463276744;5310.920336194883;5338.54622357104;5396.325459317585;5396.487333703292;5402.648827826179;5448.618596698193;5448.972755136199;5191.8182863599595;5278.920816187837;5286.735663216747;5344.839654810362;5408.45915408456 22:46:42 INFO - PROCESS | 23172 | |1;ext.html;518.6188151708496;524.2267655208567;531.5827075745541;540.3839622829972;544.0397698062919;27151.53332833469;27948;27950.16149515518;27969.860150699267;34334.8283258584;37663.811680941624;37857.43213851788;37987.240255194876;38154.04614884629;38217.80891095548;8423.199796019368;8601.182887625666;8607.526586037766;8616.612252448624;8620.913790862074;8421.621027053767;8558.871616925751;8561.700340488083;8569.785755356104;8575.185357391038;8524.659013639446;8826.86759698605;8827.911720882805;8828.337874659393;8836.381453298272;8676.60955257015;8731.519766412845;8757.036725960172;8762.167594078552;8776.254018408443;8668.52323122228;8795.780105497413;8807.515586642796;8807.559622018873;8809.075047120088;35589.11027224314;38340.42489362634;38392.616073839185;38596.421053684215;38636.80681596602;3028.424599326121;3279.9344013119603;3404.3701915145775;3587.7309201809967;3753.930129912989;28401.147965561067;29116.27209319784;29208.269793255127;29234.56148157779;29269.414611707645;3806.809659517013;3851.5570709368503;3963.8810835674976;4012.1775036117524;4038.45480860086;193678;194397;194493;194545;194674;53010;53082;53103;53155.468445315826;53224.20163697548;55765;55776.72111639416;55781.16328255079;55827.53379729612;55856.441435585126;13504.324783760772;13571.728565428637;13605.591832245049;13676.384562694702;13684.589462316146;10285.691429256985;10298.948505257425;10329.070383665507;10369.688909332732;10431.37411755297;17747.201375937857;18093.7285940711;18381.448556543324;18418.907905460655;18462;6868.896966545506;6971.736339063974;7055.506114572034;7108.253633368526;7165.176004759415;935.1723724503863;943.1511639524346;946.8153710026479;972.9173020293213;989.7674046599044;26931;27479.59683139062;27852.303692407448;27874.16377508678;28151.155465336073;916.4089162490156;978.5058545434653;991.667791289926;1011.0849681038671;1026.7227848480868;12335.814962775565;12351.764823517757;12356.691082723004;12587.433565489575;12641.683957901127;297965;300635;301421;301606;302079;41084.79457602693;44027.11945761131;44675.32987005197;44731.329030064575;44811;1191.7080315322628;1300.174389262825;1302.798066299725;1304.6542666193466;1308.2281453942219;24347.26958191257;24768.50462990766;25569;25628.231153065437;26565.203043908714;40469;41121;41227.1754564913;41251.58748412477;41307.38038929358;247203;249013;249071;249355;249425.50574494022;28227.858860706387;29483.85258073696;29919.70080299169;30485.695143048284;30834.537481938238;37304.25391492209;37513.43729844109;37908.43137352997;37991.62008379881;38458.6154138455;32326.676733232365;32466.513002304513;32538.349233014735;32620.673793262715;33212.50181247332;33030;33144;33365.83317083399;33374;33671;33158.17104572405;33381;33454.33091338208;33551.328973419906;33645.49531756977;35567.28865422729;36512;37139;38182.51621684948;41818.37272440855;27578.586321204795;28470;30427.39145217039;30635.2341191472;31074.68925310718 22:46:42 INFO - PROCESS | 23172 | |2;jquery.html;327.27018748191546;341.92990436960423;348.1505127488927;350.9754317197796;352.5663433976208;13349.199048057098;13713.657158571015;15879.523614291575;16276.267567959441;16967.915160424196;14967.850321496782;15306.846931530681;15421.383144674228;16005.119718415483;16052.357905683759;5118.6416950813555;5144.614153938451;5282.23407605897;5303.946960530384;5309.548688361494;3713.1830997180577;5097.286379906797;5261.368635763713;5297.867553311159;5328.307320048408;5283.947160528403;5308.628396012281;5311.468853114697;5321.946780532184;5624.746886390122;5939.07944268639;5952.7023648817385;5956.344802071769;5958;5963.850903727398;5178.938317644874;5224.268602395668;5228.660137091077;5233.450487698775;5271.051210782058;12046.216995895238;12401.937990310082;14676.926615366854;18849.434516964513;18863.62272754537;2238.2613737466595;2262.875541845198;2436.8781560921884;2489.1163636909;2601.596752503365;8841.778955526099;8940;9141.725748227564;9250.676226332112;9330.066993300616;1847.473470061026;1913.8277555020115;1924.2399252295404;1934.1489744512369;1944.5333120051228;56357;57853.71073144607;57964.71017644927;58470;59099.704501477216;9713.70858874235;9785.168260697777;9805.411675299505;9819.085278370649;9895.356801807859;12637.873621263854;12707.555235566895;12725.809112863315;12739.55411560591;12751.171173873669;6877.965610171917;6916.481263905227;6925.134358205224;7015.403690686348;7084.220735719066;6509.44669703071;6520.608763474207;6569.80290591283;6574.211094668671;6589.242237142694;3815.828287727059;4087.6321131098343;4194.119234960693;4236.364545318165;4244.702870799076;1657.3426573426573;1716.8969861808332;1721.7847769028872;1730.7057800174;1747.1264367816093;835.399428463325;865.4158443050916;932.1470854168496;941.0119374656583;985.5909797433984;13481.528146514825;15287.159206243763;15553.68892622164;15743.212839357986;15866.9206653966;861.4701958295603;876.369014309696;905.9909400905907;926.745145085107;935.9017303183203;8737.868931966026;8746.781330466789;8758.518281494578;8828.028916819145;8879.733607991771;560820.9179082059;563766;565307;589035;590262;72011;73244;75180.27980021392;75475.62262188653;75559.24440755633;1162.7209469727204;1167.550493060178;1174.8120300751839;1199.874013228616;1200.7658506591306;15093.622659433162;15451;15507.302171402089;15558.611034724223;15814.9209253953;33489.83255083709;33557;33584;34383.31233375368;34939.65060349466;46489.302660460795;46577.53422465732;47387.28919066286;47529.28706069342;47728.28407573959;7052.9647351762915;7074.080369551925;7169.601927624271;7286.724823155821;7311.341979221896;8635.438696484709;11009.724756881142;11077.889221107685;11429.657110286706;11943.522259109539;9711.27165462579;9726.46504442234;10029.197664186993;10186.592536298465;10228.437435940798;7072.611006394698;7928.167542408195;9449.244060475283;10028.498575071071;10186.490675466346;9455.19630831387;9577.569009394454;9790.118889299998;10285;10306.227032972407;7239.44393400706;7317;7435.974090682611;7457.792904516904;7575.787873940143;9035.864462033207;10065.245106616887;10142.29003969715;10321.277510574488;10375.636852710119 22:46:42 INFO - PROCESS | 23172 | |3;mootools.html;1223.4005337384674;1377.4008306386722;1392.4291040673322;1492.3582859370474;1680.4202550120212;7019.859602807941;7677.5393476391455;7856.842863142748;7872.527648341096;7879.842403151948;7410.814729631748;7416.740414085508;7482.176960534337;7493.250674932504;7509.361704255131;1972.9506762330914;2207.86752794832;2252.200468833565;2253.076238742116;2265.150568536799;2282.4522114692522;2310.295359915225;2315.409570559505;2317.432229103872;2322.3613506285737;2269.920552780653;2299.057386471547;2306.5963456395066;2310.1336998625516;2321.4080409495555;2262.570111678784;2279.2022792022826;2288.8512246703995;2314.5833749925005;2317.513322202323;2269.0356598445596;2282.7146606674164;2282.8402011859175;2285.1202287119413;2287.2452090809993;7708.614569271514;7774.144844067148;7781.377489800859;7786.416018798613;7788.026496687914;4577;4689.577937985564;4691.554302341272;4715.834945776915;4720.834770783006;3035.924101897448;3037.2255074955965;3058.801177923428;3085.012795905311;3168.603924509436;895.789489469974;907.3557773980482;912.2929729459655;919.9678011269574;971.3006635222629;10715.571377144905;10810.081143102845;10836.783264334748;10839.349639021606;10859.78280434387;4279.850205242801;4396.208682437192;4428.33574963758;4431.335299705005;4453.576910193527;9311.72064838056;9317.440953542673;9333.20667743236;9546.093121153479;9549.283803714749;4775.140474714584;4791.544803243686;4801.879953001133;4803.615710743132;4803.615710743132;4322.6325762309925;4347.65218782503;4359.062801497693;4359.891002724958;4362.629176519968;3460.480927860841;3575.8748443804343;3697.852085916587;3708.6662200402093;3738.8691395801015;1180.1031216275692;1184.1296646964474;1196.389841181004;1200.105921088777;1200.4837919694614;1066.1364294920984;1082.723905404117;1093.573506332531;1107.9390633515072;1109.8057839877988;7075.292470752884;7146.035285236427;7174.354308112295;7191.496595238283;7199.964000180071;1075.0808059109506;1075.9623413180502;1075.9731006724737;1077.5474300793685;1091.2633972068822;5456.045192091368;5527.2538207341495;5531.917021244684;5542.251796007568;5548.445155484419;9380.155785979157;9417.858732119024;9586.376885502421;9605.18355939739;9752.366096203725;9525.047495250557;9578.856317155249;9612.231021518262;9644.807103857884;9687.079727425884;7189.784306470814;7388;7391.33477986973;7410.703571857065;7468.663910124057;7017.754378596929;7144.428445724226;7185.748498802517;7194.604296763729;7211.495195336276;8336.268522698445;8543.700970466003;8671.04618491978;8726.956365218133;8746.868796967923;8717.389782715149;8866.822663546563;8879.422837515542;8905.154010369004;8944.86582701273;6154.692265386802;6353.904691429725;6495.220573531206;6505.902411463737;6516.609003459618;7424.554526728413;7536.057992750906;7541.509801862861;7552.546847189186;7555.73554925575;6900.585964842126;7071.929280707127;7102.4673149512955;7206.783796486114;7238.059052323164;6676.132102826601;6766.458683305225;6949;7108.111486064242;7140.071790667388;6834.248232694499;6879.415249703831;6909.7581584646305;6945.548539344926;7041.014258003986;6515.641639709672;6532.41208291256;6566.474682025522;6575.868482630416;6578.243501997332;6507.446867016357;6566.080748695282;6572.34276572339;6594.90107648376;6598 22:46:42 INFO - PROCESS | 23172 | |4;prototype.html;322.16398446032565;328.5597299618511;329.55180953902703;333.7546903026275;333.82307377090143;5701.77192912283;5763.279590051238;5773.249477567921;5795.913061304079;5820.417958204177;5544.750486228119;5725.742341594628;5754.913676294859;5757.481826635602;5758;4496.348029535716;4496.572825581581;4499.167653984024;4500.437445319335;4509.0530988492455;4315.503717072545;4369.868903932887;4472.485664148616;4489.1695036418205;4507.053518761048;4417.668674849399;4476.149531588988;4479.126570318789;4485.730856148642;4486.304622783474;4448.577385148422;4459.464864216298;4483.036147228361;4486.371907932892;4506.639468842484;3936.0356712605308;3942.743721658083;3944.033711740642;3950;3961;5407.378151512547;5537.252470916415;5556.16657501374;5597.328320601554;5612.270404847343;5145.794168233266;5156.639035267533;5159.303494028333;5160.354955630546;5162.690238585659;5832.270966129234;6159.907601385983;6175.691215439255;6180.2892667343385;6189.721462534197;4121.155163191538;4183.769892655902;4220.261454245495;4225.873223803291;4229.344451610005;6306.463950564207;6399.77600783975;6420.390062944013;6420.486361091102;6420.711068001951;4347.0871117065135;4349;4350.434443522322;4351.673624478177;4353.238183317907;4201.306784380543;4315.28797748368;4397.428334316583;4400.009997750481;4406.735595864258;5070.467600901926;5072.061668591323;5074.061298659686;5075.0357432087785;5076.466970968069;6182.567220294626;6190.845228869314;6203.2556093268195;6205.689715514297;6206.441420272197;1527.3203424476224;1551.8758499320027;1554.8367421420814;1555.3234343060578;1556.1985577427633;1029.5109822834243;1033.1631378583372;1035.3632516002604;1035.782485678016;1057.5558265528496;5720.513756330675;5720.628159169641;5721.170430287585;5724.026915424388;5819.592628515963;6320.4311611955145;6323.52573556985;6329.050642403677;6333.68331583419;6338.30278669346;5801.593888427769;5807.622504537276;5810.6513609183585;5821.388754180834;5826.82519524415;3304.686054824788;3410.1645096951406;3418.3163367326633;3423.5891692997;3428.6228514863346;6634.203895532471;6640.468762498988;6641.203055633258;6645.269020407752;6650.434713049445;6485.4163125318;6488.513361497907;6504.1219435375615;6547.214334279917;6568.573042752206;6440.194975628046;6607.768728094494;6618.338166183343;6620.5365624406795;6625.734970601218;6151.446369826737;6186.257649082139;6245.687715614292;6261.74953001893;6287;6320.336364681826;6321.49428045746;6339.207599050119;6341.55609107358;6342.524310676626;6547.312532184052;6559.7376104957175;6597.406233439014;6607.537472376887;6757.222919364336;4250.171216612731;4342.47890253159;4343.804528796149;4350.869473915787;4360.563943605614;6402.103705481143;6408.166938297992;6410.871782564416;6413.4869210463985;6435.613863168225;6216.316205217513;6219.906701399392;6235.501159907106;6238.157848690369;6238.781642642486;6084.90872636902;6222.066689996355;6223.377662233922;6228.314885362697;6230.034344676583;6060.818175454743;6117.327094019565;6117.938820611737;6124.755009799736;6133.172021777003;6260.436560709558;6260.467860231931;6260.874782504416;6263.373662633882;6266.498680105489;5910;6116.35778243278;6124.938750612615;6134.263888333428;6136.754529818757 22:46:42 INFO - PROCESS | 23172 | |5;yui.html;653.4641593893007;674.7301079568172;709.978700638981;754.2306847016047;767.919368466311;12778.616641500746;12945.417456214469;12961.416736246869;12982.350882455874;12983.285919274447;12565.120441569094;12570.43433045513;12670.619881403572;12675.492980280778;12684.30236337001;611.5291225756165;615.5660259517052;725.3182008911632;725.622676208374;733.3363306207864;737.8155461134717;737.8450525389675;738.5236522443021;739.8520295940806;741.0329519976428;772.1467778105197;776.0687175389555;776.9883451748228;778.98831517527;778.9989863026012;649.4966401039185;757.8635845547826;763.2138896936165;764.468694257494;765.5598031132066;562.5977426140329;566.2157911292848;567.3702190568466;567.4552429667524;567.6480582039121;12187.146899717023;12191.45138468771;12253.203541769757;12257;12276.877231227663;12338.074644401617;12448.06639502032;12703.555375561904;12810.16733912302;12854.935725321408;10081.798364032751;10090;10160.695179144637;10272.435016074112;10290.331128476626;3584.068142282999;3619.113317237294;3630.6732394084397;3716.5725941516803;3736.028632555528;45196.77401613004;46508.302375464395;46768.76615616934;46855.29717054213;46905.5309446908;10038;10096.646617368357;10241.632006337859;10295.07344339013;10319.793604128026;18019.2792288307;18097.18562664683;18175.45473635793;18183.545411364557;18221.7266740999;7365.1530074042175;7454.40364770817;7523.0972283326355;7547.73582924595;7582.090149182133;4118.279301122292;4228.069824638575;4244.893877653021;4256.723312984646;4349.565043495625;3130.6399764026974;3142.355817057498;3181.2524056846623;3185.3788511240086;3185.4106990206888;566.6939852479697;568.7838621323954;580.2485780913727;582.5223316880117;585.5432762445299;633.0851918977125;640.3500447046251;664.372168300951;665.4044630056072;677.218835024727;8642.913570864337;8681.696140635047;8694.652213911373;8813.25087367581;8865;516.3416643779211;533.1283351719889;546.8605505596048;575.6200907401179;625.2840497630278;3786.848526058982;3822.26660009985;3921.4124254404032;3966.841326346914;4240.915181696349;49257;49746.75126624344;50385.74807125941;52531.73734131381;52983.470165298626;46629.76685116553;47285.29072063922;47595;47609.285860712116;48029.519704803206;42432.78783606062;42777.35833962493;42857.35713964293;42889.785551072666;43265.783671081444;8516.70191543293;8809.339299552432;8829.93231013344;8902.59938302791;9047.909520904706;31909.840450797597;32574.185645359055;32908.83545582257;33622.495662564594;33651;38846.805765972116;40896;41109.383359249034;41306.380404293355;41718.16563668649;9531.904680953101;10109.898901010896;10554;10562.577496900038;10859.674209773719;11224.438778061227;11263.436828158396;12296.446659900146;12394.194377365442;12594.118411711459;11484.368359740294;11525.88474115248;11533.884661153617;11788.056955443715;12212.694682633006;11511.19421640477;11618.94190529042;11700.88299116998;12008.939955300517;12102.75794484123;10976.560937562408;11091.556337746722;11104.450994476378;11263.436828158723;11466.31202127875;8879.33404994615;8952;8965.282777377664;9147.954260228656;9152.679656212;7940.523568585903;8562.800849104524;9622.51887405641;9626;9632.518374081128 22:46:42 INFO - PROCESS | 23172 | __end_tp_report 22:46:42 INFO - PROCESS | 23172 | __start_cc_report 22:46:42 INFO - PROCESS | 23172 | _x_x_mozilla_cycle_collect,817 22:46:42 INFO - PROCESS | 23172 | __end_cc_report 22:46:42 INFO - PROCESS | 23172 | __startTimestamp1455432402629__endTimestamp 22:46:42 INFO - PROCESS | 23172 | 22:46:42 INFO - PROCESS | 23172 | ------- Summary: start ------- 22:46:42 INFO - PROCESS | 23172 | Number of tests: 6 22:46:42 INFO - PROCESS | 23172 | 22:46:42 INFO - PROCESS | 23172 | [#0] dojo.html Cycles:165 Average:5099.06 Median:5286.74 stddev:531.85 (10.1%) stddev-sans-first:510.65 22:46:42 INFO - PROCESS | 23172 | Values: 3134.2 3192.9 3237.3 3238.2 3261.9 5053.4 5130.6 5147.7 5220.8 5250.3 5147.8 5157.5 5177.4 5187.4 5197.2 4654.8 4690.2 4772.8 4774.1 4792.6 4624.0 4700.9 4738.3 4739.0 4857.7 4644.2 4650.0 4658.7 4703.6 4711.1 4670.0 4677.3 4688.3 4689.0 4708.5 4636.2 4672.4 4704.2 4740.6 4777.1 4969.6 4974.9 4992.6 4998.8 5042.1 5313.5 5469.6 5476.8 5489.8 5492.0 5489.2 5522.2 5525.7 5530.4 5570.1 5176.9 5194.5 5195.1 5195.4 5199.9 5355.8 5469.0 5619.5 5634.3 5647.3 5366.7 5392.5 5406.5 5407.3 5455.6 5458.5 5502.5 5503.2 5503.5 5504.2 5377.8 5447.9 5487.2 5493.1 5515.4 5407.2 5420.5 5424.7 5427.2 5459.3 4244.1 4256.5 4265.1 4297.5 4299.2 3763.8 3825.4 3830.7 3872.7 3897.9 4997.9 5028.6 5035.0 5037.0 5037.9 5224.5 5446.1 5446.9 5465.5 5467.3 4980.2 5016.4 5020.9 5032.5 5055.7 4719.6 4731.2 4742.9 4747.1 4791.7 5589.1 5670.9 5728.2 5746.1 5752.2 5491.3 5524.7 5525.4 5533.0 5564.8 5607.4 5615.0 5615.7 5622.2 5626.2 5351.4 5381.5 5384.5 5386.1 5392.2 5308.3 5540.3 5560.4 5589.4 5635.9 5285.4 5301.7 5307.2 5308.1 5315.7 5219.7 5252.7 5293.7 5306.6 5370.5 5283.9 5299.2 5310.7 5310.9 5338.5 5396.3 5396.5 5402.6 5448.6 5449.0 5191.8 5278.9 5286.7 5344.8 5408.5 22:46:42 INFO - PROCESS | 23172 | 22:46:42 INFO - PROCESS | 23172 | [#1] ext.html Cycles:180 Average:40985.05 Median:35578.20 stddev:65663.99 (184.6%) stddev-sans-first:65777.90 22:46:42 INFO - PROCESS | 23172 | Values: 518.6 524.2 531.6 540.4 544.0 27151.5 27948.0 27950.2 27969.9 34334.8 37663.8 37857.4 37987.2 38154.0 38217.8 8423.2 8601.2 8607.5 8616.6 8620.9 8421.6 8558.9 8561.7 8569.8 8575.2 8524.7 8826.9 8827.9 8828.3 8836.4 8676.6 8731.5 8757.0 8762.2 8776.3 8668.5 8795.8 8807.5 8807.6 8809.1 35589.1 38340.4 38392.6 38596.4 38636.8 3028.4 3279.9 3404.4 3587.7 3753.9 28401.1 29116.3 29208.3 29234.6 29269.4 3806.8 3851.6 3963.9 4012.2 4038.5 193678.0 194397.0 194493.0 194545.0 194674.0 53010.0 53082.0 53103.0 53155.5 53224.2 55765.0 55776.7 55781.2 55827.5 55856.4 13504.3 13571.7 13605.6 13676.4 13684.6 10285.7 10298.9 10329.1 10369.7 10431.4 17747.2 18093.7 18381.4 18418.9 18462.0 6868.9 6971.7 7055.5 7108.3 7165.2 935.2 943.2 946.8 972.9 989.8 26931.0 27479.6 27852.3 27874.2 28151.2 916.4 978.5 991.7 1011.1 1026.7 12335.8 12351.8 12356.7 12587.4 12641.7 297965.0 300635.0 301421.0 301606.0 302079.0 41084.8 44027.1 44675.3 44731.3 44811.0 1191.7 1300.2 1302.8 1304.7 1308.2 24347.3 24768.5 25569.0 25628.2 26565.2 40469.0 41121.0 41227.2 41251.6 41307.4 247203.0 249013.0 249071.0 249355.0 249425.5 28227.9 29483.9 29919.7 30485.7 30834.5 37304.3 37513.4 37908.4 37991.6 38458.6 32326.7 32466.5 32538.3 32620.7 33212.5 33030.0 33144.0 33365.8 33374.0 33671.0 33158.2 33381.0 33454.3 33551.3 33645.5 35567.3 36512.0 37139.0 38182.5 41818.4 27578.6 28470.0 30427.4 30635.2 31074.7 22:46:42 INFO - PROCESS | 23172 | 22:46:42 INFO - PROCESS | 23172 | [#2] jquery.html Cycles:180 Average:28398.87 Median:5226.46 stddev:93827.04 (1795.2%) stddev-sans-first:94066.57 22:46:42 INFO - PROCESS | 23172 | Values: 327.3 341.9 348.2 351.0 352.6 13349.2 13713.7 15879.5 16276.3 16967.9 14967.9 15306.8 15421.4 16005.1 16052.4 5118.6 5144.6 5282.2 5303.9 5309.5 3713.2 5097.3 5261.4 5297.9 5328.3 5283.9 5308.6 5311.5 5321.9 5624.7 5939.1 5952.7 5956.3 5958.0 5963.9 5178.9 5224.3 5228.7 5233.5 5271.1 12046.2 12401.9 14676.9 18849.4 18863.6 2238.3 2262.9 2436.9 2489.1 2601.6 8841.8 8940.0 9141.7 9250.7 9330.1 1847.5 1913.8 1924.2 1934.1 1944.5 56357.0 57853.7 57964.7 58470.0 59099.7 9713.7 9785.2 9805.4 9819.1 9895.4 12637.9 12707.6 12725.8 12739.6 12751.2 6878.0 6916.5 6925.1 7015.4 7084.2 6509.4 6520.6 6569.8 6574.2 6589.2 3815.8 4087.6 4194.1 4236.4 4244.7 1657.3 1716.9 1721.8 1730.7 1747.1 835.4 865.4 932.1 941.0 985.6 13481.5 15287.2 15553.7 15743.2 15866.9 861.5 876.4 906.0 926.7 935.9 8737.9 8746.8 8758.5 8828.0 8879.7 560820.9 563766.0 565307.0 589035.0 590262.0 72011.0 73244.0 75180.3 75475.6 75559.2 1162.7 1167.6 1174.8 1199.9 1200.8 15093.6 15451.0 15507.3 15558.6 15814.9 33489.8 33557.0 33584.0 34383.3 34939.7 46489.3 46577.5 47387.3 47529.3 47728.3 7053.0 7074.1 7169.6 7286.7 7311.3 8635.4 11009.7 11077.9 11429.7 11943.5 9711.3 9726.5 10029.2 10186.6 10228.4 7072.6 7928.2 9449.2 10028.5 10186.5 9455.2 9577.6 9790.1 10285.0 10306.2 7239.4 7317.0 7436.0 7457.8 7575.8 9035.9 10065.2 10142.3 10321.3 10375.6 22:46:42 INFO - PROCESS | 23172 | 22:46:42 INFO - PROCESS | 23172 | [#3] mootools.html Cycles:180 Average:5471.44 Median:6516.13 stddev:2868.47 (44.0%) stddev-sans-first:2858.74 22:46:42 INFO - PROCESS | 23172 | Values: 1223.4 1377.4 1392.4 1492.4 1680.4 7019.9 7677.5 7856.8 7872.5 7879.8 7410.8 7416.7 7482.2 7493.3 7509.4 1973.0 2207.9 2252.2 2253.1 2265.2 2282.5 2310.3 2315.4 2317.4 2322.4 2269.9 2299.1 2306.6 2310.1 2321.4 2262.6 2279.2 2288.9 2314.6 2317.5 2269.0 2282.7 2282.8 2285.1 2287.2 7708.6 7774.1 7781.4 7786.4 7788.0 4577.0 4689.6 4691.6 4715.8 4720.8 3035.9 3037.2 3058.8 3085.0 3168.6 895.8 907.4 912.3 920.0 971.3 10715.6 10810.1 10836.8 10839.3 10859.8 4279.9 4396.2 4428.3 4431.3 4453.6 9311.7 9317.4 9333.2 9546.1 9549.3 4775.1 4791.5 4801.9 4803.6 4803.6 4322.6 4347.7 4359.1 4359.9 4362.6 3460.5 3575.9 3697.9 3708.7 3738.9 1180.1 1184.1 1196.4 1200.1 1200.5 1066.1 1082.7 1093.6 1107.9 1109.8 7075.3 7146.0 7174.4 7191.5 7200.0 1075.1 1076.0 1076.0 1077.5 1091.3 5456.0 5527.3 5531.9 5542.3 5548.4 9380.2 9417.9 9586.4 9605.2 9752.4 9525.0 9578.9 9612.2 9644.8 9687.1 7189.8 7388.0 7391.3 7410.7 7468.7 7017.8 7144.4 7185.7 7194.6 7211.5 8336.3 8543.7 8671.0 8727.0 8746.9 8717.4 8866.8 8879.4 8905.2 8944.9 6154.7 6353.9 6495.2 6505.9 6516.6 7424.6 7536.1 7541.5 7552.5 7555.7 6900.6 7071.9 7102.5 7206.8 7238.1 6676.1 6766.5 6949.0 7108.1 7140.1 6834.2 6879.4 6909.8 6945.5 7041.0 6515.6 6532.4 6566.5 6575.9 6578.2 6507.4 6566.1 6572.3 6594.9 6598.0 22:46:42 INFO - PROCESS | 23172 | 22:46:42 INFO - PROCESS | 23172 | [#4] prototype.html Cycles:180 Average:5150.23 Median:5768.26 stddev:1556.98 (27.0%) stddev-sans-first:1518.59 22:46:42 INFO - PROCESS | 23172 | Values: 322.2 328.6 329.6 333.8 333.8 5701.8 5763.3 5773.2 5795.9 5820.4 5544.8 5725.7 5754.9 5757.5 5758.0 4496.3 4496.6 4499.2 4500.4 4509.1 4315.5 4369.9 4472.5 4489.2 4507.1 4417.7 4476.1 4479.1 4485.7 4486.3 4448.6 4459.5 4483.0 4486.4 4506.6 3936.0 3942.7 3944.0 3950.0 3961.0 5407.4 5537.3 5556.2 5597.3 5612.3 5145.8 5156.6 5159.3 5160.4 5162.7 5832.3 6159.9 6175.7 6180.3 6189.7 4121.2 4183.8 4220.3 4225.9 4229.3 6306.5 6399.8 6420.4 6420.5 6420.7 4347.1 4349.0 4350.4 4351.7 4353.2 4201.3 4315.3 4397.4 4400.0 4406.7 5070.5 5072.1 5074.1 5075.0 5076.5 6182.6 6190.8 6203.3 6205.7 6206.4 1527.3 1551.9 1554.8 1555.3 1556.2 1029.5 1033.2 1035.4 1035.8 1057.6 5720.5 5720.6 5721.2 5724.0 5819.6 6320.4 6323.5 6329.1 6333.7 6338.3 5801.6 5807.6 5810.7 5821.4 5826.8 3304.7 3410.2 3418.3 3423.6 3428.6 6634.2 6640.5 6641.2 6645.3 6650.4 6485.4 6488.5 6504.1 6547.2 6568.6 6440.2 6607.8 6618.3 6620.5 6625.7 6151.4 6186.3 6245.7 6261.7 6287.0 6320.3 6321.5 6339.2 6341.6 6342.5 6547.3 6559.7 6597.4 6607.5 6757.2 4250.2 4342.5 4343.8 4350.9 4360.6 6402.1 6408.2 6410.9 6413.5 6435.6 6216.3 6219.9 6235.5 6238.2 6238.8 6084.9 6222.1 6223.4 6228.3 6230.0 6060.8 6117.3 6117.9 6124.8 6133.2 6260.4 6260.5 6260.9 6263.4 6266.5 5910.0 6116.4 6124.9 6134.3 6136.8 22:46:42 INFO - PROCESS | 23172 | 22:46:42 INFO - PROCESS | 23172 | [#5] yui.html Cycles:180 Average:13096.69 Median:42873.57 stddev:14644.86 (34.2%) stddev-sans-first:14656.12 22:46:42 INFO - PROCESS | 23172 | Values: 653.5 674.7 710.0 754.2 767.9 12778.6 12945.4 12961.4 12982.4 12983.3 12565.1 12570.4 12670.6 12675.5 12684.3 611.5 615.6 725.3 725.6 733.3 737.8 737.8 738.5 739.9 741.0 772.1 776.1 777.0 779.0 779.0 649.5 757.9 763.2 764.5 765.6 562.6 566.2 567.4 567.5 567.6 12187.1 12191.5 12253.2 12257.0 12276.9 12338.1 12448.1 12703.6 12810.2 12854.9 10081.8 10090.0 10160.7 10272.4 10290.3 3584.1 3619.1 3630.7 3716.6 3736.0 45196.8 46508.3 46768.8 46855.3 46905.5 10038.0 10096.6 10241.6 10295.1 10319.8 18019.3 18097.2 18175.5 18183.5 18221.7 7365.2 7454.4 7523.1 7547.7 7582.1 4118.3 4228.1 4244.9 4256.7 4349.6 3130.6 3142.4 3181.3 3185.4 3185.4 566.7 568.8 580.2 582.5 585.5 633.1 640.4 664.4 665.4 677.2 8642.9 8681.7 8694.7 8813.3 8865.0 516.3 533.1 546.9 575.6 625.3 3786.8 3822.3 3921.4 3966.8 4240.9 49257.0 49746.8 50385.7 52531.7 52983.5 46629.8 47285.3 47595.0 47609.3 48029.5 42432.8 42777.4 42857.4 42889.8 43265.8 8516.7 8809.3 8829.9 8902.6 9047.9 31909.8 32574.2 32908.8 33622.5 33651.0 38846.8 40896.0 41109.4 41306.4 41718.2 9531.9 10109.9 10554.0 10562.6 10859.7 11224.4 11263.4 12296.4 12394.2 12594.1 11484.4 11525.9 11533.9 11788.1 12212.7 11511.2 11618.9 11700.9 12008.9 12102.8 10976.6 11091.6 11104.5 11263.4 11466.3 8879.3 8952.0 8965.3 9148.0 9152.7 7940.5 8562.8 9622.5 9626.0 9632.5 22:46:42 INFO - PROCESS | 23172 | -------- Summary: end -------- 22:46:42 INFO - PROCESS | 23172 | 22:46:43 INFO - TEST-INFO | 23172: exit 0 22:46:43 INFO - TEST-OK | dromaeo_css | took 1112717ms 22:46:43 INFO - TEST-START | kraken 22:46:43 INFO - operating with platform_type : linux_ 22:46:43 INFO - Initialising browser for kraken test... 22:46:43 INFO - TEST-INFO | started process 23352 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpa3ZZrZ/profile http://localhost:42294/getInfo.html) 22:46:46 INFO - PROCESS | 23352 | __metrics Screen width/height:1600/1200 22:46:46 INFO - PROCESS | 23352 | colorDepth:24 22:46:46 INFO - PROCESS | 23352 | Browser inner width/height: 1024/697 22:46:46 INFO - PROCESS | 23352 | __metrics 22:46:47 INFO - PROCESS | 23352 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:46:48 INFO - TEST-INFO | 23352: exit 0 22:46:48 INFO - Browser initialized. 22:46:48 INFO - Running cycle 1/1 for kraken test... 22:46:48 INFO - TEST-INFO | started process 23434 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpa3ZZrZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:47:00 INFO - PROCESS | 23434 | RSS: Main: 148463616 22:47:00 INFO - PROCESS | 23434 | 22:47:03 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42294/tests/kraken/driver.html?testName=audio-beat-detection) 22:47:03 INFO - PROCESS | 23434 | RSS: Main: 193945600 22:47:03 INFO - PROCESS | 23434 | 22:47:06 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42294/tests/kraken/driver.html?testName=audio-dft) 22:47:06 INFO - PROCESS | 23434 | RSS: Main: 184135680 22:47:06 INFO - PROCESS | 23434 | 22:47:09 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42294/tests/kraken/driver.html?testName=audio-fft) 22:47:10 INFO - PROCESS | 23434 | RSS: Main: 167358464 22:47:10 INFO - PROCESS | 23434 | 22:47:12 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42294/tests/kraken/driver.html?testName=audio-oscillator) 22:47:13 INFO - PROCESS | 23434 | RSS: Main: 168628224 22:47:13 INFO - PROCESS | 23434 | 22:47:15 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42294/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:47:15 INFO - PROCESS | 23434 | RSS: Main: 170708992 22:47:15 INFO - PROCESS | 23434 | 22:47:18 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42294/tests/kraken/driver.html?testName=imaging-darkroom) 22:47:19 INFO - PROCESS | 23434 | RSS: Main: 170364928 22:47:19 INFO - PROCESS | 23434 | 22:47:22 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42294/tests/kraken/driver.html?testName=imaging-desaturate) 22:47:23 INFO - PROCESS | 23434 | RSS: Main: 171077632 22:47:23 INFO - PROCESS | 23434 | 22:47:26 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42294/tests/kraken/driver.html?testName=json-parse-financial) 22:47:26 INFO - PROCESS | 23434 | RSS: Main: 170196992 22:47:26 INFO - PROCESS | 23434 | 22:47:28 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42294/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:47:28 INFO - PROCESS | 23434 | RSS: Main: 181972992 22:47:28 INFO - PROCESS | 23434 | 22:47:30 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42294/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:47:31 INFO - PROCESS | 23434 | RSS: Main: 179798016 22:47:31 INFO - PROCESS | 23434 | 22:47:33 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42294/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:47:33 INFO - PROCESS | 23434 | RSS: Main: 194703360 22:47:33 INFO - PROCESS | 23434 | 22:47:36 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:47:36 INFO - PROCESS | 23434 | RSS: Main: 198656000 22:47:36 INFO - PROCESS | 23434 | 22:47:39 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:47:40 INFO - PROCESS | 23434 | RSS: Main: 199884800 22:47:40 INFO - PROCESS | 23434 | 22:47:41 INFO - PROCESS | 23434 | Cycle 1(1): loaded http://localhost:42294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42294/tests/kraken/driver.html?testName=ai-astar) 22:47:42 INFO - PROCESS | 23434 | RSS: Main: 260349952 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | __start_tp_report 22:47:42 INFO - PROCESS | 23434 | _x_x_mozilla_page_load 22:47:42 INFO - PROCESS | 23434 | _x_x_mozilla_page_load_details 22:47:42 INFO - PROCESS | 23434 | |i|pagename|runs| 22:47:42 INFO - PROCESS | 23434 | |0;ai-astar;110;110;105;110;112;112;103;111;111;111 22:47:42 INFO - PROCESS | 23434 | |1;audio-beat-detection;154;135;151;165;134;157;155;129;166;134 22:47:42 INFO - PROCESS | 23434 | |2;audio-dft;163;161;161;162;161;162;160;164;162;162 22:47:42 INFO - PROCESS | 23434 | |3;audio-fft;72;76;101;98;77;73;72;112;92;73 22:47:42 INFO - PROCESS | 23434 | |4;audio-oscillator;97;96;136;96;96;95;149;96;95;148 22:47:42 INFO - PROCESS | 23434 | |5;imaging-gaussian-blur;119;115;114;114;114;114;115;115;115;115 22:47:42 INFO - PROCESS | 23434 | |6;imaging-darkroom;147;145;147;146;147;147;147;146;146;146 22:47:42 INFO - PROCESS | 23434 | |7;imaging-desaturate;96;96;96;95;95;96;96;96;96;95 22:47:42 INFO - PROCESS | 23434 | |8;json-parse-financial;58;58;57;57;58;56;58;64;55;55 22:47:42 INFO - PROCESS | 23434 | |9;json-stringify-tinderbox;67;68;67;67;66;67;67;68;66;67 22:47:42 INFO - PROCESS | 23434 | |10;stanford-crypto-aes;83;85;83;82;83;82;86;90;83;82 22:47:42 INFO - PROCESS | 23434 | |11;stanford-crypto-ccm;124;115;119;117;117;118;123;128;115;117 22:47:42 INFO - PROCESS | 23434 | |12;stanford-crypto-pbkdf2;153;142;152;148;150;142;143;151;150;152 22:47:42 INFO - PROCESS | 23434 | |13;stanford-crypto-sha256-iterative;72;69;71;71;69;71;68;70;69;70 22:47:42 INFO - PROCESS | 23434 | __end_tp_report 22:47:42 INFO - PROCESS | 23434 | __start_cc_report 22:47:42 INFO - PROCESS | 23434 | _x_x_mozilla_cycle_collect,943 22:47:42 INFO - PROCESS | 23434 | __end_cc_report 22:47:42 INFO - PROCESS | 23434 | __startTimestamp1455432462052__endTimestamp 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | ------- Summary: start ------- 22:47:42 INFO - PROCESS | 23434 | Number of tests: 14 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.03 (2.7%) stddev-sans-first:3.21 22:47:42 INFO - PROCESS | 23434 | Values: 110.0 110.0 105.0 110.0 112.0 112.0 103.0 111.0 111.0 111.0 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:154.50 stddev:13.78 (8.9%) stddev-sans-first:14.45 22:47:42 INFO - PROCESS | 23434 | Values: 154.0 135.0 151.0 165.0 134.0 157.0 155.0 129.0 166.0 134.0 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 22:47:42 INFO - PROCESS | 23434 | Values: 163.0 161.0 161.0 162.0 161.0 162.0 160.0 164.0 162.0 162.0 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#3] audio-fft Cycles:10 Average:84.60 Median:74.50 stddev:14.80 (19.9%) stddev-sans-first:14.98 22:47:42 INFO - PROCESS | 23434 | Values: 72.0 76.0 101.0 98.0 77.0 73.0 72.0 112.0 92.0 73.0 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:96.00 stddev:23.67 (24.7%) stddev-sans-first:24.60 22:47:42 INFO - PROCESS | 23434 | Values: 97.0 96.0 136.0 96.0 96.0 95.0 149.0 96.0 95.0 148.0 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:0.53 22:47:42 INFO - PROCESS | 23434 | Values: 119.0 115.0 114.0 114.0 114.0 114.0 115.0 115.0 115.0 115.0 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 22:47:42 INFO - PROCESS | 23434 | Values: 147.0 145.0 147.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 22:47:42 INFO - PROCESS | 23434 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:2.55 (4.4%) stddev-sans-first:2.70 22:47:42 INFO - PROCESS | 23434 | Values: 58.0 58.0 57.0 57.0 58.0 56.0 58.0 64.0 55.0 55.0 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 22:47:42 INFO - PROCESS | 23434 | Values: 67.0 68.0 67.0 67.0 66.0 67.0 67.0 68.0 66.0 67.0 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:2.51 (3.0%) stddev-sans-first:2.65 22:47:42 INFO - PROCESS | 23434 | Values: 83.0 85.0 83.0 82.0 83.0 82.0 86.0 90.0 83.0 82.0 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:118.50 stddev:4.30 (3.6%) stddev-sans-first:4.21 22:47:42 INFO - PROCESS | 23434 | Values: 124.0 115.0 119.0 117.0 117.0 118.0 123.0 128.0 115.0 117.0 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:150.50 stddev:4.35 (2.9%) stddev-sans-first:4.27 22:47:42 INFO - PROCESS | 23434 | Values: 153.0 142.0 152.0 148.0 150.0 142.0 143.0 151.0 150.0 152.0 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - PROCESS | 23434 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:1.25 (1.8%) stddev-sans-first:1.09 22:47:42 INFO - PROCESS | 23434 | Values: 72.0 69.0 71.0 71.0 69.0 71.0 68.0 70.0 69.0 70.0 22:47:42 INFO - PROCESS | 23434 | -------- Summary: end -------- 22:47:42 INFO - PROCESS | 23434 | 22:47:42 INFO - TEST-INFO | 23434: exit 0 22:47:42 INFO - TEST-OK | kraken | took 59735ms 22:47:42 INFO - SUITE-END | took 1172s 22:47:43 INFO - Completed test suite (00:19:32) 22:47:43 INFO - Working with test: dromaeo_css 22:47:43 INFO - Generating results file: dromaeo_css 22:47:43 INFO - Working with test: kraken 22:47:43 INFO - Generating results file: kraken 22:47:43 INFO - javascript benchmark 22:47:43 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:47:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 22:47:43 INFO - process_Request line: dromaeo_css 6665.24 graph.html#tests=[[72,1,35]] 22:47:43 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:47:43 INFO - process_Request line: kraken 1517.50 graph.html#tests=[[232,1,35]] 22:47:43 INFO - RETURN: dromaeo_css: 6665.24 22:47:43 INFO - RETURN: kraken: 1517.50 22:47:43 INFO - javascript benchmark 22:47:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3134.1537784798106, 3192.8882489112884, 3237.3039796443773, 3238.2390138317505, 3261.8532166052523, 5053.36832895888, 5130.615203859711, 5147.665401748884, 5220.791168353266, 5250.264962905197, 5147.81982630608, 5157.4842515748405, 5177.378714554259, 5187.403448603412, 5197.168453047513, 4654.813807447698, 4690.179218636734, 4772.832950846721, 4774.092922344744, 4792.568668819806, 4623.976880115595, 4700.905981880361, 4738.265568836819, 4738.952610473885, 4857.73282469464, 4644.210484217691, 4650.046740418223, 4658.673892827504, 4703.553162449562, 4711.057788442291, 4669.976650116728, 4677.345171675968, 4688.29675548667, 4688.953110468886, 4708.4820669726305, 4636.188666983298, 4672.415948006499, 4704.247320428749, 4740.620750339965, 4777.116233496814, 4969.577585905203, 4974.8756281093265, 4992.575631071363, 4998.8250411235795, 5042.067217564762, 5313.495217954288, 5469.644473109275, 5476.835694929158, 5489.780408783644, 5492.038893193675, 5489.204065410533, 5522.199281104257, 5525.723713814293, 5530.446955304477, 5570.053090974504, 5176.8964620707375, 5194.506521880416, 5195.064888320101, 5195.376554813409, 5199.870003249911, 5355.785768569213, 5468.972655136698, 5619.494245517923, 5634.295713035871, 5647.322321321468, 5366.731663416814, 5392.5416339611575, 5406.459354064641, 5407.297051383295, 5455.645383050089, 5458.4814442627885, 5502.477264659851, 5503.229547863302, 5503.504684578407, 5504.2018907258225, 5377.7580008899695, 5447.918281225785, 5487.204355368449, 5493.121100623881, 5515.393306736256, 5407.188921661782, 5420.4850539198715, 5424.7016414096815, 5427.240186373911, 5459.317585301837, 4244.0663054128045, 4256.489221293465, 4265.104328091135, 4297.548757380492, 4299.204647140226, 3763.8118094095184, 3825.445310429972, 3830.7318487705593, 3872.6901847852105, 3897.922041559153, 4997.875053123701, 5028.5977121830165, 5034.974825125851, 5037.042961837239, 5037.874053148701, 5224.477552244821, 5446.074167391553, 5446.91829622556, 5465.508104270635, 5467.261919640798, 4980.153373926369, 5016.372953380827, 5020.899582008339, 5032.547070763576, 5055.69665820052, 4719.622430205644, 4731.157199392954, 4742.881427964259, 4747.121782470254, 4791.688540244873, 5589.133684278943, 5670.886582268414, 5728.198052272685, 5746.051901436216, 5752.223449834302, 5491.258680078138, 5524.66851988882, 5525.392206857162, 5533.0, 5564.77740890376, 5607.355154157324, 5615.0, 5615.7192140392, 5622.156676498558, 5626.212330273846, 5351.438098999549, 5381.461853814587, 5384.488473595002, 5386.084365657926, 5392.218128371443, 5308.336457942757, 5540.307461567304, 5560.443955604407, 5589.385167631476, 5635.859103522281, 5285.418603953639, 5301.734913254399, 5307.150855863043, 5308.071087559739, 5315.681059136464, 5219.739013049257, 5252.737363131904, 5293.708846013352, 5306.575473961997, 5370.516653501048, 5283.947160528345, 5299.231611416246, 5310.734463276744, 5310.920336194883, 5338.54622357104, 5396.325459317585, 5396.487333703292, 5402.648827826179, 5448.618596698193, 5448.972755136199, 5191.8182863599595, 5278.920816187837, 5286.735663216747, 5344.839654810362, 5408.45915408456], "unit": "score", "name": "dojo.html", "value": 5067.210377539872}, {"lowerIsBetter": false, "replicates": [518.6188151708496, 524.2267655208567, 531.5827075745541, 540.3839622829972, 544.0397698062919, 27151.53332833469, 27948.0, 27950.16149515518, 27969.860150699267, 34334.8283258584, 37663.811680941624, 37857.43213851788, 37987.240255194876, 38154.04614884629, 38217.80891095548, 8423.199796019368, 8601.182887625666, 8607.526586037766, 8616.612252448624, 8620.913790862074, 8421.621027053767, 8558.871616925751, 8561.700340488083, 8569.785755356104, 8575.185357391038, 8524.659013639446, 8826.86759698605, 8827.911720882805, 8828.337874659393, 8836.381453298272, 8676.60955257015, 8731.519766412845, 8757.036725960172, 8762.167594078552, 8776.254018408443, 8668.52323122228, 8795.780105497413, 8807.515586642796, 8807.559622018873, 8809.075047120088, 35589.11027224314, 38340.42489362634, 38392.616073839185, 38596.421053684215, 38636.80681596602, 3028.424599326121, 3279.9344013119603, 3404.3701915145775, 3587.7309201809967, 3753.930129912989, 28401.147965561067, 29116.27209319784, 29208.269793255127, 29234.56148157779, 29269.414611707645, 3806.809659517013, 3851.5570709368503, 3963.8810835674976, 4012.1775036117524, 4038.45480860086, 193678.0, 194397.0, 194493.0, 194545.0, 194674.0, 53010.0, 53082.0, 53103.0, 53155.468445315826, 53224.20163697548, 55765.0, 55776.72111639416, 55781.16328255079, 55827.53379729612, 55856.441435585126, 13504.324783760772, 13571.728565428637, 13605.591832245049, 13676.384562694702, 13684.589462316146, 10285.691429256985, 10298.948505257425, 10329.070383665507, 10369.688909332732, 10431.37411755297, 17747.201375937857, 18093.7285940711, 18381.448556543324, 18418.907905460655, 18462.0, 6868.896966545506, 6971.736339063974, 7055.506114572034, 7108.253633368526, 7165.176004759415, 935.1723724503863, 943.1511639524346, 946.8153710026479, 972.9173020293213, 989.7674046599044, 26931.0, 27479.59683139062, 27852.303692407448, 27874.16377508678, 28151.155465336073, 916.4089162490156, 978.5058545434653, 991.667791289926, 1011.0849681038671, 1026.7227848480868, 12335.814962775565, 12351.764823517757, 12356.691082723004, 12587.433565489575, 12641.683957901127, 297965.0, 300635.0, 301421.0, 301606.0, 302079.0, 41084.79457602693, 44027.11945761131, 44675.32987005197, 44731.329030064575, 44811.0, 1191.7080315322628, 1300.174389262825, 1302.798066299725, 1304.6542666193466, 1308.2281453942219, 24347.26958191257, 24768.50462990766, 25569.0, 25628.231153065437, 26565.203043908714, 40469.0, 41121.0, 41227.1754564913, 41251.58748412477, 41307.38038929358, 247203.0, 249013.0, 249071.0, 249355.0, 249425.50574494022, 28227.858860706387, 29483.85258073696, 29919.70080299169, 30485.695143048284, 30834.537481938238, 37304.25391492209, 37513.43729844109, 37908.43137352997, 37991.62008379881, 38458.6154138455, 32326.676733232365, 32466.513002304513, 32538.349233014735, 32620.673793262715, 33212.50181247332, 33030.0, 33144.0, 33365.83317083399, 33374.0, 33671.0, 33158.17104572405, 33381.0, 33454.33091338208, 33551.328973419906, 33645.49531756977, 35567.28865422729, 36512.0, 37139.0, 38182.51621684948, 41818.37272440855, 27578.586321204795, 28470.0, 30427.39145217039, 30635.2341191472, 31074.68925310718], "unit": "score", "name": "ext.html", "value": 17184.99717557824}, {"lowerIsBetter": false, "replicates": [327.27018748191546, 341.92990436960423, 348.1505127488927, 350.9754317197796, 352.5663433976208, 13349.199048057098, 13713.657158571015, 15879.523614291575, 16276.267567959441, 16967.915160424196, 14967.850321496782, 15306.846931530681, 15421.383144674228, 16005.119718415483, 16052.357905683759, 5118.6416950813555, 5144.614153938451, 5282.23407605897, 5303.946960530384, 5309.548688361494, 3713.1830997180577, 5097.286379906797, 5261.368635763713, 5297.867553311159, 5328.307320048408, 5283.947160528403, 5308.628396012281, 5311.468853114697, 5321.946780532184, 5624.746886390122, 5939.07944268639, 5952.7023648817385, 5956.344802071769, 5958.0, 5963.850903727398, 5178.938317644874, 5224.268602395668, 5228.660137091077, 5233.450487698775, 5271.051210782058, 12046.216995895238, 12401.937990310082, 14676.926615366854, 18849.434516964513, 18863.62272754537, 2238.2613737466595, 2262.875541845198, 2436.8781560921884, 2489.1163636909, 2601.596752503365, 8841.778955526099, 8940.0, 9141.725748227564, 9250.676226332112, 9330.066993300616, 1847.473470061026, 1913.8277555020115, 1924.2399252295404, 1934.1489744512369, 1944.5333120051228, 56357.0, 57853.71073144607, 57964.71017644927, 58470.0, 59099.704501477216, 9713.70858874235, 9785.168260697777, 9805.411675299505, 9819.085278370649, 9895.356801807859, 12637.873621263854, 12707.555235566895, 12725.809112863315, 12739.55411560591, 12751.171173873669, 6877.965610171917, 6916.481263905227, 6925.134358205224, 7015.403690686348, 7084.220735719066, 6509.44669703071, 6520.608763474207, 6569.80290591283, 6574.211094668671, 6589.242237142694, 3815.828287727059, 4087.6321131098343, 4194.119234960693, 4236.364545318165, 4244.702870799076, 1657.3426573426573, 1716.8969861808332, 1721.7847769028872, 1730.7057800174, 1747.1264367816093, 835.399428463325, 865.4158443050916, 932.1470854168496, 941.0119374656583, 985.5909797433984, 13481.528146514825, 15287.159206243763, 15553.68892622164, 15743.212839357986, 15866.9206653966, 861.4701958295603, 876.369014309696, 905.9909400905907, 926.745145085107, 935.9017303183203, 8737.868931966026, 8746.781330466789, 8758.518281494578, 8828.028916819145, 8879.733607991771, 560820.9179082059, 563766.0, 565307.0, 589035.0, 590262.0, 72011.0, 73244.0, 75180.27980021392, 75475.62262188653, 75559.24440755633, 1162.7209469727204, 1167.550493060178, 1174.8120300751839, 1199.874013228616, 1200.7658506591306, 15093.622659433162, 15451.0, 15507.302171402089, 15558.611034724223, 15814.9209253953, 33489.83255083709, 33557.0, 33584.0, 34383.31233375368, 34939.65060349466, 46489.302660460795, 46577.53422465732, 47387.28919066286, 47529.28706069342, 47728.28407573959, 7052.9647351762915, 7074.080369551925, 7169.601927624271, 7286.724823155821, 7311.341979221896, 8635.438696484709, 11009.724756881142, 11077.889221107685, 11429.657110286706, 11943.522259109539, 9711.27165462579, 9726.46504442234, 10029.197664186993, 10186.592536298465, 10228.437435940798, 7072.611006394698, 7928.167542408195, 9449.244060475283, 10028.498575071071, 10186.490675466346, 9455.19630831387, 9577.569009394454, 9790.118889299998, 10285.0, 10306.227032972407, 7239.44393400706, 7317.0, 7435.974090682611, 7457.792904516904, 7575.787873940143, 9035.864462033207, 10065.245106616887, 10142.29003969715, 10321.277510574488, 10375.636852710119], "unit": "score", "name": "jquery.html", "value": 8027.980367063388}, {"lowerIsBetter": false, "replicates": [1223.4005337384674, 1377.4008306386722, 1392.4291040673322, 1492.3582859370474, 1680.4202550120212, 7019.859602807941, 7677.5393476391455, 7856.842863142748, 7872.527648341096, 7879.842403151948, 7410.814729631748, 7416.740414085508, 7482.176960534337, 7493.250674932504, 7509.361704255131, 1972.9506762330914, 2207.86752794832, 2252.200468833565, 2253.076238742116, 2265.150568536799, 2282.4522114692522, 2310.295359915225, 2315.409570559505, 2317.432229103872, 2322.3613506285737, 2269.920552780653, 2299.057386471547, 2306.5963456395066, 2310.1336998625516, 2321.4080409495555, 2262.570111678784, 2279.2022792022826, 2288.8512246703995, 2314.5833749925005, 2317.513322202323, 2269.0356598445596, 2282.7146606674164, 2282.8402011859175, 2285.1202287119413, 2287.2452090809993, 7708.614569271514, 7774.144844067148, 7781.377489800859, 7786.416018798613, 7788.026496687914, 4577.0, 4689.577937985564, 4691.554302341272, 4715.834945776915, 4720.834770783006, 3035.924101897448, 3037.2255074955965, 3058.801177923428, 3085.012795905311, 3168.603924509436, 895.789489469974, 907.3557773980482, 912.2929729459655, 919.9678011269574, 971.3006635222629, 10715.571377144905, 10810.081143102845, 10836.783264334748, 10839.349639021606, 10859.78280434387, 4279.850205242801, 4396.208682437192, 4428.33574963758, 4431.335299705005, 4453.576910193527, 9311.72064838056, 9317.440953542673, 9333.20667743236, 9546.093121153479, 9549.283803714749, 4775.140474714584, 4791.544803243686, 4801.879953001133, 4803.615710743132, 4803.615710743132, 4322.6325762309925, 4347.65218782503, 4359.062801497693, 4359.891002724958, 4362.629176519968, 3460.480927860841, 3575.8748443804343, 3697.852085916587, 3708.6662200402093, 3738.8691395801015, 1180.1031216275692, 1184.1296646964474, 1196.389841181004, 1200.105921088777, 1200.4837919694614, 1066.1364294920984, 1082.723905404117, 1093.573506332531, 1107.9390633515072, 1109.8057839877988, 7075.292470752884, 7146.035285236427, 7174.354308112295, 7191.496595238283, 7199.964000180071, 1075.0808059109506, 1075.9623413180502, 1075.9731006724737, 1077.5474300793685, 1091.2633972068822, 5456.045192091368, 5527.2538207341495, 5531.917021244684, 5542.251796007568, 5548.445155484419, 9380.155785979157, 9417.858732119024, 9586.376885502421, 9605.18355939739, 9752.366096203725, 9525.047495250557, 9578.856317155249, 9612.231021518262, 9644.807103857884, 9687.079727425884, 7189.784306470814, 7388.0, 7391.33477986973, 7410.703571857065, 7468.663910124057, 7017.754378596929, 7144.428445724226, 7185.748498802517, 7194.604296763729, 7211.495195336276, 8336.268522698445, 8543.700970466003, 8671.04618491978, 8726.956365218133, 8746.868796967923, 8717.389782715149, 8866.822663546563, 8879.422837515542, 8905.154010369004, 8944.86582701273, 6154.692265386802, 6353.904691429725, 6495.220573531206, 6505.902411463737, 6516.609003459618, 7424.554526728413, 7536.057992750906, 7541.509801862861, 7552.546847189186, 7555.73554925575, 6900.585964842126, 7071.929280707127, 7102.4673149512955, 7206.783796486114, 7238.059052323164, 6676.132102826601, 6766.458683305225, 6949.0, 7108.111486064242, 7140.071790667388, 6834.248232694499, 6879.415249703831, 6909.7581584646305, 6945.548539344926, 7041.014258003986, 6515.641639709672, 6532.41208291256, 6566.474682025522, 6575.868482630416, 6578.243501997332, 6507.446867016357, 6566.080748695282, 6572.34276572339, 6594.90107648376, 6598.0], "unit": "score", "name": "mootools.html", "value": 4467.807185126806}, {"lowerIsBetter": false, "replicates": [322.16398446032565, 328.5597299618511, 329.55180953902703, 333.7546903026275, 333.82307377090143, 5701.77192912283, 5763.279590051238, 5773.249477567921, 5795.913061304079, 5820.417958204177, 5544.750486228119, 5725.742341594628, 5754.913676294859, 5757.481826635602, 5758.0, 4496.348029535716, 4496.572825581581, 4499.167653984024, 4500.437445319335, 4509.0530988492455, 4315.503717072545, 4369.868903932887, 4472.485664148616, 4489.1695036418205, 4507.053518761048, 4417.668674849399, 4476.149531588988, 4479.126570318789, 4485.730856148642, 4486.304622783474, 4448.577385148422, 4459.464864216298, 4483.036147228361, 4486.371907932892, 4506.639468842484, 3936.0356712605308, 3942.743721658083, 3944.033711740642, 3950.0, 3961.0, 5407.378151512547, 5537.252470916415, 5556.16657501374, 5597.328320601554, 5612.270404847343, 5145.794168233266, 5156.639035267533, 5159.303494028333, 5160.354955630546, 5162.690238585659, 5832.270966129234, 6159.907601385983, 6175.691215439255, 6180.2892667343385, 6189.721462534197, 4121.155163191538, 4183.769892655902, 4220.261454245495, 4225.873223803291, 4229.344451610005, 6306.463950564207, 6399.77600783975, 6420.390062944013, 6420.486361091102, 6420.711068001951, 4347.0871117065135, 4349.0, 4350.434443522322, 4351.673624478177, 4353.238183317907, 4201.306784380543, 4315.28797748368, 4397.428334316583, 4400.009997750481, 4406.735595864258, 5070.467600901926, 5072.061668591323, 5074.061298659686, 5075.0357432087785, 5076.466970968069, 6182.567220294626, 6190.845228869314, 6203.2556093268195, 6205.689715514297, 6206.441420272197, 1527.3203424476224, 1551.8758499320027, 1554.8367421420814, 1555.3234343060578, 1556.1985577427633, 1029.5109822834243, 1033.1631378583372, 1035.3632516002604, 1035.782485678016, 1057.5558265528496, 5720.513756330675, 5720.628159169641, 5721.170430287585, 5724.026915424388, 5819.592628515963, 6320.4311611955145, 6323.52573556985, 6329.050642403677, 6333.68331583419, 6338.30278669346, 5801.593888427769, 5807.622504537276, 5810.6513609183585, 5821.388754180834, 5826.82519524415, 3304.686054824788, 3410.1645096951406, 3418.3163367326633, 3423.5891692997, 3428.6228514863346, 6634.203895532471, 6640.468762498988, 6641.203055633258, 6645.269020407752, 6650.434713049445, 6485.4163125318, 6488.513361497907, 6504.1219435375615, 6547.214334279917, 6568.573042752206, 6440.194975628046, 6607.768728094494, 6618.338166183343, 6620.5365624406795, 6625.734970601218, 6151.446369826737, 6186.257649082139, 6245.687715614292, 6261.74953001893, 6287.0, 6320.336364681826, 6321.49428045746, 6339.207599050119, 6341.55609107358, 6342.524310676626, 6547.312532184052, 6559.7376104957175, 6597.406233439014, 6607.537472376887, 6757.222919364336, 4250.171216612731, 4342.47890253159, 4343.804528796149, 4350.869473915787, 4360.563943605614, 6402.103705481143, 6408.166938297992, 6410.871782564416, 6413.4869210463985, 6435.613863168225, 6216.316205217513, 6219.906701399392, 6235.501159907106, 6238.157848690369, 6238.781642642486, 6084.90872636902, 6222.066689996355, 6223.377662233922, 6228.314885362697, 6230.034344676583, 6060.818175454743, 6117.327094019565, 6117.938820611737, 6124.755009799736, 6133.172021777003, 6260.436560709558, 6260.467860231931, 6260.874782504416, 6263.373662633882, 6266.498680105489, 5910.0, 6116.35778243278, 6124.938750612615, 6134.263888333428, 6136.754529818757], "unit": "score", "name": "prototype.html", "value": 4644.399485430495}, {"lowerIsBetter": false, "replicates": [653.4641593893007, 674.7301079568172, 709.978700638981, 754.2306847016047, 767.919368466311, 12778.616641500746, 12945.417456214469, 12961.416736246869, 12982.350882455874, 12983.285919274447, 12565.120441569094, 12570.43433045513, 12670.619881403572, 12675.492980280778, 12684.30236337001, 611.5291225756165, 615.5660259517052, 725.3182008911632, 725.622676208374, 733.3363306207864, 737.8155461134717, 737.8450525389675, 738.5236522443021, 739.8520295940806, 741.0329519976428, 772.1467778105197, 776.0687175389555, 776.9883451748228, 778.98831517527, 778.9989863026012, 649.4966401039185, 757.8635845547826, 763.2138896936165, 764.468694257494, 765.5598031132066, 562.5977426140329, 566.2157911292848, 567.3702190568466, 567.4552429667524, 567.6480582039121, 12187.146899717023, 12191.45138468771, 12253.203541769757, 12257.0, 12276.877231227663, 12338.074644401617, 12448.06639502032, 12703.555375561904, 12810.16733912302, 12854.935725321408, 10081.798364032751, 10090.0, 10160.695179144637, 10272.435016074112, 10290.331128476626, 3584.068142282999, 3619.113317237294, 3630.6732394084397, 3716.5725941516803, 3736.028632555528, 45196.77401613004, 46508.302375464395, 46768.76615616934, 46855.29717054213, 46905.5309446908, 10038.0, 10096.646617368357, 10241.632006337859, 10295.07344339013, 10319.793604128026, 18019.2792288307, 18097.18562664683, 18175.45473635793, 18183.545411364557, 18221.7266740999, 7365.1530074042175, 7454.40364770817, 7523.0972283326355, 7547.73582924595, 7582.090149182133, 4118.279301122292, 4228.069824638575, 4244.893877653021, 4256.723312984646, 4349.565043495625, 3130.6399764026974, 3142.355817057498, 3181.2524056846623, 3185.3788511240086, 3185.4106990206888, 566.6939852479697, 568.7838621323954, 580.2485780913727, 582.5223316880117, 585.5432762445299, 633.0851918977125, 640.3500447046251, 664.372168300951, 665.4044630056072, 677.218835024727, 8642.913570864337, 8681.696140635047, 8694.652213911373, 8813.25087367581, 8865.0, 516.3416643779211, 533.1283351719889, 546.8605505596048, 575.6200907401179, 625.2840497630278, 3786.848526058982, 3822.26660009985, 3921.4124254404032, 3966.841326346914, 4240.915181696349, 49257.0, 49746.75126624344, 50385.74807125941, 52531.73734131381, 52983.470165298626, 46629.76685116553, 47285.29072063922, 47595.0, 47609.285860712116, 48029.519704803206, 42432.78783606062, 42777.35833962493, 42857.35713964293, 42889.785551072666, 43265.783671081444, 8516.70191543293, 8809.339299552432, 8829.93231013344, 8902.59938302791, 9047.909520904706, 31909.840450797597, 32574.185645359055, 32908.83545582257, 33622.495662564594, 33651.0, 38846.805765972116, 40896.0, 41109.383359249034, 41306.380404293355, 41718.16563668649, 9531.904680953101, 10109.898901010896, 10554.0, 10562.577496900038, 10859.674209773719, 11224.438778061227, 11263.436828158396, 12296.446659900146, 12394.194377365442, 12594.118411711459, 11484.368359740294, 11525.88474115248, 11533.884661153617, 11788.056955443715, 12212.694682633006, 11511.19421640477, 11618.94190529042, 11700.88299116998, 12008.939955300517, 12102.75794484123, 10976.560937562408, 11091.556337746722, 11104.450994476378, 11263.436828158723, 11466.31202127875, 8879.33404994615, 8952.0, 8965.282777377664, 9147.954260228656, 9152.679656212, 7940.523568585903, 8562.800849104524, 9622.51887405641, 9626.0, 9632.518374081128], "unit": "score", "name": "yui.html", "value": 6043.779861749539}], "name": "dromaeo_css", "value": 6665.238127655731}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 110.0, 112.0, 112.0, 103.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [154.0, 135.0, 151.0, 165.0, 134.0, 157.0, 155.0, 129.0, 166.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 162.0, 161.0, 162.0, 160.0, 164.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 101.0, 98.0, 77.0, 73.0, 72.0, 112.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 136.0, 96.0, 96.0, 95.0, 149.0, 96.0, 95.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.0}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 57.0, 57.0, 58.0, 56.0, 58.0, 64.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 66.0, 67.0, 67.0, 68.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 83.0, 82.0, 83.0, 82.0, 86.0, 90.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [124.0, 115.0, 119.0, 117.0, 117.0, 118.0, 123.0, 128.0, 115.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.3}, {"lowerIsBetter": true, "replicates": [153.0, 142.0, 152.0, 148.0, 150.0, 142.0, 143.0, 151.0, 150.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.3}, {"lowerIsBetter": true, "replicates": [72.0, 69.0, 71.0, 71.0, 69.0, 71.0, 68.0, 70.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1517.5}]} 22:47:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1517.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6665.24"}}} 22:47:43 INFO - Return code: 0 22:47:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:47:43 INFO - # TBPL SUCCESS # 22:47:43 INFO - Running post-action listener: _resource_record_post_action 22:47:43 INFO - Running post-run listener: _resource_record_post_run 22:47:44 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539078656; Read time: 12; Write time: 417592 22:47:44 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 239644672; Read time: 0; Write time: 252276 22:47:44 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298835968; Read time: 12; Write time: 165316 22:47:44 INFO - Running post-run listener: _upload_blobber_files 22:47:44 INFO - Blob upload gear active. 22:47:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:47:44 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:47:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:47:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:47:44 INFO - (blobuploader) - INFO - Open directory for files ... 22:47:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:47:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:47:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:47:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:45 INFO - (blobuploader) - INFO - Done attempting. 22:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:47:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:46 INFO - (blobuploader) - INFO - Done attempting. 22:47:46 INFO - (blobuploader) - INFO - Iteration through files over. 22:47:46 INFO - Return code: 0 22:47:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:47:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:47:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68f04b566291627c5e4fb95c829dfd828995bb6bf028e5e020cbba44c210b4688a2f8a03bfdf7e060f07fa14a5514c8c55dba51b17671c27b406c4d4107422cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9e45f84742372ade5e6cbafd150118a4e841f501d58bc632481c5685ac33fac4f9c136d510b62b810be407329d67aea8c2196c1a8a9e8e390eb89e14cf7ecae"} 22:47:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:47:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:47:46 INFO - Contents: 22:47:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68f04b566291627c5e4fb95c829dfd828995bb6bf028e5e020cbba44c210b4688a2f8a03bfdf7e060f07fa14a5514c8c55dba51b17671c27b406c4d4107422cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9e45f84742372ade5e6cbafd150118a4e841f501d58bc632481c5685ac33fac4f9c136d510b62b810be407329d67aea8c2196c1a8a9e8e390eb89e14cf7ecae"} 22:47:46 INFO - Running post-run listener: copy_logs_to_upload_dir 22:47:46 INFO - Copying logs to upload dir... 22:47:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:47:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.401656 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-13 22:47:46.227581) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-13 22:47:46.230867) ========= 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=82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68f04b566291627c5e4fb95c829dfd828995bb6bf028e5e020cbba44c210b4688a2f8a03bfdf7e060f07fa14a5514c8c55dba51b17671c27b406c4d4107422cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9e45f84742372ade5e6cbafd150118a4e841f501d58bc632481c5685ac33fac4f9c136d510b62b810be407329d67aea8c2196c1a8a9e8e390eb89e14cf7ecae"} build_url:https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011466 build_url: 'https://queue.taskcluster.net/v1/task/P2Ui-U1aQXOsSMZVAw4y-g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68f04b566291627c5e4fb95c829dfd828995bb6bf028e5e020cbba44c210b4688a2f8a03bfdf7e060f07fa14a5514c8c55dba51b17671c27b406c4d4107422cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9e45f84742372ade5e6cbafd150118a4e841f501d58bc632481c5685ac33fac4f9c136d510b62b810be407329d67aea8c2196c1a8a9e8e390eb89e14cf7ecae"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-13 22:47:46.255590) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:47:46.255929) ========= 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=82e07478c745e68b1fe4678a000001bc-1455426719.871833-256965181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 22:47:46.340041) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-13 22:47:46.340384) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-13 22:47:46.340663) ========= ========= Total master_lag: 0.33 =========