builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1455371114.65 results: success (0) buildid: 20160213030210 builduid: 894af2de5a0b424887525eea5079d9db revision: d719ac4bcbec13e0ba13a41547788e3bf365c679 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:14.646714) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:14.647109) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:14.647419) ========= 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=32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006350 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:14.688025) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:14.688316) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:14.748557) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:14.748828) ========= 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=32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:14.810617) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:14.810876) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:14.811224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:14.811507) ========= 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=32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-13 05:45:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.1M=0s 2016-02-13 05:45:15 (84.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.230422 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:15.056961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:15.057275) ========= 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=32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014415 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:15.107077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:15.107442) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d719ac4bcbec13e0ba13a41547788e3bf365c679 --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 d719ac4bcbec13e0ba13a41547788e3bf365c679 --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=32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-13 05:45:15,759 truncating revision to first 12 chars 2016-02-13 05:45:15,759 Setting DEBUG logging. 2016-02-13 05:45:15,759 attempt 1/10 2016-02-13 05:45:15,759 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d719ac4bcbec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-13 05:45:16,078 unpacking tar archive at: mozilla-central-d719ac4bcbec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617565 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:15.738629) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:15.738923) ========= echo d719ac4bcbec13e0ba13a41547788e3bf365c679 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd719ac4bcbec13e0ba13a41547788e3bf365c679'] 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=32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d719ac4bcbec13e0ba13a41547788e3bf365c679 program finished with exit code 0 elapsedTime=0.004633 script_repo_revision: 'd719ac4bcbec13e0ba13a41547788e3bf365c679' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:15.789760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:15.790060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-13 05:45:15.800113) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-02-13 05:45:15.800408) ========= /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=32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:45:16 INFO - MultiFileLogger online at 20160213 05:45:16 in /builds/slave/test-pgo 05:45:16 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 05:45:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:45:16 INFO - {'append_to_log': False, 05:45:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:45:16 INFO - 'blob_upload_branch': 'Firefox', 05:45:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:45:16 INFO - 'branch': 'Firefox', 05:45:16 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:16 INFO - 'config_files': ('talos/linux_config.py',), 05:45:16 INFO - 'default_actions': ('clobber', 05:45:16 INFO - 'read-buildbot-config', 05:45:16 INFO - 'download-and-extract', 05:45:16 INFO - 'populate-webroot', 05:45:16 INFO - 'create-virtualenv', 05:45:16 INFO - 'install', 05:45:16 INFO - 'run-tests'), 05:45:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:16 INFO - 'download_minidump_stackwalk': True, 05:45:16 INFO - 'download_symbols': 'ondemand', 05:45:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:16 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:16 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:16 INFO - 'installer_path': 'installer.exe', 05:45:16 INFO - 'log_level': 'info', 05:45:16 INFO - 'log_name': 'talos', 05:45:16 INFO - 'log_to_console': True, 05:45:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:45:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:45:16 INFO - 'opt_config_files': (), 05:45:16 INFO - 'pip_index': False, 05:45:16 INFO - 'sps_profile': False, 05:45:16 INFO - 'sps_profile_interval': 0, 05:45:16 INFO - 'suite': 'dromaeojs', 05:45:16 INFO - 'system_bits': '32', 05:45:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:16 INFO - 'title': 'talos-linux64-ix-008', 05:45:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:16 INFO - 'use_talos_json': True, 05:45:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:45:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:16 INFO - 'work_dir': 'build'} 05:45:16 INFO - ##### 05:45:16 INFO - ##### Running clobber step. 05:45:16 INFO - ##### 05:45:16 INFO - Running pre-action listener: _resource_record_pre_action 05:45:16 INFO - Running main action method: clobber 05:45:16 INFO - rmtree: /builds/slave/test-pgo/build 05:45:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:45:17 INFO - Running post-action listener: _resource_record_post_action 05:45:17 INFO - ##### 05:45:17 INFO - ##### Running read-buildbot-config step. 05:45:17 INFO - ##### 05:45:17 INFO - Running pre-action listener: _resource_record_pre_action 05:45:17 INFO - Running main action method: read_buildbot_config 05:45:17 INFO - Using buildbot properties: 05:45:17 INFO - { 05:45:17 INFO - "project": "", 05:45:17 INFO - "product": "firefox", 05:45:17 INFO - "script_repo_revision": "production", 05:45:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:45:17 INFO - "repository": "", 05:45:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:45:17 INFO - "buildid": "20160213030210", 05:45:17 INFO - "stage_platform": "linux64-pgo", 05:45:17 INFO - "basedir": "/builds/slave/test-pgo", 05:45:17 INFO - "nightly_build": "True", 05:45:17 INFO - "buildnumber": 191, 05:45:17 INFO - "slavename": "talos-linux64-ix-008", 05:45:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:45:17 INFO - "platform": "ubuntu64_hw", 05:45:17 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:45:17 INFO - "branch": "mozilla-central", 05:45:17 INFO - "repo_path": "mozilla-central", 05:45:17 INFO - "revision": "d719ac4bcbec13e0ba13a41547788e3bf365c679", 05:45:17 INFO - "pgo_build": "True", 05:45:17 INFO - "builduid": "894af2de5a0b424887525eea5079d9db", 05:45:17 INFO - "slavebuilddir": "test" 05:45:17 INFO - } 05:45:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:45:17 INFO - Running post-action listener: _resource_record_post_action 05:45:17 INFO - ##### 05:45:17 INFO - ##### Running download-and-extract step. 05:45:17 INFO - ##### 05:45:17 INFO - Running pre-action listener: _resource_record_pre_action 05:45:17 INFO - Running main action method: download_and_extract 05:45:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:17 INFO - https://queue.taskcluster.net/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:45:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/test_packages.json 05:45:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/test_packages.json 05:45:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:45:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:45:27 INFO - Downloaded 1448 bytes. 05:45:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:45:27 INFO - Using the following test package requirements: 05:45:27 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:27 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:45:27 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:45:27 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:27 INFO - u'jsshell-linux-x86_64.zip'], 05:45:27 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:45:27 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:27 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:45:27 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:45:27 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:45:27 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:27 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:45:27 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:27 INFO - https://queue.taskcluster.net/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:45:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:45:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/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 05:45:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/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 05:45:33 INFO - Downloaded 23296002 bytes. 05:45:33 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'] 05:45:33 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 05:45:34 INFO - Return code: 0 05:45:34 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 05:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:34 INFO - https://queue.taskcluster.net/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:45:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:45:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/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 05:45:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/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 05:45:36 INFO - Downloaded 23296002 bytes. 05:45:36 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'] 05:45:36 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 05:45:37 INFO - Return code: 0 05:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:37 INFO - https://queue.taskcluster.net/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:45:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/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 05:45:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/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 05:45:38 INFO - Downloaded 10706696 bytes. 05:45:38 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'] 05:45:38 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 05:45:38 INFO - Return code: 0 05:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:38 INFO - https://queue.taskcluster.net/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:45:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:45:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:45:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/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 05:45:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/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 05:45:40 INFO - Downloaded 56476010 bytes. 05:45:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:45:40 INFO - mkdir: /builds/slave/test-pgo/properties 05:45:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:45:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:45:40 INFO - Contents: 05:45:40 INFO - build_url:https://queue.taskcluster.net/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:45:41 INFO - Running post-action listener: _resource_record_post_action 05:45:41 INFO - Running post-action listener: set_extra_try_arguments 05:45:41 INFO - ##### 05:45:41 INFO - ##### Running populate-webroot step. 05:45:41 INFO - ##### 05:45:41 INFO - Running pre-action listener: _resource_record_pre_action 05:45:41 INFO - Running main action method: populate_webroot 05:45:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:41 INFO - '--tppagecycles', 05:45:41 INFO - '7'], 05:45:41 INFO - 'tests': ['tsvgm']}}, 05:45:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:45:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:45:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:45:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:45:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:45:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:41 INFO - 'talos_options': ['--e10s'], 05:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:41 INFO - 'tests': ['damp', 'tps']}, 05:45:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:41 INFO - 'talos_options': ['--e10s'], 05:45:41 INFO - 'tests': ['damp', 'tps']}, 05:45:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:45:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:41 INFO - 'other': {'tests': ['a11yr', 05:45:41 INFO - 'ts_paint', 05:45:41 INFO - 'tpaint', 05:45:41 INFO - 'sessionrestore', 05:45:41 INFO - 'sessionrestore_no_auto_restore']}, 05:45:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:45:41 INFO - 'tests': ['a11yr', 05:45:41 INFO - 'ts_paint', 05:45:41 INFO - 'tpaint', 05:45:41 INFO - 'sessionrestore', 05:45:41 INFO - 'sessionrestore_no_auto_restore']}, 05:45:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:45:41 INFO - 'tests': ['a11yr', 05:45:41 INFO - 'ts_paint', 05:45:41 INFO - 'tpaint', 05:45:41 INFO - 'sessionrestore', 05:45:41 INFO - 'sessionrestore_no_auto_restore']}, 05:45:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:45:41 INFO - 'tests': ['a11yr', 05:45:41 INFO - 'ts_paint', 05:45:41 INFO - 'tpaint', 05:45:41 INFO - 'sessionrestore', 05:45:41 INFO - 'sessionrestore_no_auto_restore']}, 05:45:41 INFO - 'other_l64': {'tests': ['a11yr', 05:45:41 INFO - 'ts_paint', 05:45:41 INFO - 'tpaint', 05:45:41 INFO - 'sessionrestore', 05:45:41 INFO - 'sessionrestore_no_auto_restore']}, 05:45:41 INFO - 'other_nol64': {'tests': ['a11yr', 05:45:41 INFO - 'ts_paint', 05:45:41 INFO - 'tpaint', 05:45:41 INFO - 'sessionrestore', 05:45:41 INFO - 'sessionrestore_no_auto_restore']}, 05:45:41 INFO - 'svgr': {'tests': ['tsvgx', 05:45:41 INFO - 'tsvgr_opacity', 05:45:41 INFO - 'tart', 05:45:41 INFO - 'tscrollx', 05:45:41 INFO - 'cart']}, 05:45:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:45:41 INFO - 'tests': ['tsvgx', 05:45:41 INFO - 'tsvgr_opacity', 05:45:41 INFO - 'tart', 05:45:41 INFO - 'tscrollx', 05:45:41 INFO - 'cart']}, 05:45:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:41 INFO - 'tests': ['tp5o']}, 05:45:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:41 INFO - 'talos_options': ['--e10s'], 05:45:41 INFO - 'tests': ['tp5o']}, 05:45:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:41 INFO - 'talos_options': ['--xperf_path', 05:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:41 INFO - 'tests': ['tp5n']}, 05:45:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:41 INFO - 'talos_options': ['--e10s', 05:45:41 INFO - '--xperf_path', 05:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:41 INFO - 'tests': ['tp5n']}}, 05:45:41 INFO - 'talos.zip': {'path': '', 05:45:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:41 INFO - Running post-action listener: _resource_record_post_action 05:45:41 INFO - ##### 05:45:41 INFO - ##### Running create-virtualenv step. 05:45:41 INFO - ##### 05:45:41 INFO - Running pre-action listener: _resource_record_pre_action 05:45:41 INFO - Running main action method: create_virtualenv 05:45:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:45:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:45:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:45:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:41 INFO - Using real prefix '/usr' 05:45:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:45:42 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:44 INFO - Installing pip.................done. 05:45:44 INFO - Return code: 0 05:45:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f276c9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cab8c0>, '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 0x2cac7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cacc50>, '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': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:45:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:45:44 INFO - Using env: {'DISPLAY': ':0', 05:45:44 INFO - 'HOME': '/home/cltbld', 05:45:44 INFO - 'LANG': 'en_US.UTF-8', 05:45:44 INFO - 'LANGUAGE': 'en_US:en', 05:45:44 INFO - 'LOGNAME': 'cltbld', 05:45:44 INFO - 'MAIL': '/var/mail/cltbld', 05:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:44 INFO - 'MOZ_NO_REMOTE': '1', 05:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:44 INFO - 'NO_EM_RESTART': '1', 05:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:44 INFO - 'SHELL': '/bin/bash', 05:45:44 INFO - 'SHLVL': '1', 05:45:44 INFO - 'TERM': 'linux', 05:45:44 INFO - 'TMOUT': '86400', 05:45:44 INFO - 'USER': 'cltbld', 05:45:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 05:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:44 INFO - '_': '/tools/buildbot/bin/python'} 05:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:45:44 INFO - Cleaning up... 05:45:44 INFO - Return code: 0 05:45:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f276c9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cab8c0>, '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 0x2cac7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cacc50>, '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': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:45:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:45:44 INFO - Using env: {'DISPLAY': ':0', 05:45:44 INFO - 'HOME': '/home/cltbld', 05:45:44 INFO - 'LANG': 'en_US.UTF-8', 05:45:44 INFO - 'LANGUAGE': 'en_US:en', 05:45:44 INFO - 'LOGNAME': 'cltbld', 05:45:44 INFO - 'MAIL': '/var/mail/cltbld', 05:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:44 INFO - 'MOZ_NO_REMOTE': '1', 05:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:44 INFO - 'NO_EM_RESTART': '1', 05:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:44 INFO - 'SHELL': '/bin/bash', 05:45:44 INFO - 'SHLVL': '1', 05:45:44 INFO - 'TERM': 'linux', 05:45:44 INFO - 'TMOUT': '86400', 05:45:44 INFO - 'USER': 'cltbld', 05:45:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 05:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:44 INFO - '_': '/tools/buildbot/bin/python'} 05:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:44 INFO - Downloading/unpacking psutil>=0.7.1 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:46 INFO - Installing collected packages: psutil 05:45:46 INFO - Running setup.py install for psutil 05:45:46 INFO - building 'psutil._psutil_linux' extension 05:45:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:45:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:45:46 INFO - building 'psutil._psutil_posix' extension 05:45:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:45:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:45:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:47 INFO - Successfully installed psutil 05:45:47 INFO - Cleaning up... 05:45:47 INFO - Return code: 0 05:45:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:45: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')]} 05:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f276c9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cab8c0>, '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 0x2cac7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cacc50>, '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': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:45:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:45:47 INFO - Using env: {'DISPLAY': ':0', 05:45:47 INFO - 'HOME': '/home/cltbld', 05:45:47 INFO - 'LANG': 'en_US.UTF-8', 05:45:47 INFO - 'LANGUAGE': 'en_US:en', 05:45:47 INFO - 'LOGNAME': 'cltbld', 05:45:47 INFO - 'MAIL': '/var/mail/cltbld', 05:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:47 INFO - 'MOZ_NO_REMOTE': '1', 05:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:47 INFO - 'NO_EM_RESTART': '1', 05:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:47 INFO - 'SHELL': '/bin/bash', 05:45:47 INFO - 'SHLVL': '1', 05:45:47 INFO - 'TERM': 'linux', 05:45:47 INFO - 'TMOUT': '86400', 05:45:47 INFO - 'USER': 'cltbld', 05:45:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 05:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:47 INFO - '_': '/tools/buildbot/bin/python'} 05:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:45:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:45:49 INFO - Installing collected packages: mozsystemmonitor 05:45:49 INFO - Running setup.py install for mozsystemmonitor 05:45:49 INFO - Successfully installed mozsystemmonitor 05:45:49 INFO - Cleaning up... 05:45:49 INFO - Return code: 0 05:45:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:45: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')]} 05:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f276c9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cab8c0>, '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 0x2cac7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cacc50>, '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': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:45:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:45:49 INFO - Using env: {'DISPLAY': ':0', 05:45:49 INFO - 'HOME': '/home/cltbld', 05:45:49 INFO - 'LANG': 'en_US.UTF-8', 05:45:49 INFO - 'LANGUAGE': 'en_US:en', 05:45:49 INFO - 'LOGNAME': 'cltbld', 05:45:49 INFO - 'MAIL': '/var/mail/cltbld', 05:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:49 INFO - 'MOZ_NO_REMOTE': '1', 05:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:49 INFO - 'NO_EM_RESTART': '1', 05:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:49 INFO - 'SHELL': '/bin/bash', 05:45:49 INFO - 'SHLVL': '1', 05:45:49 INFO - 'TERM': 'linux', 05:45:49 INFO - 'TMOUT': '86400', 05:45:49 INFO - 'USER': 'cltbld', 05:45:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 05:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:49 INFO - '_': '/tools/buildbot/bin/python'} 05:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:45:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:52 INFO - Downloading docopt-0.6.1.tar.gz 05:45:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:52 INFO - Running setup.py install for blobuploader 05:45:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:45:52 INFO - Running setup.py install for requests 05:45:52 INFO - Running setup.py install for docopt 05:45:52 INFO - Successfully installed blobuploader requests docopt 05:45:52 INFO - Cleaning up... 05:45:52 INFO - Return code: 0 05:45:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:52 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 0x7f276c9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cab8c0>, '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 0x2cac7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cacc50>, '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': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:45:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:52 INFO - Using env: {'DISPLAY': ':0', 05:45:52 INFO - 'HOME': '/home/cltbld', 05:45:52 INFO - 'LANG': 'en_US.UTF-8', 05:45:52 INFO - 'LANGUAGE': 'en_US:en', 05:45:52 INFO - 'LOGNAME': 'cltbld', 05:45:52 INFO - 'MAIL': '/var/mail/cltbld', 05:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:52 INFO - 'MOZ_NO_REMOTE': '1', 05:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:52 INFO - 'NO_EM_RESTART': '1', 05:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:52 INFO - 'SHELL': '/bin/bash', 05:45:52 INFO - 'SHLVL': '1', 05:45:52 INFO - 'TERM': 'linux', 05:45:52 INFO - 'TMOUT': '86400', 05:45:52 INFO - 'USER': 'cltbld', 05:45:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 05:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:52 INFO - '_': '/tools/buildbot/bin/python'} 05:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:52 INFO - Running setup.py (path:/tmp/pip-xzKIED-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:53 INFO - Running setup.py (path:/tmp/pip-zD_Ke3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:53 INFO - Running setup.py (path:/tmp/pip-aik7c6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:53 INFO - Running setup.py (path:/tmp/pip-2hOIOs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:53 INFO - Running setup.py (path:/tmp/pip-xyxJ98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:53 INFO - Running setup.py (path:/tmp/pip-L5hvHE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:53 INFO - Running setup.py (path:/tmp/pip-eIWAD8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:53 INFO - Running setup.py (path:/tmp/pip-fjCMvg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:53 INFO - Running setup.py (path:/tmp/pip-zSLOyZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:53 INFO - Running setup.py (path:/tmp/pip-onrv0p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:53 INFO - Running setup.py (path:/tmp/pip-Sg6SgS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:53 INFO - Running setup.py (path:/tmp/pip-R46zmS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:53 INFO - Running setup.py (path:/tmp/pip-NDn_Pt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:53 INFO - Running setup.py (path:/tmp/pip-kCWT9z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:53 INFO - Running setup.py (path:/tmp/pip-vQViYV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:54 INFO - Running setup.py (path:/tmp/pip-n9y8MF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:54 INFO - Running setup.py (path:/tmp/pip-Tc8aSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:54 INFO - Running setup.py install for manifestparser 05:45:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:45:54 INFO - Running setup.py install for mozcrash 05:45:54 INFO - Running setup.py install for mozdebug 05:45:54 INFO - Running setup.py install for mozdevice 05:45:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:45:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:45:54 INFO - Running setup.py install for mozfile 05:45:54 INFO - Running setup.py install for mozhttpd 05:45:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:45:54 INFO - Running setup.py install for mozinfo 05:45:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:45:54 INFO - Running setup.py install for mozInstall 05:45:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:45:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:45:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:45:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:45:54 INFO - Running setup.py install for mozleak 05:45:55 INFO - Running setup.py install for mozlog 05:45:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:45:55 INFO - Running setup.py install for moznetwork 05:45:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:45:55 INFO - Running setup.py install for mozprocess 05:45:55 INFO - Running setup.py install for mozprofile 05:45:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:45:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:45:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:45:55 INFO - Running setup.py install for mozrunner 05:45:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:45:55 INFO - Running setup.py install for mozscreenshot 05:45:55 INFO - Running setup.py install for moztest 05:45:55 INFO - Running setup.py install for mozversion 05:45:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:45:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:56 INFO - Cleaning up... 05:45:56 INFO - Return code: 0 05:45:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f276c9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cab8c0>, '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 0x2cac7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cacc50>, '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': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:45:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:56 INFO - Using env: {'DISPLAY': ':0', 05:45:56 INFO - 'HOME': '/home/cltbld', 05:45:56 INFO - 'LANG': 'en_US.UTF-8', 05:45:56 INFO - 'LANGUAGE': 'en_US:en', 05:45:56 INFO - 'LOGNAME': 'cltbld', 05:45:56 INFO - 'MAIL': '/var/mail/cltbld', 05:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:56 INFO - 'MOZ_NO_REMOTE': '1', 05:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:56 INFO - 'NO_EM_RESTART': '1', 05:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:56 INFO - 'SHELL': '/bin/bash', 05:45:56 INFO - 'SHLVL': '1', 05:45:56 INFO - 'TERM': 'linux', 05:45:56 INFO - 'TMOUT': '86400', 05:45:56 INFO - 'USER': 'cltbld', 05:45:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 05:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:56 INFO - '_': '/tools/buildbot/bin/python'} 05:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:56 INFO - Running setup.py (path:/tmp/pip-kgmMLJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:56 INFO - Running setup.py (path:/tmp/pip-DY7rZy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:56 INFO - Running setup.py (path:/tmp/pip-i5o5KB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:56 INFO - Running setup.py (path:/tmp/pip-_4AbSL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:56 INFO - Running setup.py (path:/tmp/pip-YG6Z8c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:56 INFO - Running setup.py (path:/tmp/pip-Tpq0gs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:56 INFO - Running setup.py (path:/tmp/pip-iypFmf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:56 INFO - Running setup.py (path:/tmp/pip-VnBIr9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:56 INFO - Running setup.py (path:/tmp/pip-ACqWQM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:56 INFO - Running setup.py (path:/tmp/pip-ZSGJU0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:56 INFO - Running setup.py (path:/tmp/pip-WoAoto-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:57 INFO - Running setup.py (path:/tmp/pip-1fOMLt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:57 INFO - Running setup.py (path:/tmp/pip-159vIK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:57 INFO - Running setup.py (path:/tmp/pip-B8oPym-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:57 INFO - Running setup.py (path:/tmp/pip-vHshXh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:57 INFO - Running setup.py (path:/tmp/pip-pHljmL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:57 INFO - Running setup.py (path:/tmp/pip-AoNgl4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:59 INFO - Downloading blessings-1.6.tar.gz 05:45:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:59 INFO - Installing collected packages: blessings 05:45:59 INFO - Running setup.py install for blessings 05:45:59 INFO - Successfully installed blessings 05:45:59 INFO - Cleaning up... 05:45:59 INFO - Return code: 0 05:45:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:45:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:59 INFO - Reading from file tmpfile_stdout 05:45:59 INFO - Current package versions: 05:45:59 INFO - argparse == 1.2.1 05:45:59 INFO - blessings == 1.6 05:45:59 INFO - blobuploader == 1.2.4 05:45:59 INFO - docopt == 0.6.1 05:45:59 INFO - manifestparser == 1.1 05:45:59 INFO - mozInstall == 1.12 05:45:59 INFO - mozcrash == 0.16 05:45:59 INFO - mozdebug == 0.1 05:45:59 INFO - mozdevice == 0.48 05:45:59 INFO - mozfile == 1.2 05:45:59 INFO - mozhttpd == 0.7 05:45:59 INFO - mozinfo == 0.9 05:45:59 INFO - mozleak == 0.1 05:45:59 INFO - mozlog == 3.1 05:45:59 INFO - moznetwork == 0.27 05:45:59 INFO - mozprocess == 0.22 05:45:59 INFO - mozprofile == 0.28 05:45:59 INFO - mozrunner == 6.11 05:45:59 INFO - mozscreenshot == 0.1 05:45:59 INFO - mozsystemmonitor == 0.0 05:45:59 INFO - moztest == 0.7 05:45:59 INFO - mozversion == 1.4 05:45:59 INFO - psutil == 3.1.1 05:45:59 INFO - requests == 1.2.3 05:45:59 INFO - wsgiref == 0.1.2 05:45:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 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 0x7f276c9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cab8c0>, '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 0x2cac7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cacc50>, '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': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:45:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:59 INFO - Using env: {'DISPLAY': ':0', 05:45:59 INFO - 'HOME': '/home/cltbld', 05:45:59 INFO - 'LANG': 'en_US.UTF-8', 05:45:59 INFO - 'LANGUAGE': 'en_US:en', 05:45:59 INFO - 'LOGNAME': 'cltbld', 05:45:59 INFO - 'MAIL': '/var/mail/cltbld', 05:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:59 INFO - 'MOZ_NO_REMOTE': '1', 05:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:59 INFO - 'NO_EM_RESTART': '1', 05:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:59 INFO - 'SHELL': '/bin/bash', 05:45:59 INFO - 'SHLVL': '1', 05:45:59 INFO - 'TERM': 'linux', 05:45:59 INFO - 'TMOUT': '86400', 05:45:59 INFO - 'USER': 'cltbld', 05:45:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 05:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:59 INFO - '_': '/tools/buildbot/bin/python'} 05:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:59 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)) 05:45:59 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)) 05:45:59 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)) 05:45:59 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)) 05:45:59 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)) 05:45:59 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)) 05:45:59 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)) 05:45:59 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)) 05:45:59 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)) 05:45:59 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)) 05:45:59 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)) 05:45:59 INFO - Cleaning up... 05:45:59 INFO - Return code: 0 05:45:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:59 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 0x7f276c9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cab8c0>, '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 0x2cac7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cacc50>, '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': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:45:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:45:59 INFO - Using env: {'DISPLAY': ':0', 05:45:59 INFO - 'HOME': '/home/cltbld', 05:45:59 INFO - 'LANG': 'en_US.UTF-8', 05:45:59 INFO - 'LANGUAGE': 'en_US:en', 05:45:59 INFO - 'LOGNAME': 'cltbld', 05:45:59 INFO - 'MAIL': '/var/mail/cltbld', 05:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:59 INFO - 'MOZ_NO_REMOTE': '1', 05:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:59 INFO - 'NO_EM_RESTART': '1', 05:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:59 INFO - 'SHELL': '/bin/bash', 05:45:59 INFO - 'SHLVL': '1', 05:45:59 INFO - 'TERM': 'linux', 05:45:59 INFO - 'TMOUT': '86400', 05:45:59 INFO - 'USER': 'cltbld', 05:45:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 05:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:59 INFO - '_': '/tools/buildbot/bin/python'} 05:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:00 INFO - Downloading/unpacking jsonschema 05:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:01 INFO - Downloading/unpacking functools32 (from jsonschema) 05:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:02 INFO - warning: no files found matching '*.txt' 05:46:02 INFO - no previously-included directories found matching 'build' 05:46:02 INFO - no previously-included directories found matching 'dist' 05:46:02 INFO - no previously-included directories found matching '.git*' 05:46:02 INFO - Installing collected packages: jsonschema, functools32 05:46:02 INFO - Running setup.py install for functools32 05:46:02 INFO - warning: no files found matching '*.txt' 05:46:02 INFO - no previously-included directories found matching 'build' 05:46:02 INFO - no previously-included directories found matching 'dist' 05:46:02 INFO - no previously-included directories found matching '.git*' 05:46:02 INFO - Successfully installed jsonschema functools32 05:46:02 INFO - Cleaning up... 05:46:02 INFO - Return code: 0 05:46:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f276c9acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cab8c0>, '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 0x2cac7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cacc50>, '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': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:46:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:46:02 INFO - Using env: {'DISPLAY': ':0', 05:46:02 INFO - 'HOME': '/home/cltbld', 05:46:02 INFO - 'LANG': 'en_US.UTF-8', 05:46:02 INFO - 'LANGUAGE': 'en_US:en', 05:46:02 INFO - 'LOGNAME': 'cltbld', 05:46:02 INFO - 'MAIL': '/var/mail/cltbld', 05:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:02 INFO - 'MOZ_NO_REMOTE': '1', 05:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:02 INFO - 'NO_EM_RESTART': '1', 05:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:02 INFO - 'SHELL': '/bin/bash', 05:46:02 INFO - 'SHLVL': '1', 05:46:02 INFO - 'TERM': 'linux', 05:46:02 INFO - 'TMOUT': '86400', 05:46:02 INFO - 'USER': 'cltbld', 05:46:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 05:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:02 INFO - '_': '/tools/buildbot/bin/python'} 05:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:02 INFO - Downloading/unpacking flake8 05:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:46:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:46:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:46:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:05 INFO - no previously-included directories found matching 'docs/_build' 05:46:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:46:05 INFO - Running setup.py install for pep8 05:46:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:05 INFO - no previously-included directories found matching 'docs/_build' 05:46:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:46:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:46:05 INFO - Cleaning up... 05:46:05 INFO - Return code: 0 05:46:05 INFO - Running post-action listener: _resource_record_post_action 05:46:05 INFO - Running post-action listener: _start_resource_monitoring 05:46:05 INFO - Starting resource monitoring. 05:46:05 INFO - ##### 05:46:05 INFO - ##### Running install step. 05:46:05 INFO - ##### 05:46:05 INFO - Running pre-action listener: _resource_record_pre_action 05:46:05 INFO - Running main action method: install 05:46:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:46:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:46:05 INFO - Reading from file tmpfile_stdout 05:46:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:46:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:46:05 INFO - Reading from file tmpfile_stdout 05:46:05 INFO - Output received: 05:46:05 INFO - Usage: mozinstall [options] installer 05:46:05 INFO - Options: 05:46:05 INFO - -h, --help show this help message and exit 05:46:05 INFO - -d DEST, --destination=DEST 05:46:05 INFO - Directory to install application into. [default: 05:46:05 INFO - "/builds/slave/test-pgo"] 05:46:05 INFO - --app=APP Application being installed. [default: firefox] 05:46:05 INFO - mkdir: /builds/slave/test-pgo/build/application 05:46:05 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'] 05:46:05 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 05:46:21 INFO - Reading from file tmpfile_stdout 05:46:21 INFO - Output received: 05:46:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:46:21 INFO - Running post-action listener: _resource_record_post_action 05:46:21 INFO - ##### 05:46:21 INFO - ##### Running run-tests step. 05:46:21 INFO - ##### 05:46:21 INFO - Running pre-action listener: _resource_record_pre_action 05:46:21 INFO - Running main action method: run_tests 05:46:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:46:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:46:21 INFO - Python 2.7.3 05:46:21 INFO - Return code: 0 05:46:21 INFO - grabbing minidump binary from tooltool 05:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:21 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 0x2cab8c0>, '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 0x2cac7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cacc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:46:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:46:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:46:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:21 INFO - Return code: 0 05:46:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:46:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:46:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:46:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:46:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:46:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:46:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:46:22 INFO - Return code: 0 05:46:22 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/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 05:46:22 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/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 05:46:22 INFO - Using env: {'DISPLAY': ':0', 05:46:22 INFO - 'HOME': '/home/cltbld', 05:46:22 INFO - 'LANG': 'en_US.UTF-8', 05:46:22 INFO - 'LANGUAGE': 'en_US:en', 05:46:22 INFO - 'LOGNAME': 'cltbld', 05:46:22 INFO - 'MAIL': '/var/mail/cltbld', 05:46:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:46:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:22 INFO - 'MOZ_NO_REMOTE': '1', 05:46:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:22 INFO - 'NO_EM_RESTART': '1', 05:46:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:46:22 INFO - 'SHELL': '/bin/bash', 05:46:22 INFO - 'SHLVL': '1', 05:46:22 INFO - 'TERM': 'linux', 05:46:22 INFO - 'TMOUT': '86400', 05:46:22 INFO - 'USER': 'cltbld', 05:46:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202', 05:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:22 INFO - '_': '/tools/buildbot/bin/python'} 05:46:22 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/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 05:46:23 INFO - mozversion application_buildid: 20160213030210 05:46:23 INFO - mozversion application_changeset: d719ac4bcbec13e0ba13a41547788e3bf365c679 05:46:23 INFO - mozversion application_display_name: Nightly 05:46:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:23 INFO - mozversion application_name: Firefox 05:46:23 INFO - mozversion application_remotingname: firefox 05:46:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:23 INFO - mozversion application_vendor: Mozilla 05:46:23 INFO - mozversion application_version: 47.0a1 05:46:23 INFO - mozversion platform_buildid: 20160213030210 05:46:23 INFO - mozversion platform_changeset: d719ac4bcbec13e0ba13a41547788e3bf365c679 05:46:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:23 INFO - mozversion platform_version: 47.0a1 05:46:23 INFO - using testdate: 1455371183 05:46:23 INFO - actual date: 1455371183 05:46:23 INFO - starting webserver on 'localhost:47667' 05:46:23 INFO - SUITE-START | Running 2 tests 05:46:23 INFO - TEST-START | dromaeo_css 05:46:23 INFO - operating with platform_type : linux_ 05:46:23 INFO - Initialising browser for dromaeo_css test... 05:46:23 INFO - TEST-INFO | started process 21091 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphhquUm/profile http://localhost:47667/getInfo.html) 05:46:27 INFO - PROCESS | 21091 | __metrics Screen width/height:1600/1200 05:46:27 INFO - PROCESS | 21091 | colorDepth:24 05:46:27 INFO - PROCESS | 21091 | Browser inner width/height: 1024/697 05:46:27 INFO - PROCESS | 21091 | __metrics 05:46:27 INFO - PROCESS | 21091 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:46:28 INFO - TEST-INFO | 21091: exit 0 05:46:28 INFO - Browser initialized. 05:46:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:28 INFO - TEST-INFO | started process 21182 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphhquUm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:40 INFO - PROCESS | 21182 | RSS: Main: 153800704 05:46:40 INFO - PROCESS | 21182 | 05:47:31 INFO - PROCESS | 21182 | 1455371251906 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] 05:49:40 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:47667/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47667/tests/dromaeo/cssquery-ext.html) 05:49:41 INFO - PROCESS | 21182 | RSS: Main: 250245120 05:49:41 INFO - PROCESS | 21182 | 05:52:43 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:47667/tests/dromaeo/cssquery-ext.html (next: http://localhost:47667/tests/dromaeo/cssquery-jquery.html) 05:52:44 INFO - PROCESS | 21182 | RSS: Main: 239841280 05:52:44 INFO - PROCESS | 21182 | 05:55:46 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:47667/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47667/tests/dromaeo/cssquery-mootools.html) 05:55:46 INFO - PROCESS | 21182 | RSS: Main: 230326272 05:55:46 INFO - PROCESS | 21182 | 05:58:48 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:47667/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47667/tests/dromaeo/cssquery-prototype.html) 05:58:49 INFO - PROCESS | 21182 | RSS: Main: 217669632 05:58:49 INFO - PROCESS | 21182 | 06:01:51 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:47667/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47667/tests/dromaeo/cssquery-yui.html) 06:01:52 INFO - PROCESS | 21182 | RSS: Main: 218271744 06:01:52 INFO - PROCESS | 21182 | 06:04:55 INFO - PROCESS | 21182 | Cycle 1(1): loaded http://localhost:47667/tests/dromaeo/cssquery-yui.html (next: http://localhost:47667/tests/dromaeo/cssquery-dojo.html) 06:04:55 INFO - PROCESS | 21182 | RSS: Main: 291950592 06:04:55 INFO - PROCESS | 21182 | 06:04:55 INFO - PROCESS | 21182 | __start_tp_report 06:04:55 INFO - PROCESS | 21182 | _x_x_mozilla_page_load 06:04:55 INFO - PROCESS | 21182 | _x_x_mozilla_page_load_details 06:04:55 INFO - PROCESS | 21182 | |i|pagename|runs| 06:04:55 INFO - PROCESS | 21182 | |0;dojo.html;3129.859156337965;3199.13623321703;3234.514822776585;3246.1397729601645;3273.2307907641707;5167.431582525919;5184.1705327147665;5228.058949389113;5297.761600727967;5307.601929855257;5148.871278218037;5263.34208223972;5275.050490911634;5285.471452854713;5310.522053015228;4702.24764037754;4775.617950563964;4790.041991601676;4842.66101372904;4948.307236986807;4709.5055019223;4894.363732714742;4901.607871370282;4904.4114706235305;4926;4767.284907263921;4800.039992001613;4812.518748125194;4829.975850120762;4834.468208497063;4784.114938736345;4787.712737235777;4795.472498025214;4800.1119792838435;4838.6854854434705;4749.026449577863;4756.143894099096;4782.784774685148;4794.760261986921;4819.6867203631655;4958.429780575208;5036.622253331015;5055.545000949932;5066.518680725325;5087.720175390352;5600.103983362643;5628.43715628438;5647.632903861236;5658.377578466366;5704.686242256675;5573.777048918038;5595.468430499137;5596.776128954837;5601.187827764951;5606.383297837235;5193.870153246161;5211.706848986434;5246.527812496855;5260.500252476047;5294.867628309285;5775.971120144456;5785.652860828363;5786.334571524329;5794.478496935211;5821.15593238978;5514.6691198528215;5569.415211402826;5574.86062848432;5574.888502229933;5575.637583557056;5401.054815407288;5485.588580856452;5556.944430555724;5661.631993920464;5679.858003549862;5583.664980101207;5613.943860561342;5614.989301925611;5618.606697531133;5626.690532020778;5626.831195064155;5628.127640215773;5630;5630.465105814941;5636.408177141423;4279.16556271524;4338.696291259645;4346.087321662486;4347.369631403429;4348.065165989327;3899.629535194152;3908.5895980922164;3923.352646813301;3949.407588861636;3952.545457272393;5263.26314315996;5288;5299.867503312371;5304.628675992721;5333.359996800331;5532.834014979557;5623.156526521055;5630.71846407678;5631.7747290108755;5633.971830140823;5126.8974620508125;5153.175491921274;5213.426523082458;5225.399079105951;5236.842894713165;4828.46886842447;4836.177849765549;4874.268859671007;4875.95124048762;4889.731064791471;5894.498967587803;5919.67441790697;5935.139404786281;5936;5938.317093534299;5586.664800112007;5654.06707893193;5705.857353566277;5717.37108918027;5724.4561766632105;5689.857753556194;5891.23413956183;5896.55775816824;5935.851603709769;5981.521478281814;5528.9723551381985;5565.860853478695;5569.331680198402;5571.60998730085;5574.303212098488;5582.525485333792;5646.463585959492;5660.943390566042;5669.376368599368;5698.430156984268;5476.397596264487;5522.2544956430365;5528.585356098229;5532.30846144232;5575.776968921197;5446.482584154499;5477.945220547903;5478.369987451494;5480.26016487785;5480.91778623313;5346.385165705838;5357.758900849549;5390.730463476889;5423.891522169613;5432.103702889137;5460.863478413072;5469.644473109235;5489.698066606215;5522.447755224445;5560.666360018412;5351.518363347317;5390.056740070394;5390.676559406448;5397.406285308692;5409.513143817076 06:04:55 INFO - PROCESS | 21182 | |1;ext.html;480.27238733319007;505.3581950922326;521.846055413653;533.6371267538075;552.4309960740437;28638.85680571597;29005.129846104624;29021.70978290219;36686.61537000093;37089;39320;39988.20023599526;40048.39927401084;40110.598894011055;40147.79926100365;8447.028591711955;8669.046404895456;8674.306055515575;8676.739697809076;8677.956610216972;8407.831843363128;8553.828923421528;8569.100244474334;8573.871391929126;8580.785480362978;8753.299736021103;8835.381523293372;8847.867281990775;8848.380613357067;8848.646054157825;8706.129387061306;8729.127087291283;8746.781330466725;8774.780630484192;8787.64849406023;8670.13298670128;8719.651213951434;8809.823803523957;8830.205281524693;8831.55842207887;39248;39743;39819.203615927516;39833.40249896254;39858.40212396816;3228.886988955399;3269.623993240784;3324.833758312099;3496.8426420811124;3828.1960788234505;26818.195454136407;27475.725242747518;27484.862575687195;27497.45005099907;27498;3435.4503279475166;3504.3692135415613;3652.626167337986;3714.832832522543;3715.8327875245677;263702;267252;267785;268018.6599067012;269003;58774.11838822421;60076.39923600796;60491.39508604858;60759.6962015196;61034;63830.36169638337;64117.35882641207;64178.67910660417;64265;64471.677641611495;16749.24628391725;16869.32522699103;16886.15569221534;16933.322667093424;16966.745498817527;12833.294168820617;12842.422091005927;12921.160124591872;12922.224666520038;12929.935350323376;19812;20390.69413958792;20593.58812823765;20608.793912060988;20661.483462913548;7854.646540905673;7871.960640196762;7878.172791856887;7937.920620793833;8009.919900801034;820.323233332503;916.3585490156917;927.1099744245465;977.8973207813077;1034.2605037398296;24352.391190220387;24900.875495622407;24955.126570570304;25013.249602511954;25029;900.0999000999001;900.6142776730919;908;1039.9168066554657;1144.4678224625422;14314;14644.063742637554;15034.849651503564;15113.697726045417;15175.772363414557;377575;381814;382354;383197;383798;47267.29099063517;52785.47214527882;53245.733771330895;53442;53981.73009135008;1320.3332317179763;1342.2080972226433;1342.9798553021712;1356.0575400097034;1359.3475131936725;26197.869010654824;26670.466590668468;28196.718032819408;28374.716252838032;28817.42365152727;43751.56248437602;44535.777321113186;44610.107797843215;44611.10777784491;44629.10741785211;285649;286895;286932;287813;288291;26801.597976030764;30921.690783091883;31252.843735782084;31288.843555782074;31710.68289317077;36468.635313646526;36482.63517364793;36933.26133477369;37250;37395;31437.685623143476;31628.367432650757;31849.8407507961;32124.19689507781;32138.19654508656;31660.841695791372;31741.365172695954;32150.678493214768;32390.838045810564;32644.020679379657;33274.168145796546;33434.66565334315;33549.83225083859;33608.1597960053;33682.49476257809;29088;30371.2407189822;30880.536791948587;30943;30945.535816962314;23714;23782.40543986345;23861.164859229844;23877.403064923517;24066.51866962616 06:04:55 INFO - PROCESS | 21182 | |2;jquery.html;351.26059644448435;358.7399135626669;361.2179631098671;365.3861512658733;365.8225760506155;13641.863581364183;13887.375068121934;16246.268917898693;17004.74492882606;17527.561810954732;14526.491572794954;15758.84241157588;16140.515784526482;16257.349706011775;16294;5314.335708036505;5446.891062178754;5483.424240454755;5494.835154945358;5497.890042199174;3984.2629113614075;5420.403755586883;5522.3649280332675;5872.383399743008;6122.571420000601;5911.674857882815;6042.244719410074;6085.604435711687;6097.298810636789;6107.083937409379;6058.242719660043;6075.817725468243;6075.939240607626;6114.2968558615885;6197.907031394533;5220.425753167148;5320.042392369372;5334.386545547273;5345.572354211693;5370.140777475585;19785.703214451652;20281.79718202814;20397.490062748402;20567.280145194996;20604.072816723285;2139.0801955159277;2183.836212284085;2325.081592770863;2570.665813444259;2656.654634897451;12685.556005539762;12965.481380744759;13041.217526948414;13445.19328840263;13601.795973060413;1826.2329821475012;1829.1585870499453;1852.685043542601;1887.5186827359073;1932;56931.71534142344;58496.70751646257;59151.70424147852;60015.69992150055;60155.699221503615;9617.56720947559;9699.127078562964;10170.694879153638;10339.431331276852;10396;13357.065005449525;13413.32933353348;13484.932575337061;13486.258255795829;13499.122557033761;7780.416468764865;7801.53190808542;7873.645685944146;7935.444518883738;7942.324902383247;7715.344195743312;7744.303012728881;7754.806129846799;7799.883001754978;7820.257075577811;4111.444954931106;4469.553044695569;4498.6626003049905;4504.797284122223;4535.705179163344;1778.2264714849082;1822.4714832698635;1835.6879330513846;1839.1264149528868;1856.5729882127187;940.6765289734345;952.0574631115285;952.8523078922778;1027.4913917610832;1038.055369613663;15444.45944391941;16645.916770416312;16663.3334666612;16726.74909876353;16874.071926044184;957.1098878043347;964.0841200859212;973.3186769261546;975.9707208783748;987.7056894621577;8112.22933821286;8720.520371379635;8801.723750056206;9249.861252081224;9792.706218813448;522945;531044.7805766662;539856;543593;548760;70146;71899;72366;72821.6358918202;73658.63170684113;1173.266708307308;1174.9941250293864;1219.1405059433077;1222.883826036525;1235.110720281396;13839.169649821042;14404.279786010868;15260.389584416944;15572.84427155714;15617.531474055797;31323.84338078295;31753.68246317507;31857.681423185473;32080;32323.838380807945;39558.80220598994;40248.798756006036;40303;41113.38329925113;44169.33745993877;7378.926210738038;7467.253274672489;7539.660715267716;7638.197989211053;7680.846383072419;7760.943350012364;9841.60633574649;10324.380537167794;10778.838317425401;11506.367149806842;9569.90430095718;9783.315167938461;9813.460259685786;10065.396076235449;10243.07812296897;3028.2732144284773;7200.479371666568;9846.359986601135;9883.406995580288;9892.406455612687;6960.617166055916;7143.928260804516;7268.0914885639295;9758.268129890144;9875.209983201183;7315.524490908074;7336.082989626297;7347.228541003332;7447.143578488543;7469.514481558681;6364.586301890362;9489.810203796023;9596;9596.808063838544;10206.846897296695 06:04:55 INFO - PROCESS | 21182 | |3;mootools.html;1391.3877893726765;1495.5064828606558;1518.2105305241275;1686.1569215392303;1862.0224382199335;7133.251008644089;7897.131315555284;8039.035315762117;8043.195680431954;8048;7719.459637825355;7868.92131078689;7870.409719271063;7894.881576776339;7897.091834439027;1989.910454029572;2249.8200143988524;2310.4685922237895;2318.0611852199886;2340.134150364359;2331.7901388875;2339.3917581428864;2340.777626125524;2343.5781559319403;2344.6951896253463;2239.787220214077;2318.976810231893;2319.1766922742436;2323.1984965186984;2324.360800779782;2255.6954811100454;2279.0314116500504;2323.512062466884;2326.011445135827;2327.9301620951314;2278.7607301233297;2288.5880541502524;2293.896774645145;2319.211468100854;2372;8199.139090395542;8261.297789687884;8277.751667449986;8294.543800090993;8294.709685160991;4710.222813235812;4791.065742180276;4793.784279707422;4796.112719146969;4811.494793046715;2945.9263518412;2987.1635941936293;3029.5758593796886;3031.1209749172713;3041.194083567856;922.6724512797995;933.8272419602396;938.737153596994;961.7691753979065;982.4694664880956;10639.734006649818;10645.20160987929;10696.304740191941;10701.464926753632;10728.678139655824;4274.166537525215;4327.350897365357;4332.436783218224;4436.0462500562535;4472.351509031172;9143.954280228556;9145.81708365829;9159.084091590788;9175;9175.403598766059;4890.755462226874;4899.4365647950945;4903.338049363361;4904.092742842514;4910;4474.709143905701;4481.395011673448;4485.035717320791;4492.05666809967;4493.640508759291;3513.2973405318526;3783.508143941325;3820.3887378019385;3852.345101332724;3852.691784657277;1223.7246619510538;1245.9439325230387;1252.6242127361754;1262.9684257893443;1265.6709255593612;1346;1355.0920883008407;1356.504875720355;1363.6113707593288;1403.017887478769;7298.56208627484;7537.133229678548;7557.924420755722;7567.31894129531;7727.343175830118;1154.9316881884392;1156.5836298932377;1159.2406973432414;1167.6672148437824;1189.4052973513244;5529.834104976857;5588.30146231721;5602.887942241132;5605.495505404451;5623.493885550321;9134.223590994707;9134.543272836332;9190.90809091914;9274.304427167854;9312.627494900127;9364.484953327632;9499.38254013487;9503.382280151767;9512.524373781283;9577.281703872099;7294.416446684252;7464.477486575996;7510.4742668013805;7526.24737526243;7527.9247207528315;7027.472939529658;7083.7520686775715;7097.25478824716;7123.430125589836;7126.643667816485;8312.210340017931;8365.163483651586;8467.449615774955;8667.609957551798;8669.869951950599;8574.52840093776;8740.344474164336;8746.037935827182;8752.562371881508;8761.518116503654;6262.68686565679;6856.9314306856295;6890.931090689029;6951;6954.513184077066;6931.306869313028;6940.41006514452;6958.686859091455;7492.51298665585;7629.694812207449;7010.158780946319;7165.820854478679;7232.168300645282;7234.276572342724;7373.115226172894;7094.64526773649;7164.534305270141;7172.318629730167;7260.600666963368;7273.3817625500305;7190.856182876418;7240.8913866290995;7248.275172482709;7309.086364204474;7333.633318333956;6562.967185164043;6590.670466476753;6591.274959754327;6602.504812139013;6628.27089020217;6826.385625293748;6835.624040677811;6853.4859885507785;6873.656317184221;6921.515493915377 06:04:55 INFO - PROCESS | 21182 | |4;prototype.html;301.37314386076963;304.5538286410409;328.13863608028925;334.64026171865237;336.63811402742056;5781.971090144549;5834.21238132852;5836.6789826559525;5843.2695913010875;5862.501687356569;5726.541876649869;5795.130730390443;5796.333421656511;5818.098194779805;5820.505257053155;4342.956570434287;4476.932846007297;4477.888052798674;4558.361829343895;4559.7948092335755;4417.801198946039;4464.821407143727;4496.505384407713;4553.795079221426;4598;4497.7526236057;4504.662150338721;4505.594496495315;4519.367288579601;4528.8867778305475;4285.057287396768;4384.167008268419;4503.504614492404;4522.163399771053;4524.389207456984;3999.8000099995174;4013.8595149169932;4016.6585840203616;4022.7184097113213;4030.3551431770775;5545.168224766277;5554;5559.499645031926;5562.610617256793;5580.190872323531;5251;5257.605679574047;5262.05283049051;5262.710550919698;5264.578833693296;6052.833040037397;6107.969460152671;6142.416470435302;6159.568830181889;6163.506919446433;4441.267190913495;4441.644668426518;4446.088551846864;4449.443819522559;4454.13144436835;6427.871442571122;6429.099926010363;6429.099926010409;6430.742770289183;6438.452731517827;4523.615492683159;4548.545145485491;4551;4555.088982203506;4555.430571178603;4504.256797628354;4603.194440972817;4606.078784243165;4616.330632058332;4641.6286697064825;5237.476252374732;5250.65870718402;5255.369355677343;5258.631895767259;5258.789648414097;6176.845578860564;6205.131281620576;6209.130721698965;6212.9068063979075;6217.875642487215;1598.6003499125218;1613.798275215598;1615.450746746112;1615.9676806463806;1620.3761551802404;1097.5116073347283;1104.0615476844778;1109.5672687651822;1109.672646569264;1131.0273165078027;5853.326867410217;5855.502282306052;5857.47282744555;5862.296524417097;5866.73599688015;6326.905096423558;6352.396522330371;6364.07720880479;6372.044193370939;6380.361963803675;5855.560832937546;5855.912161317584;5862.912056319074;5863.882722345529;5871.6183448075735;3314.801111933292;3354.0943945135164;3366.2762506061313;3403.387390269775;3434.1586311353876;6724.9327506725285;6737.326267373223;6759.695813688396;6771.085903403076;6779.389854912983;6480.902786458207;6559.770408035696;6569.113169722122;6571.868562628721;6575.506836987245;6472.967635161888;6647.734090636417;6655.86688266232;6703.564268322641;6710.328967103251;6417.422431981144;6428.067930150196;6436.16329877113;6440.710168042543;6442.291347951628;6304.684765761602;6362.713677884413;6371.745130194926;6373.776917807854;6375.139356187041;6492.870142597028;6661.700223489857;6668.933310666831;6689.197296324278;6705.094812200486;4412.580804823537;4445.555444455528;4454.977725111354;4455.465344158722;4462.598366147063;6391.456726178327;6426.260979987362;6430.164078669743;6431.196100487439;6438.420542151229;6009.06859436788;6163.291221509405;6226.906596400967;6234.376562343729;6243.283097148321;6216.191895053614;6217.595856269328;6228.4705800005695;6231.906521402273;6234.314225435289;6119.143319935123;6119.2350956130485;6121.3572574879;6122.602030867979;6150.692465376624;6056.394360563909;6218;6238.563300569098;6246.125542424155;6256.937430625818;6087.908681369871;6114.694265286629;6138.785142520169;6147.877042459215;6150 06:04:55 INFO - PROCESS | 21182 | |5;yui.html;712.9786106416809;778.5017588743209;813.6054013803305;814.214283216696;828.7223780033688;13153.868461315384;13297.069205155618;13335.199888006715;13425.932870335648;13610.387532561033;12151.96708279795;12264.448099835528;12277.386130693452;12278.938605306983;12295.754084918297;677.1941389746211;829.0714399872137;849.2399302624148;850.2517784349764;851.0043249398219;704.4681265644457;790.608648718885;849.218718778722;849.9065102838683;851.0298259983624;873.9388242823005;885.2608072259671;885.3802338363139;886.3751055505885;886.3751055505885;712.9643517824088;870.5777697816554;882.9470231786113;884.3279107877995;891.1222445890793;653.3956090616208;657.1457105762489;657.4608820766973;657.6678777217522;657.9703913323864;12793.744125117539;12841.1011229214;12843.422046007952;12853.87146128536;12865.67835804103;11867.703307417298;12626.368681565886;12703.936480317632;12854.153650869215;13488.325583720774;9980.97439013454;9983;10029.247806414549;10044.246681498917;10107.89892101077;3031.6513600935955;3078.5536097265995;3103.115612050555;3105.239216391976;3120.719135277813;46021;46440.76779616114;47650.285245721345;48012.279815802794;48015;10207.285490015776;10302.948485257526;10450.268481206243;10608.098311643596;10654;18935.33726319572;19036.71444928327;19047.047647617565;19060;19101.522461938563;7200.711971521186;7498.362639175732;7577.204393538709;7584.772456826304;7723.150453450116;4052.4124002019544;4099.528554216304;4117.279476091672;4119.423280740639;4134.069834287261;3164.699353561408;3197.568328275653;3199.9680003200137;3202.3595280943905;3203.3913556424204;565.6351653183674;573.1545969694668;581.4621475135483;586.3257254157753;593.2376895689019;548.9268480121353;596.9910850662367;630.8895943210011;644.9484041276687;713.0979311171373;8103.756887293391;8146.674133034612;8209.425340226246;8280.80571076342;8465.195806398382;567.2540609099021;606.6329870428416;621.7948077134535;650.1190886349024;673.8719643267764;3884.4367566703236;3906.74606150605;3911.7532448068037;4016.4094159267693;4043.7775922324554;56680;57204.71397642985;57313.713431432574;61537;62176.68911655503;49359.50640493549;49605.751971239915;50838.74580627073;51065.234021489705;51258.48741512537;45523;45719;46098.53901460942;46261.5373846264;47437.99999999931;8449.662013519635;8466.57667116654;8512.872306915277;8556.486610803371;8741.475511469333;34727.65272347244;35211;35240.471392928615;35377.05426201584;35681.82159089188;41314.38028429636;41315.380269296584;42327;44837.77581112204;44941;10831.783364332512;10870.347779133277;11304.886951130384;11535.942320288344;11733;11928.522859085539;12028.310098031121;13053.934730326288;13063;13181.736365272833;10787.6224332148;11255.099592032782;11440.084793216689;11637.825432618687;11648.242864213798;10877.67366978992;11809.822852657046;12002.339871307162;12093;12102;10861.40262285582;11064;11090.223684342018;11325.660230193107;11407.771844562896;9438.480883551196;9755.268354873271;9814.803703926023;9825.4104753715;9870.358426702242;9502.904970950201;9648.276379271723;9777.21782257432;10005.149562287286;10228.386296822215 06:04:55 INFO - PROCESS | 21182 | __end_tp_report 06:04:55 INFO - PROCESS | 21182 | __start_cc_report 06:04:55 INFO - PROCESS | 21182 | _x_x_mozilla_cycle_collect,761 06:04:55 INFO - PROCESS | 21182 | __end_cc_report 06:04:55 INFO - PROCESS | 21182 | __startTimestamp1455372295342__endTimestamp 06:04:55 INFO - PROCESS | 21182 | 06:04:55 INFO - PROCESS | 21182 | ------- Summary: start ------- 06:04:55 INFO - PROCESS | 21182 | Number of tests: 6 06:04:55 INFO - PROCESS | 21182 | 06:04:55 INFO - PROCESS | 21182 | [#0] dojo.html Cycles:165 Average:5231.84 Median:5401.05 stddev:569.22 (10.5%) stddev-sans-first:546.56 06:04:55 INFO - PROCESS | 21182 | Values: 3129.9 3199.1 3234.5 3246.1 3273.2 5167.4 5184.2 5228.1 5297.8 5307.6 5148.9 5263.3 5275.1 5285.5 5310.5 4702.2 4775.6 4790.0 4842.7 4948.3 4709.5 4894.4 4901.6 4904.4 4926.0 4767.3 4800.0 4812.5 4830.0 4834.5 4784.1 4787.7 4795.5 4800.1 4838.7 4749.0 4756.1 4782.8 4794.8 4819.7 4958.4 5036.6 5055.5 5066.5 5087.7 5600.1 5628.4 5647.6 5658.4 5704.7 5573.8 5595.5 5596.8 5601.2 5606.4 5193.9 5211.7 5246.5 5260.5 5294.9 5776.0 5785.7 5786.3 5794.5 5821.2 5514.7 5569.4 5574.9 5574.9 5575.6 5401.1 5485.6 5556.9 5661.6 5679.9 5583.7 5613.9 5615.0 5618.6 5626.7 5626.8 5628.1 5630.0 5630.5 5636.4 4279.2 4338.7 4346.1 4347.4 4348.1 3899.6 3908.6 3923.4 3949.4 3952.5 5263.3 5288.0 5299.9 5304.6 5333.4 5532.8 5623.2 5630.7 5631.8 5634.0 5126.9 5153.2 5213.4 5225.4 5236.8 4828.5 4836.2 4874.3 4876.0 4889.7 5894.5 5919.7 5935.1 5936.0 5938.3 5586.7 5654.1 5705.9 5717.4 5724.5 5689.9 5891.2 5896.6 5935.9 5981.5 5529.0 5565.9 5569.3 5571.6 5574.3 5582.5 5646.5 5660.9 5669.4 5698.4 5476.4 5522.3 5528.6 5532.3 5575.8 5446.5 5477.9 5478.4 5480.3 5480.9 5346.4 5357.8 5390.7 5423.9 5432.1 5460.9 5469.6 5489.7 5522.4 5560.7 5351.5 5390.1 5390.7 5397.4 5409.5 06:04:55 INFO - PROCESS | 21182 | 06:04:55 INFO - PROCESS | 21182 | [#1] ext.html Cycles:180 Average:47080.60 Median:3500.61 stddev:83071.97 (2373.1%) stddev-sans-first:83231.33 06:04:55 INFO - PROCESS | 21182 | Values: 480.3 505.4 521.8 533.6 552.4 28638.9 29005.1 29021.7 36686.6 37089.0 39320.0 39988.2 40048.4 40110.6 40147.8 8447.0 8669.0 8674.3 8676.7 8678.0 8407.8 8553.8 8569.1 8573.9 8580.8 8753.3 8835.4 8847.9 8848.4 8848.6 8706.1 8729.1 8746.8 8774.8 8787.6 8670.1 8719.7 8809.8 8830.2 8831.6 39248.0 39743.0 39819.2 39833.4 39858.4 3228.9 3269.6 3324.8 3496.8 3828.2 26818.2 27475.7 27484.9 27497.5 27498.0 3435.5 3504.4 3652.6 3714.8 3715.8 263702.0 267252.0 267785.0 268018.7 269003.0 58774.1 60076.4 60491.4 60759.7 61034.0 63830.4 64117.4 64178.7 64265.0 64471.7 16749.2 16869.3 16886.2 16933.3 16966.7 12833.3 12842.4 12921.2 12922.2 12929.9 19812.0 20390.7 20593.6 20608.8 20661.5 7854.6 7872.0 7878.2 7937.9 8009.9 820.3 916.4 927.1 977.9 1034.3 24352.4 24900.9 24955.1 25013.2 25029.0 900.1 900.6 908.0 1039.9 1144.5 14314.0 14644.1 15034.8 15113.7 15175.8 377575.0 381814.0 382354.0 383197.0 383798.0 47267.3 52785.5 53245.7 53442.0 53981.7 1320.3 1342.2 1343.0 1356.1 1359.3 26197.9 26670.5 28196.7 28374.7 28817.4 43751.6 44535.8 44610.1 44611.1 44629.1 285649.0 286895.0 286932.0 287813.0 288291.0 26801.6 30921.7 31252.8 31288.8 31710.7 36468.6 36482.6 36933.3 37250.0 37395.0 31437.7 31628.4 31849.8 32124.2 32138.2 31660.8 31741.4 32150.7 32390.8 32644.0 33274.2 33434.7 33549.8 33608.2 33682.5 29088.0 30371.2 30880.5 30943.0 30945.5 23714.0 23782.4 23861.2 23877.4 24066.5 06:04:55 INFO - PROCESS | 21182 | 06:04:55 INFO - PROCESS | 21182 | [#2] jquery.html Cycles:180 Average:27447.66 Median:268179.56 stddev:87768.54 (32.7%) stddev-sans-first:87991.17 06:04:55 INFO - PROCESS | 21182 | Values: 351.3 358.7 361.2 365.4 365.8 13641.9 13887.4 16246.3 17004.7 17527.6 14526.5 15758.8 16140.5 16257.3 16294.0 5314.3 5446.9 5483.4 5494.8 5497.9 3984.3 5420.4 5522.4 5872.4 6122.6 5911.7 6042.2 6085.6 6097.3 6107.1 6058.2 6075.8 6075.9 6114.3 6197.9 5220.4 5320.0 5334.4 5345.6 5370.1 19785.7 20281.8 20397.5 20567.3 20604.1 2139.1 2183.8 2325.1 2570.7 2656.7 12685.6 12965.5 13041.2 13445.2 13601.8 1826.2 1829.2 1852.7 1887.5 1932.0 56931.7 58496.7 59151.7 60015.7 60155.7 9617.6 9699.1 10170.7 10339.4 10396.0 13357.1 13413.3 13484.9 13486.3 13499.1 7780.4 7801.5 7873.6 7935.4 7942.3 7715.3 7744.3 7754.8 7799.9 7820.3 4111.4 4469.6 4498.7 4504.8 4535.7 1778.2 1822.5 1835.7 1839.1 1856.6 940.7 952.1 952.9 1027.5 1038.1 15444.5 16645.9 16663.3 16726.7 16874.1 957.1 964.1 973.3 976.0 987.7 8112.2 8720.5 8801.7 9249.9 9792.7 522945.0 531044.8 539856.0 543593.0 548760.0 70146.0 71899.0 72366.0 72821.6 73658.6 1173.3 1175.0 1219.1 1222.9 1235.1 13839.2 14404.3 15260.4 15572.8 15617.5 31323.8 31753.7 31857.7 32080.0 32323.8 39558.8 40248.8 40303.0 41113.4 44169.3 7378.9 7467.3 7539.7 7638.2 7680.8 7760.9 9841.6 10324.4 10778.8 11506.4 9569.9 9783.3 9813.5 10065.4 10243.1 3028.3 7200.5 9846.4 9883.4 9892.4 6960.6 7143.9 7268.1 9758.3 9875.2 7315.5 7336.1 7347.2 7447.1 7469.5 6364.6 9489.8 9596.0 9596.8 10206.8 06:04:55 INFO - PROCESS | 21182 | 06:04:55 INFO - PROCESS | 21182 | [#3] mootools.html Cycles:180 Average:5544.56 Median:6727.33 stddev:2840.34 (42.2%) stddev-sans-first:2831.15 06:04:55 INFO - PROCESS | 21182 | Values: 1391.4 1495.5 1518.2 1686.2 1862.0 7133.3 7897.1 8039.0 8043.2 8048.0 7719.5 7868.9 7870.4 7894.9 7897.1 1989.9 2249.8 2310.5 2318.1 2340.1 2331.8 2339.4 2340.8 2343.6 2344.7 2239.8 2319.0 2319.2 2323.2 2324.4 2255.7 2279.0 2323.5 2326.0 2327.9 2278.8 2288.6 2293.9 2319.2 2372.0 8199.1 8261.3 8277.8 8294.5 8294.7 4710.2 4791.1 4793.8 4796.1 4811.5 2945.9 2987.2 3029.6 3031.1 3041.2 922.7 933.8 938.7 961.8 982.5 10639.7 10645.2 10696.3 10701.5 10728.7 4274.2 4327.4 4332.4 4436.0 4472.4 9144.0 9145.8 9159.1 9175.0 9175.4 4890.8 4899.4 4903.3 4904.1 4910.0 4474.7 4481.4 4485.0 4492.1 4493.6 3513.3 3783.5 3820.4 3852.3 3852.7 1223.7 1245.9 1252.6 1263.0 1265.7 1346.0 1355.1 1356.5 1363.6 1403.0 7298.6 7537.1 7557.9 7567.3 7727.3 1154.9 1156.6 1159.2 1167.7 1189.4 5529.8 5588.3 5602.9 5605.5 5623.5 9134.2 9134.5 9190.9 9274.3 9312.6 9364.5 9499.4 9503.4 9512.5 9577.3 7294.4 7464.5 7510.5 7526.2 7527.9 7027.5 7083.8 7097.3 7123.4 7126.6 8312.2 8365.2 8467.4 8667.6 8669.9 8574.5 8740.3 8746.0 8752.6 8761.5 6262.7 6856.9 6890.9 6951.0 6954.5 6931.3 6940.4 6958.7 7492.5 7629.7 7010.2 7165.8 7232.2 7234.3 7373.1 7094.6 7164.5 7172.3 7260.6 7273.4 7190.9 7240.9 7248.3 7309.1 7333.6 6563.0 6590.7 6591.3 6602.5 6628.3 6826.4 6835.6 6853.5 6873.7 6921.5 06:04:55 INFO - PROCESS | 21182 | 06:04:55 INFO - PROCESS | 21182 | [#4] prototype.html Cycles:180 Average:5211.39 Median:5855.53 stddev:1550.97 (26.5%) stddev-sans-first:1510.90 06:04:55 INFO - PROCESS | 21182 | Values: 301.4 304.6 328.1 334.6 336.6 5782.0 5834.2 5836.7 5843.3 5862.5 5726.5 5795.1 5796.3 5818.1 5820.5 4343.0 4476.9 4477.9 4558.4 4559.8 4417.8 4464.8 4496.5 4553.8 4598.0 4497.8 4504.7 4505.6 4519.4 4528.9 4285.1 4384.2 4503.5 4522.2 4524.4 3999.8 4013.9 4016.7 4022.7 4030.4 5545.2 5554.0 5559.5 5562.6 5580.2 5251.0 5257.6 5262.1 5262.7 5264.6 6052.8 6108.0 6142.4 6159.6 6163.5 4441.3 4441.6 4446.1 4449.4 4454.1 6427.9 6429.1 6429.1 6430.7 6438.5 4523.6 4548.5 4551.0 4555.1 4555.4 4504.3 4603.2 4606.1 4616.3 4641.6 5237.5 5250.7 5255.4 5258.6 5258.8 6176.8 6205.1 6209.1 6212.9 6217.9 1598.6 1613.8 1615.5 1616.0 1620.4 1097.5 1104.1 1109.6 1109.7 1131.0 5853.3 5855.5 5857.5 5862.3 5866.7 6326.9 6352.4 6364.1 6372.0 6380.4 5855.6 5855.9 5862.9 5863.9 5871.6 3314.8 3354.1 3366.3 3403.4 3434.2 6724.9 6737.3 6759.7 6771.1 6779.4 6480.9 6559.8 6569.1 6571.9 6575.5 6473.0 6647.7 6655.9 6703.6 6710.3 6417.4 6428.1 6436.2 6440.7 6442.3 6304.7 6362.7 6371.7 6373.8 6375.1 6492.9 6661.7 6668.9 6689.2 6705.1 4412.6 4445.6 4455.0 4455.5 4462.6 6391.5 6426.3 6430.2 6431.2 6438.4 6009.1 6163.3 6226.9 6234.4 6243.3 6216.2 6217.6 6228.5 6231.9 6234.3 6119.1 6119.2 6121.4 6122.6 6150.7 6056.4 6218.0 6238.6 6246.1 6256.9 6087.9 6114.7 6138.8 6147.9 6150.0 06:04:55 INFO - PROCESS | 21182 | 06:04:55 INFO - PROCESS | 21182 | [#5] yui.html Cycles:180 Average:13742.94 Median:45621.00 stddev:15889.19 (34.8%) stddev-sans-first:15903.64 06:04:55 INFO - PROCESS | 21182 | Values: 713.0 778.5 813.6 814.2 828.7 13153.9 13297.1 13335.2 13425.9 13610.4 12152.0 12264.4 12277.4 12278.9 12295.8 677.2 829.1 849.2 850.3 851.0 704.5 790.6 849.2 849.9 851.0 873.9 885.3 885.4 886.4 886.4 713.0 870.6 882.9 884.3 891.1 653.4 657.1 657.5 657.7 658.0 12793.7 12841.1 12843.4 12853.9 12865.7 11867.7 12626.4 12703.9 12854.2 13488.3 9981.0 9983.0 10029.2 10044.2 10107.9 3031.7 3078.6 3103.1 3105.2 3120.7 46021.0 46440.8 47650.3 48012.3 48015.0 10207.3 10302.9 10450.3 10608.1 10654.0 18935.3 19036.7 19047.0 19060.0 19101.5 7200.7 7498.4 7577.2 7584.8 7723.2 4052.4 4099.5 4117.3 4119.4 4134.1 3164.7 3197.6 3200.0 3202.4 3203.4 565.6 573.2 581.5 586.3 593.2 548.9 597.0 630.9 644.9 713.1 8103.8 8146.7 8209.4 8280.8 8465.2 567.3 606.6 621.8 650.1 673.9 3884.4 3906.7 3911.8 4016.4 4043.8 56680.0 57204.7 57313.7 61537.0 62176.7 49359.5 49605.8 50838.7 51065.2 51258.5 45523.0 45719.0 46098.5 46261.5 47438.0 8449.7 8466.6 8512.9 8556.5 8741.5 34727.7 35211.0 35240.5 35377.1 35681.8 41314.4 41315.4 42327.0 44837.8 44941.0 10831.8 10870.3 11304.9 11535.9 11733.0 11928.5 12028.3 13053.9 13063.0 13181.7 10787.6 11255.1 11440.1 11637.8 11648.2 10877.7 11809.8 12002.3 12093.0 12102.0 10861.4 11064.0 11090.2 11325.7 11407.8 9438.5 9755.3 9814.8 9825.4 9870.4 9502.9 9648.3 9777.2 10005.1 10228.4 06:04:55 INFO - PROCESS | 21182 | -------- Summary: end -------- 06:04:55 INFO - PROCESS | 21182 | 06:04:56 INFO - TEST-INFO | 21182: exit 0 06:04:56 INFO - TEST-OK | dromaeo_css | took 1112925ms 06:04:56 INFO - TEST-START | kraken 06:04:56 INFO - operating with platform_type : linux_ 06:04:56 INFO - Initialising browser for kraken test... 06:04:56 INFO - TEST-INFO | started process 21366 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1Aj5dU/profile http://localhost:47667/getInfo.html) 06:04:59 INFO - PROCESS | 21366 | __metrics Screen width/height:1600/1200 06:04:59 INFO - PROCESS | 21366 | colorDepth:24 06:04:59 INFO - PROCESS | 21366 | Browser inner width/height: 1024/697 06:04:59 INFO - PROCESS | 21366 | __metrics 06:05:00 INFO - PROCESS | 21366 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:01 INFO - TEST-INFO | 21366: exit 0 06:05:01 INFO - Browser initialized. 06:05:01 INFO - Running cycle 1/1 for kraken test... 06:05:01 INFO - TEST-INFO | started process 21447 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1Aj5dU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:12 INFO - PROCESS | 21447 | RSS: Main: 153669632 06:05:12 INFO - PROCESS | 21447 | 06:05:15 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47667/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:16 INFO - PROCESS | 21447 | RSS: Main: 196513792 06:05:16 INFO - PROCESS | 21447 | 06:05:18 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47667/tests/kraken/driver.html?testName=audio-dft) 06:05:19 INFO - PROCESS | 21447 | RSS: Main: 186535936 06:05:19 INFO - PROCESS | 21447 | 06:05:22 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47667/tests/kraken/driver.html?testName=audio-fft) 06:05:22 INFO - PROCESS | 21447 | RSS: Main: 169644032 06:05:22 INFO - PROCESS | 21447 | 06:05:24 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47667/tests/kraken/driver.html?testName=audio-oscillator) 06:05:25 INFO - PROCESS | 21447 | RSS: Main: 172843008 06:05:25 INFO - PROCESS | 21447 | 06:05:27 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47667/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:28 INFO - PROCESS | 21447 | RSS: Main: 174616576 06:05:28 INFO - PROCESS | 21447 | 06:05:31 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47667/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:31 INFO - PROCESS | 21447 | RSS: Main: 174419968 06:05:31 INFO - PROCESS | 21447 | 06:05:35 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47667/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:35 INFO - PROCESS | 21447 | RSS: Main: 174792704 06:05:35 INFO - PROCESS | 21447 | 06:05:38 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47667/tests/kraken/driver.html?testName=json-parse-financial) 06:05:39 INFO - PROCESS | 21447 | RSS: Main: 176295936 06:05:39 INFO - PROCESS | 21447 | 06:05:40 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47667/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:41 INFO - PROCESS | 21447 | RSS: Main: 187334656 06:05:41 INFO - PROCESS | 21447 | 06:05:43 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47667/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:43 INFO - PROCESS | 21447 | RSS: Main: 182882304 06:05:43 INFO - PROCESS | 21447 | 06:05:45 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47667/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:05:46 INFO - PROCESS | 21447 | RSS: Main: 198193152 06:05:46 INFO - PROCESS | 21447 | 06:05:48 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:05:49 INFO - PROCESS | 21447 | RSS: Main: 202674176 06:05:49 INFO - PROCESS | 21447 | 06:05:51 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:05:52 INFO - PROCESS | 21447 | RSS: Main: 200802304 06:05:52 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | Cycle 1(1): loaded http://localhost:47667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47667/tests/kraken/driver.html?testName=ai-astar) 06:05:54 INFO - PROCESS | 21447 | RSS: Main: 262082560 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | __start_tp_report 06:05:54 INFO - PROCESS | 21447 | _x_x_mozilla_page_load 06:05:54 INFO - PROCESS | 21447 | _x_x_mozilla_page_load_details 06:05:54 INFO - PROCESS | 21447 | |i|pagename|runs| 06:05:54 INFO - PROCESS | 21447 | |0;ai-astar;111;111;108;111;111;113;103;112;111;111 06:05:54 INFO - PROCESS | 21447 | |1;audio-beat-detection;156;125;155;165;127;152;151;136;176;129 06:05:54 INFO - PROCESS | 21447 | |2;audio-dft;172;161;163;162;160;162;162;164;163;166 06:05:54 INFO - PROCESS | 21447 | |3;audio-fft;73;73;106;97;72;74;73;102;95;73 06:05:54 INFO - PROCESS | 21447 | |4;audio-oscillator;96;96;149;96;96;95;137;95;97;138 06:05:54 INFO - PROCESS | 21447 | |5;imaging-gaussian-blur;119;115;115;115;115;115;115;115;115;115 06:05:54 INFO - PROCESS | 21447 | |6;imaging-darkroom;146;145;146;145;146;146;146;145;146;146 06:05:54 INFO - PROCESS | 21447 | |7;imaging-desaturate;96;96;96;96;95;95;96;96;96;96 06:05:54 INFO - PROCESS | 21447 | |8;json-parse-financial;55;56;66;54;55;56;55;64;53;54 06:05:54 INFO - PROCESS | 21447 | |9;json-stringify-tinderbox;67;67;66;67;66;67;67;66;66;67 06:05:54 INFO - PROCESS | 21447 | |10;stanford-crypto-aes;82;81;82;82;82;83;82;86;82;83 06:05:54 INFO - PROCESS | 21447 | |11;stanford-crypto-ccm;125;122;122;116;114;120;129;121;126;127 06:05:54 INFO - PROCESS | 21447 | |12;stanford-crypto-pbkdf2;161;145;155;168;161;146;156;154;152;155 06:05:54 INFO - PROCESS | 21447 | |13;stanford-crypto-sha256-iterative;69;71;70;73;69;69;69;71;69;67 06:05:54 INFO - PROCESS | 21447 | __end_tp_report 06:05:54 INFO - PROCESS | 21447 | __start_cc_report 06:05:54 INFO - PROCESS | 21447 | _x_x_mozilla_cycle_collect,1000 06:05:54 INFO - PROCESS | 21447 | __end_cc_report 06:05:54 INFO - PROCESS | 21447 | __startTimestamp1455372354525__endTimestamp 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | ------- Summary: start ------- 06:05:54 INFO - PROCESS | 21447 | Number of tests: 14 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.82 (2.5%) stddev-sans-first:2.98 06:05:54 INFO - PROCESS | 21447 | Values: 111.0 111.0 108.0 111.0 111.0 113.0 103.0 112.0 111.0 111.0 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:153.50 stddev:17.25 (11.2%) stddev-sans-first:18.01 06:05:54 INFO - PROCESS | 21447 | Values: 156.0 125.0 155.0 165.0 127.0 152.0 151.0 136.0 176.0 129.0 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:3.41 (2.1%) stddev-sans-first:1.74 06:05:54 INFO - PROCESS | 21447 | Values: 172.0 161.0 163.0 162.0 160.0 162.0 162.0 164.0 163.0 166.0 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#3] audio-fft Cycles:10 Average:83.80 Median:73.00 stddev:14.24 (19.5%) stddev-sans-first:14.56 06:05:54 INFO - PROCESS | 21447 | Values: 73.0 73.0 106.0 97.0 72.0 74.0 73.0 102.0 95.0 73.0 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:22.20 (23.1%) stddev-sans-first:23.00 06:05:54 INFO - PROCESS | 21447 | Values: 96.0 96.0 149.0 96.0 96.0 95.0 137.0 95.0 97.0 138.0 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.26 (1.1%) stddev-sans-first:0.00 06:05:54 INFO - PROCESS | 21447 | Values: 119.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:05:54 INFO - PROCESS | 21447 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:05:54 INFO - PROCESS | 21447 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:55.50 stddev:4.44 (8.0%) stddev-sans-first:4.66 06:05:54 INFO - PROCESS | 21447 | Values: 55.0 56.0 66.0 54.0 55.0 56.0 55.0 64.0 53.0 54.0 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:05:54 INFO - PROCESS | 21447 | Values: 67.0 67.0 66.0 67.0 66.0 67.0 67.0 66.0 66.0 67.0 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.00 stddev:1.35 (1.7%) stddev-sans-first:1.42 06:05:54 INFO - PROCESS | 21447 | Values: 82.0 81.0 82.0 82.0 82.0 83.0 82.0 86.0 82.0 83.0 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#11] stanford-crypto-ccm Cycles:10 Average:122.20 Median:123.50 stddev:4.76 (3.9%) stddev-sans-first:4.94 06:05:54 INFO - PROCESS | 21447 | Values: 125.0 122.0 122.0 116.0 114.0 120.0 129.0 121.0 126.0 127.0 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:155.50 stddev:6.93 (4.5%) stddev-sans-first:7.04 06:05:54 INFO - PROCESS | 21447 | Values: 161.0 145.0 155.0 168.0 161.0 146.0 156.0 154.0 152.0 155.0 06:05:54 INFO - PROCESS | 21447 | 06:05:54 INFO - PROCESS | 21447 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.50 stddev:1.64 (2.4%) stddev-sans-first:1.72 06:05:54 INFO - PROCESS | 21447 | Values: 69.0 71.0 70.0 73.0 69.0 69.0 69.0 71.0 69.0 67.0 06:05:54 INFO - PROCESS | 21447 | -------- Summary: end -------- 06:05:54 INFO - PROCESS | 21447 | 06:05:55 INFO - TEST-INFO | 21447: exit 0 06:05:55 INFO - TEST-OK | kraken | took 59422ms 06:05:55 INFO - SUITE-END | took 1172s 06:05:55 INFO - Completed test suite (00:19:32) 06:05:55 INFO - Working with test: dromaeo_css 06:05:55 INFO - Generating results file: dromaeo_css 06:05:55 INFO - Working with test: kraken 06:05:55 INFO - Generating results file: kraken 06:05:55 INFO - javascript benchmark 06:05:55 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:55 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:05:55 INFO - process_Request line: dromaeo_css 6860.30 graph.html#tests=[[72,1,35]] 06:05:55 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:55 INFO - process_Request line: kraken 1524.20 graph.html#tests=[[232,1,35]] 06:05:55 INFO - RETURN: dromaeo_css: 6860.30 06:05:55 INFO - RETURN: kraken: 1524.20 06:05:55 INFO - javascript benchmark 06:05:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3129.859156337965, 3199.13623321703, 3234.514822776585, 3246.1397729601645, 3273.2307907641707, 5167.431582525919, 5184.1705327147665, 5228.058949389113, 5297.761600727967, 5307.601929855257, 5148.871278218037, 5263.34208223972, 5275.050490911634, 5285.471452854713, 5310.522053015228, 4702.24764037754, 4775.617950563964, 4790.041991601676, 4842.66101372904, 4948.307236986807, 4709.5055019223, 4894.363732714742, 4901.607871370282, 4904.4114706235305, 4926.0, 4767.284907263921, 4800.039992001613, 4812.518748125194, 4829.975850120762, 4834.468208497063, 4784.114938736345, 4787.712737235777, 4795.472498025214, 4800.1119792838435, 4838.6854854434705, 4749.026449577863, 4756.143894099096, 4782.784774685148, 4794.760261986921, 4819.6867203631655, 4958.429780575208, 5036.622253331015, 5055.545000949932, 5066.518680725325, 5087.720175390352, 5600.103983362643, 5628.43715628438, 5647.632903861236, 5658.377578466366, 5704.686242256675, 5573.777048918038, 5595.468430499137, 5596.776128954837, 5601.187827764951, 5606.383297837235, 5193.870153246161, 5211.706848986434, 5246.527812496855, 5260.500252476047, 5294.867628309285, 5775.971120144456, 5785.652860828363, 5786.334571524329, 5794.478496935211, 5821.15593238978, 5514.6691198528215, 5569.415211402826, 5574.86062848432, 5574.888502229933, 5575.637583557056, 5401.054815407288, 5485.588580856452, 5556.944430555724, 5661.631993920464, 5679.858003549862, 5583.664980101207, 5613.943860561342, 5614.989301925611, 5618.606697531133, 5626.690532020778, 5626.831195064155, 5628.127640215773, 5630.0, 5630.465105814941, 5636.408177141423, 4279.16556271524, 4338.696291259645, 4346.087321662486, 4347.369631403429, 4348.065165989327, 3899.629535194152, 3908.5895980922164, 3923.352646813301, 3949.407588861636, 3952.545457272393, 5263.26314315996, 5288.0, 5299.867503312371, 5304.628675992721, 5333.359996800331, 5532.834014979557, 5623.156526521055, 5630.71846407678, 5631.7747290108755, 5633.971830140823, 5126.8974620508125, 5153.175491921274, 5213.426523082458, 5225.399079105951, 5236.842894713165, 4828.46886842447, 4836.177849765549, 4874.268859671007, 4875.95124048762, 4889.731064791471, 5894.498967587803, 5919.67441790697, 5935.139404786281, 5936.0, 5938.317093534299, 5586.664800112007, 5654.06707893193, 5705.857353566277, 5717.37108918027, 5724.4561766632105, 5689.857753556194, 5891.23413956183, 5896.55775816824, 5935.851603709769, 5981.521478281814, 5528.9723551381985, 5565.860853478695, 5569.331680198402, 5571.60998730085, 5574.303212098488, 5582.525485333792, 5646.463585959492, 5660.943390566042, 5669.376368599368, 5698.430156984268, 5476.397596264487, 5522.2544956430365, 5528.585356098229, 5532.30846144232, 5575.776968921197, 5446.482584154499, 5477.945220547903, 5478.369987451494, 5480.26016487785, 5480.91778623313, 5346.385165705838, 5357.758900849549, 5390.730463476889, 5423.891522169613, 5432.103702889137, 5460.863478413072, 5469.644473109235, 5489.698066606215, 5522.447755224445, 5560.666360018412, 5351.518363347317, 5390.056740070394, 5390.676559406448, 5397.406285308692, 5409.513143817076], "unit": "score", "name": "dojo.html", "value": 5196.085765213496}, {"lowerIsBetter": false, "replicates": [480.27238733319007, 505.3581950922326, 521.846055413653, 533.6371267538075, 552.4309960740437, 28638.85680571597, 29005.129846104624, 29021.70978290219, 36686.61537000093, 37089.0, 39320.0, 39988.20023599526, 40048.39927401084, 40110.598894011055, 40147.79926100365, 8447.028591711955, 8669.046404895456, 8674.306055515575, 8676.739697809076, 8677.956610216972, 8407.831843363128, 8553.828923421528, 8569.100244474334, 8573.871391929126, 8580.785480362978, 8753.299736021103, 8835.381523293372, 8847.867281990775, 8848.380613357067, 8848.646054157825, 8706.129387061306, 8729.127087291283, 8746.781330466725, 8774.780630484192, 8787.64849406023, 8670.13298670128, 8719.651213951434, 8809.823803523957, 8830.205281524693, 8831.55842207887, 39248.0, 39743.0, 39819.203615927516, 39833.40249896254, 39858.40212396816, 3228.886988955399, 3269.623993240784, 3324.833758312099, 3496.8426420811124, 3828.1960788234505, 26818.195454136407, 27475.725242747518, 27484.862575687195, 27497.45005099907, 27498.0, 3435.4503279475166, 3504.3692135415613, 3652.626167337986, 3714.832832522543, 3715.8327875245677, 263702.0, 267252.0, 267785.0, 268018.6599067012, 269003.0, 58774.11838822421, 60076.39923600796, 60491.39508604858, 60759.6962015196, 61034.0, 63830.36169638337, 64117.35882641207, 64178.67910660417, 64265.0, 64471.677641611495, 16749.24628391725, 16869.32522699103, 16886.15569221534, 16933.322667093424, 16966.745498817527, 12833.294168820617, 12842.422091005927, 12921.160124591872, 12922.224666520038, 12929.935350323376, 19812.0, 20390.69413958792, 20593.58812823765, 20608.793912060988, 20661.483462913548, 7854.646540905673, 7871.960640196762, 7878.172791856887, 7937.920620793833, 8009.919900801034, 820.323233332503, 916.3585490156917, 927.1099744245465, 977.8973207813077, 1034.2605037398296, 24352.391190220387, 24900.875495622407, 24955.126570570304, 25013.249602511954, 25029.0, 900.0999000999001, 900.6142776730919, 908.0, 1039.9168066554657, 1144.4678224625422, 14314.0, 14644.063742637554, 15034.849651503564, 15113.697726045417, 15175.772363414557, 377575.0, 381814.0, 382354.0, 383197.0, 383798.0, 47267.29099063517, 52785.47214527882, 53245.733771330895, 53442.0, 53981.73009135008, 1320.3332317179763, 1342.2080972226433, 1342.9798553021712, 1356.0575400097034, 1359.3475131936725, 26197.869010654824, 26670.466590668468, 28196.718032819408, 28374.716252838032, 28817.42365152727, 43751.56248437602, 44535.777321113186, 44610.107797843215, 44611.10777784491, 44629.10741785211, 285649.0, 286895.0, 286932.0, 287813.0, 288291.0, 26801.597976030764, 30921.690783091883, 31252.843735782084, 31288.843555782074, 31710.68289317077, 36468.635313646526, 36482.63517364793, 36933.26133477369, 37250.0, 37395.0, 31437.685623143476, 31628.367432650757, 31849.8407507961, 32124.19689507781, 32138.19654508656, 31660.841695791372, 31741.365172695954, 32150.678493214768, 32390.838045810564, 32644.020679379657, 33274.168145796546, 33434.66565334315, 33549.83225083859, 33608.1597960053, 33682.49476257809, 29088.0, 30371.2407189822, 30880.536791948587, 30943.0, 30945.535816962314, 23714.0, 23782.40543986345, 23861.164859229844, 23877.403064923517, 24066.51866962616], "unit": "score", "name": "ext.html", "value": 17965.563217478157}, {"lowerIsBetter": false, "replicates": [351.26059644448435, 358.7399135626669, 361.2179631098671, 365.3861512658733, 365.8225760506155, 13641.863581364183, 13887.375068121934, 16246.268917898693, 17004.74492882606, 17527.561810954732, 14526.491572794954, 15758.84241157588, 16140.515784526482, 16257.349706011775, 16294.0, 5314.335708036505, 5446.891062178754, 5483.424240454755, 5494.835154945358, 5497.890042199174, 3984.2629113614075, 5420.403755586883, 5522.3649280332675, 5872.383399743008, 6122.571420000601, 5911.674857882815, 6042.244719410074, 6085.604435711687, 6097.298810636789, 6107.083937409379, 6058.242719660043, 6075.817725468243, 6075.939240607626, 6114.2968558615885, 6197.907031394533, 5220.425753167148, 5320.042392369372, 5334.386545547273, 5345.572354211693, 5370.140777475585, 19785.703214451652, 20281.79718202814, 20397.490062748402, 20567.280145194996, 20604.072816723285, 2139.0801955159277, 2183.836212284085, 2325.081592770863, 2570.665813444259, 2656.654634897451, 12685.556005539762, 12965.481380744759, 13041.217526948414, 13445.19328840263, 13601.795973060413, 1826.2329821475012, 1829.1585870499453, 1852.685043542601, 1887.5186827359073, 1932.0, 56931.71534142344, 58496.70751646257, 59151.70424147852, 60015.69992150055, 60155.699221503615, 9617.56720947559, 9699.127078562964, 10170.694879153638, 10339.431331276852, 10396.0, 13357.065005449525, 13413.32933353348, 13484.932575337061, 13486.258255795829, 13499.122557033761, 7780.416468764865, 7801.53190808542, 7873.645685944146, 7935.444518883738, 7942.324902383247, 7715.344195743312, 7744.303012728881, 7754.806129846799, 7799.883001754978, 7820.257075577811, 4111.444954931106, 4469.553044695569, 4498.6626003049905, 4504.797284122223, 4535.705179163344, 1778.2264714849082, 1822.4714832698635, 1835.6879330513846, 1839.1264149528868, 1856.5729882127187, 940.6765289734345, 952.0574631115285, 952.8523078922778, 1027.4913917610832, 1038.055369613663, 15444.45944391941, 16645.916770416312, 16663.3334666612, 16726.74909876353, 16874.071926044184, 957.1098878043347, 964.0841200859212, 973.3186769261546, 975.9707208783748, 987.7056894621577, 8112.22933821286, 8720.520371379635, 8801.723750056206, 9249.861252081224, 9792.706218813448, 522945.0, 531044.7805766662, 539856.0, 543593.0, 548760.0, 70146.0, 71899.0, 72366.0, 72821.6358918202, 73658.63170684113, 1173.266708307308, 1174.9941250293864, 1219.1405059433077, 1222.883826036525, 1235.110720281396, 13839.169649821042, 14404.279786010868, 15260.389584416944, 15572.84427155714, 15617.531474055797, 31323.84338078295, 31753.68246317507, 31857.681423185473, 32080.0, 32323.838380807945, 39558.80220598994, 40248.798756006036, 40303.0, 41113.38329925113, 44169.33745993877, 7378.926210738038, 7467.253274672489, 7539.660715267716, 7638.197989211053, 7680.846383072419, 7760.943350012364, 9841.60633574649, 10324.380537167794, 10778.838317425401, 11506.367149806842, 9569.90430095718, 9783.315167938461, 9813.460259685786, 10065.396076235449, 10243.07812296897, 3028.2732144284773, 7200.479371666568, 9846.359986601135, 9883.406995580288, 9892.406455612687, 6960.617166055916, 7143.928260804516, 7268.0914885639295, 9758.268129890144, 9875.209983201183, 7315.524490908074, 7336.082989626297, 7347.228541003332, 7447.143578488543, 7469.514481558681, 6364.586301890362, 9489.810203796023, 9596.0, 9596.808063838544, 10206.846897296695], "unit": "score", "name": "jquery.html", "value": 8256.405865112809}, {"lowerIsBetter": false, "replicates": [1391.3877893726765, 1495.5064828606558, 1518.2105305241275, 1686.1569215392303, 1862.0224382199335, 7133.251008644089, 7897.131315555284, 8039.035315762117, 8043.195680431954, 8048.0, 7719.459637825355, 7868.92131078689, 7870.409719271063, 7894.881576776339, 7897.091834439027, 1989.910454029572, 2249.8200143988524, 2310.4685922237895, 2318.0611852199886, 2340.134150364359, 2331.7901388875, 2339.3917581428864, 2340.777626125524, 2343.5781559319403, 2344.6951896253463, 2239.787220214077, 2318.976810231893, 2319.1766922742436, 2323.1984965186984, 2324.360800779782, 2255.6954811100454, 2279.0314116500504, 2323.512062466884, 2326.011445135827, 2327.9301620951314, 2278.7607301233297, 2288.5880541502524, 2293.896774645145, 2319.211468100854, 2372.0, 8199.139090395542, 8261.297789687884, 8277.751667449986, 8294.543800090993, 8294.709685160991, 4710.222813235812, 4791.065742180276, 4793.784279707422, 4796.112719146969, 4811.494793046715, 2945.9263518412, 2987.1635941936293, 3029.5758593796886, 3031.1209749172713, 3041.194083567856, 922.6724512797995, 933.8272419602396, 938.737153596994, 961.7691753979065, 982.4694664880956, 10639.734006649818, 10645.20160987929, 10696.304740191941, 10701.464926753632, 10728.678139655824, 4274.166537525215, 4327.350897365357, 4332.436783218224, 4436.0462500562535, 4472.351509031172, 9143.954280228556, 9145.81708365829, 9159.084091590788, 9175.0, 9175.403598766059, 4890.755462226874, 4899.4365647950945, 4903.338049363361, 4904.092742842514, 4910.0, 4474.709143905701, 4481.395011673448, 4485.035717320791, 4492.05666809967, 4493.640508759291, 3513.2973405318526, 3783.508143941325, 3820.3887378019385, 3852.345101332724, 3852.691784657277, 1223.7246619510538, 1245.9439325230387, 1252.6242127361754, 1262.9684257893443, 1265.6709255593612, 1346.0, 1355.0920883008407, 1356.504875720355, 1363.6113707593288, 1403.017887478769, 7298.56208627484, 7537.133229678548, 7557.924420755722, 7567.31894129531, 7727.343175830118, 1154.9316881884392, 1156.5836298932377, 1159.2406973432414, 1167.6672148437824, 1189.4052973513244, 5529.834104976857, 5588.30146231721, 5602.887942241132, 5605.495505404451, 5623.493885550321, 9134.223590994707, 9134.543272836332, 9190.90809091914, 9274.304427167854, 9312.627494900127, 9364.484953327632, 9499.38254013487, 9503.382280151767, 9512.524373781283, 9577.281703872099, 7294.416446684252, 7464.477486575996, 7510.4742668013805, 7526.24737526243, 7527.9247207528315, 7027.472939529658, 7083.7520686775715, 7097.25478824716, 7123.430125589836, 7126.643667816485, 8312.210340017931, 8365.163483651586, 8467.449615774955, 8667.609957551798, 8669.869951950599, 8574.52840093776, 8740.344474164336, 8746.037935827182, 8752.562371881508, 8761.518116503654, 6262.68686565679, 6856.9314306856295, 6890.931090689029, 6951.0, 6954.513184077066, 6931.306869313028, 6940.41006514452, 6958.686859091455, 7492.51298665585, 7629.694812207449, 7010.158780946319, 7165.820854478679, 7232.168300645282, 7234.276572342724, 7373.115226172894, 7094.64526773649, 7164.534305270141, 7172.318629730167, 7260.600666963368, 7273.3817625500305, 7190.856182876418, 7240.8913866290995, 7248.275172482709, 7309.086364204474, 7333.633318333956, 6562.967185164043, 6590.670466476753, 6591.274959754327, 6602.504812139013, 6628.27089020217, 6826.385625293748, 6835.624040677811, 6853.4859885507785, 6873.656317184221, 6921.515493915377], "unit": "score", "name": "mootools.html", "value": 4576.0665695212365}, {"lowerIsBetter": false, "replicates": [301.37314386076963, 304.5538286410409, 328.13863608028925, 334.64026171865237, 336.63811402742056, 5781.971090144549, 5834.21238132852, 5836.6789826559525, 5843.2695913010875, 5862.501687356569, 5726.541876649869, 5795.130730390443, 5796.333421656511, 5818.098194779805, 5820.505257053155, 4342.956570434287, 4476.932846007297, 4477.888052798674, 4558.361829343895, 4559.7948092335755, 4417.801198946039, 4464.821407143727, 4496.505384407713, 4553.795079221426, 4598.0, 4497.7526236057, 4504.662150338721, 4505.594496495315, 4519.367288579601, 4528.8867778305475, 4285.057287396768, 4384.167008268419, 4503.504614492404, 4522.163399771053, 4524.389207456984, 3999.8000099995174, 4013.8595149169932, 4016.6585840203616, 4022.7184097113213, 4030.3551431770775, 5545.168224766277, 5554.0, 5559.499645031926, 5562.610617256793, 5580.190872323531, 5251.0, 5257.605679574047, 5262.05283049051, 5262.710550919698, 5264.578833693296, 6052.833040037397, 6107.969460152671, 6142.416470435302, 6159.568830181889, 6163.506919446433, 4441.267190913495, 4441.644668426518, 4446.088551846864, 4449.443819522559, 4454.13144436835, 6427.871442571122, 6429.099926010363, 6429.099926010409, 6430.742770289183, 6438.452731517827, 4523.615492683159, 4548.545145485491, 4551.0, 4555.088982203506, 4555.430571178603, 4504.256797628354, 4603.194440972817, 4606.078784243165, 4616.330632058332, 4641.6286697064825, 5237.476252374732, 5250.65870718402, 5255.369355677343, 5258.631895767259, 5258.789648414097, 6176.845578860564, 6205.131281620576, 6209.130721698965, 6212.9068063979075, 6217.875642487215, 1598.6003499125218, 1613.798275215598, 1615.450746746112, 1615.9676806463806, 1620.3761551802404, 1097.5116073347283, 1104.0615476844778, 1109.5672687651822, 1109.672646569264, 1131.0273165078027, 5853.326867410217, 5855.502282306052, 5857.47282744555, 5862.296524417097, 5866.73599688015, 6326.905096423558, 6352.396522330371, 6364.07720880479, 6372.044193370939, 6380.361963803675, 5855.560832937546, 5855.912161317584, 5862.912056319074, 5863.882722345529, 5871.6183448075735, 3314.801111933292, 3354.0943945135164, 3366.2762506061313, 3403.387390269775, 3434.1586311353876, 6724.9327506725285, 6737.326267373223, 6759.695813688396, 6771.085903403076, 6779.389854912983, 6480.902786458207, 6559.770408035696, 6569.113169722122, 6571.868562628721, 6575.506836987245, 6472.967635161888, 6647.734090636417, 6655.86688266232, 6703.564268322641, 6710.328967103251, 6417.422431981144, 6428.067930150196, 6436.16329877113, 6440.710168042543, 6442.291347951628, 6304.684765761602, 6362.713677884413, 6371.745130194926, 6373.776917807854, 6375.139356187041, 6492.870142597028, 6661.700223489857, 6668.933310666831, 6689.197296324278, 6705.094812200486, 4412.580804823537, 4445.555444455528, 4454.977725111354, 4455.465344158722, 4462.598366147063, 6391.456726178327, 6426.260979987362, 6430.164078669743, 6431.196100487439, 6438.420542151229, 6009.06859436788, 6163.291221509405, 6226.906596400967, 6234.376562343729, 6243.283097148321, 6216.191895053614, 6217.595856269328, 6228.4705800005695, 6231.906521402273, 6234.314225435289, 6119.143319935123, 6119.2350956130485, 6121.3572574879, 6122.602030867979, 6150.692465376624, 6056.394360563909, 6218.0, 6238.563300569098, 6246.125542424155, 6256.937430625818, 6087.908681369871, 6114.694265286629, 6138.785142520169, 6147.877042459215, 6150.0], "unit": "score", "name": "prototype.html", "value": 4707.556886105889}, {"lowerIsBetter": false, "replicates": [712.9786106416809, 778.5017588743209, 813.6054013803305, 814.214283216696, 828.7223780033688, 13153.868461315384, 13297.069205155618, 13335.199888006715, 13425.932870335648, 13610.387532561033, 12151.96708279795, 12264.448099835528, 12277.386130693452, 12278.938605306983, 12295.754084918297, 677.1941389746211, 829.0714399872137, 849.2399302624148, 850.2517784349764, 851.0043249398219, 704.4681265644457, 790.608648718885, 849.218718778722, 849.9065102838683, 851.0298259983624, 873.9388242823005, 885.2608072259671, 885.3802338363139, 886.3751055505885, 886.3751055505885, 712.9643517824088, 870.5777697816554, 882.9470231786113, 884.3279107877995, 891.1222445890793, 653.3956090616208, 657.1457105762489, 657.4608820766973, 657.6678777217522, 657.9703913323864, 12793.744125117539, 12841.1011229214, 12843.422046007952, 12853.87146128536, 12865.67835804103, 11867.703307417298, 12626.368681565886, 12703.936480317632, 12854.153650869215, 13488.325583720774, 9980.97439013454, 9983.0, 10029.247806414549, 10044.246681498917, 10107.89892101077, 3031.6513600935955, 3078.5536097265995, 3103.115612050555, 3105.239216391976, 3120.719135277813, 46021.0, 46440.76779616114, 47650.285245721345, 48012.279815802794, 48015.0, 10207.285490015776, 10302.948485257526, 10450.268481206243, 10608.098311643596, 10654.0, 18935.33726319572, 19036.71444928327, 19047.047647617565, 19060.0, 19101.522461938563, 7200.711971521186, 7498.362639175732, 7577.204393538709, 7584.772456826304, 7723.150453450116, 4052.4124002019544, 4099.528554216304, 4117.279476091672, 4119.423280740639, 4134.069834287261, 3164.699353561408, 3197.568328275653, 3199.9680003200137, 3202.3595280943905, 3203.3913556424204, 565.6351653183674, 573.1545969694668, 581.4621475135483, 586.3257254157753, 593.2376895689019, 548.9268480121353, 596.9910850662367, 630.8895943210011, 644.9484041276687, 713.0979311171373, 8103.756887293391, 8146.674133034612, 8209.425340226246, 8280.80571076342, 8465.195806398382, 567.2540609099021, 606.6329870428416, 621.7948077134535, 650.1190886349024, 673.8719643267764, 3884.4367566703236, 3906.74606150605, 3911.7532448068037, 4016.4094159267693, 4043.7775922324554, 56680.0, 57204.71397642985, 57313.713431432574, 61537.0, 62176.68911655503, 49359.50640493549, 49605.751971239915, 50838.74580627073, 51065.234021489705, 51258.48741512537, 45523.0, 45719.0, 46098.53901460942, 46261.5373846264, 47437.99999999931, 8449.662013519635, 8466.57667116654, 8512.872306915277, 8556.486610803371, 8741.475511469333, 34727.65272347244, 35211.0, 35240.471392928615, 35377.05426201584, 35681.82159089188, 41314.38028429636, 41315.380269296584, 42327.0, 44837.77581112204, 44941.0, 10831.783364332512, 10870.347779133277, 11304.886951130384, 11535.942320288344, 11733.0, 11928.522859085539, 12028.310098031121, 13053.934730326288, 13063.0, 13181.736365272833, 10787.6224332148, 11255.099592032782, 11440.084793216689, 11637.825432618687, 11648.242864213798, 10877.67366978992, 11809.822852657046, 12002.339871307162, 12093.0, 12102.0, 10861.40262285582, 11064.0, 11090.223684342018, 11325.660230193107, 11407.771844562896, 9438.480883551196, 9755.268354873271, 9814.803703926023, 9825.4104753715, 9870.358426702242, 9502.904970950201, 9648.276379271723, 9777.21782257432, 10005.149562287286, 10228.386296822215], "unit": "score", "name": "yui.html", "value": 6278.038838656178}], "name": "dromaeo_css", "value": 6860.2955063668}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 108.0, 111.0, 111.0, 113.0, 103.0, 112.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [156.0, 125.0, 155.0, 165.0, 127.0, 152.0, 151.0, 136.0, 176.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [172.0, 161.0, 163.0, 162.0, 160.0, 162.0, 162.0, 164.0, 163.0, 166.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 106.0, 97.0, 72.0, 74.0, 73.0, 102.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 149.0, 96.0, 96.0, 95.0, 137.0, 95.0, 97.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 66.0, 54.0, 55.0, 56.0, 55.0, 64.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 82.0, 82.0, 82.0, 83.0, 82.0, 86.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [125.0, 122.0, 122.0, 116.0, 114.0, 120.0, 129.0, 121.0, 126.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.2}, {"lowerIsBetter": true, "replicates": [161.0, 145.0, 155.0, 168.0, 161.0, 146.0, 156.0, 154.0, 152.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.3}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 70.0, 73.0, 69.0, 69.0, 69.0, 71.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1524.1999999999998}]} 06:05:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1524.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6860.30"}}} 06:05:56 INFO - Return code: 0 06:05:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:05:56 INFO - # TBPL SUCCESS # 06:05:56 INFO - Running post-action listener: _resource_record_post_action 06:05:56 INFO - Running post-run listener: _resource_record_post_run 06:05:57 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538972160; Read time: 36; Write time: 425304 06:05:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 239558656; Read time: 0; Write time: 231556 06:05:57 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298684416; Read time: 36; Write time: 193740 06:05:57 INFO - Running post-run listener: _upload_blobber_files 06:05:57 INFO - Blob upload gear active. 06:05:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:05:57 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 06:05:57 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'] 06:05:57 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 06:05:57 INFO - (blobuploader) - INFO - Open directory for files ... 06:05:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:05:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:05:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:58 INFO - (blobuploader) - INFO - Done attempting. 06:05:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:05:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:05:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:59 INFO - (blobuploader) - INFO - Done attempting. 06:05:59 INFO - (blobuploader) - INFO - Iteration through files over. 06:05:59 INFO - Return code: 0 06:05:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:05:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:05:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd883d6db439b59fa60a4c5c6951a6c4ba64755fdc3fd2d3601010ea57402293c17c428882b0858a7a262d107efc607a4689897a4e6713824beda625c06b9323", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cf58269f342f14809ae22230df0dac6fe99a530aa2fe98bf8e18f4b85ab3c341f22acb7887b1e35d1ef948cbc1a752449a529e4a0eeef81b7d7aea587c4fc71"} 06:05:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:05:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:05:59 INFO - Contents: 06:05:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd883d6db439b59fa60a4c5c6951a6c4ba64755fdc3fd2d3601010ea57402293c17c428882b0858a7a262d107efc607a4689897a4e6713824beda625c06b9323", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cf58269f342f14809ae22230df0dac6fe99a530aa2fe98bf8e18f4b85ab3c341f22acb7887b1e35d1ef948cbc1a752449a529e4a0eeef81b7d7aea587c4fc71"} 06:05:59 INFO - Running post-run listener: copy_logs_to_upload_dir 06:05:59 INFO - Copying logs to upload dir... 06:05:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:05:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.886312 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-02-13 06:05:58.695525) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-13 06:05:58.701633) ========= 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=32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202 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/fd883d6db439b59fa60a4c5c6951a6c4ba64755fdc3fd2d3601010ea57402293c17c428882b0858a7a262d107efc607a4689897a4e6713824beda625c06b9323", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cf58269f342f14809ae22230df0dac6fe99a530aa2fe98bf8e18f4b85ab3c341f22acb7887b1e35d1ef948cbc1a752449a529e4a0eeef81b7d7aea587c4fc71"} build_url:https://queue.taskcluster.net/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/PUoUHI9YRH6h0aBGCJhaVQ/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/fd883d6db439b59fa60a4c5c6951a6c4ba64755fdc3fd2d3601010ea57402293c17c428882b0858a7a262d107efc607a4689897a4e6713824beda625c06b9323", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4cf58269f342f14809ae22230df0dac6fe99a530aa2fe98bf8e18f4b85ab3c341f22acb7887b1e35d1ef948cbc1a752449a529e4a0eeef81b7d7aea587c4fc71"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-13 06:05:58.725895) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 06:05:58.726199) ========= 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=32c5991c409366f7fec8a718000001d2-1455368343.402438-90353202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-13 06:05:58.811978) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-13 06:05:58.812308) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-13 06:05:58.812598) ========= ========= Total master_lag: 0.30 =========